builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1461971372.82 results: success (0) buildid: 20160429133634 builduid: 978fae549a734e23b520b62985c9b2c1 revision: 259d41769207bbf0a55afe7475fc3a71f8a5d724 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.824517) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.824913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.825215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.852255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.852565) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 16:09:33-- 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% 113M=0s 2016-04-29 16:09:33 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111526 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.978550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:32.978939) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019631 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.061043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.061407) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 259d41769207bbf0a55afe7475fc3a71f8a5d724 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 259d41769207bbf0a55afe7475fc3a71f8a5d724 --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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 16:09:33,568 truncating revision to first 12 chars 2016-04-29 16:09:33,569 Setting DEBUG logging. 2016-04-29 16:09:33,569 attempt 1/10 2016-04-29 16:09:33,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/259d41769207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 16:09:34,004 unpacking tar archive at: mozilla-beta-259d41769207/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.781352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.781672) ========= script_repo_revision: 259d41769207bbf0a55afe7475fc3a71f8a5d724 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.782056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.782368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 16:09:33.791021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-04-29 16:09:33.791286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:34 INFO - MultiFileLogger online at 20160429 16:09:34 in /builds/slave/test 16:09:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:34 INFO - {'append_to_log': False, 16:09:34 INFO - 'base_work_dir': '/builds/slave/test', 16:09:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:34 INFO - 'branch': 'Mozilla-Beta', 16:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:34 INFO - 'config_files': ('talos/linux_config.py',), 16:09:34 INFO - 'default_actions': ('clobber', 16:09:34 INFO - 'read-buildbot-config', 16:09:34 INFO - 'download-and-extract', 16:09:34 INFO - 'populate-webroot', 16:09:34 INFO - 'create-virtualenv', 16:09:34 INFO - 'install', 16:09:34 INFO - 'run-tests'), 16:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:34 INFO - 'download_minidump_stackwalk': True, 16:09:34 INFO - 'download_symbols': 'ondemand', 16:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:34 INFO - 'installer_path': 'installer.exe', 16:09:34 INFO - 'log_level': 'info', 16:09:34 INFO - 'log_name': 'talos', 16:09:34 INFO - 'log_to_console': True, 16:09:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:34 INFO - 'opt_config_files': (), 16:09:34 INFO - 'pip_index': False, 16:09:34 INFO - 'sps_profile': False, 16:09:34 INFO - 'sps_profile_interval': 0, 16:09:34 INFO - 'suite': 'dromaeojs', 16:09:34 INFO - 'system_bits': '32', 16:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:34 INFO - 'title': 'talos-linux64-ix-037', 16:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:34 INFO - 'use_talos_json': True, 16:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:34 INFO - 'work_dir': 'build'} 16:09:34 INFO - ##### 16:09:34 INFO - ##### Running clobber step. 16:09:34 INFO - ##### 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: clobber 16:09:34 INFO - rmtree: /builds/slave/test/build 16:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:34 INFO - Running post-action listener: _resource_record_post_action 16:09:34 INFO - ##### 16:09:34 INFO - ##### Running read-buildbot-config step. 16:09:34 INFO - ##### 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: read_buildbot_config 16:09:34 INFO - Using buildbot properties: 16:09:34 INFO - { 16:09:34 INFO - "project": "", 16:09:34 INFO - "product": "firefox", 16:09:34 INFO - "script_repo_revision": "production", 16:09:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:09:34 INFO - "repository": "", 16:09:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:09:34 INFO - "buildid": "20160429133634", 16:09:34 INFO - "pgo_build": "True", 16:09:34 INFO - "basedir": "/builds/slave/test", 16:09:34 INFO - "buildnumber": 55, 16:09:34 INFO - "slavename": "talos-linux64-ix-037", 16:09:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:09:34 INFO - "platform": "ubuntu64_hw", 16:09:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:09:34 INFO - "branch": "mozilla-beta", 16:09:34 INFO - "repo_path": "releases/mozilla-beta", 16:09:34 INFO - "revision": "259d41769207bbf0a55afe7475fc3a71f8a5d724", 16:09:34 INFO - "stage_platform": "linux64-pgo", 16:09:34 INFO - "builduid": "978fae549a734e23b520b62985c9b2c1", 16:09:34 INFO - "slavebuilddir": "test" 16:09:34 INFO - } 16:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 16:09:34 INFO - Running post-action listener: _resource_record_post_action 16:09:34 INFO - ##### 16:09:34 INFO - ##### Running download-and-extract step. 16:09:34 INFO - ##### 16:09:34 INFO - Running pre-action listener: _resource_record_pre_action 16:09:34 INFO - Running main action method: download_and_extract 16:09:34 INFO - mkdir: /builds/slave/test/build/tests 16:09:34 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')]} 16:09:34 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:09:37 INFO - Downloaded 1412 bytes. 16:09:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 16:09:37 INFO - Using the following test package requirements: 16:09:37 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:37 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:37 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 16:09:37 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'jsshell-linux-x86_64.zip'], 16:09:37 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:37 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:37 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 16:09:37 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 16:09:37 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:37 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 16:09:37 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 16:09:37 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:37 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:37 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')]} 16:09:37 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:09:46 INFO - Downloaded 23363475 bytes. 16:09:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:09:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:09:47 INFO - Return code: 0 16:09:47 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:09: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')]} 16:09:47 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 16:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:09:53 INFO - Downloaded 23363475 bytes. 16:09:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:09:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:09:54 INFO - Return code: 0 16:09: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')]} 16:09:54 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 16:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:11:16 INFO - Downloaded 10845194 bytes. 16:11:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:11:16 INFO - Return code: 0 16:11:16 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')]} 16:11:16 INFO - https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:11:22 INFO - Downloaded 53781846 bytes. 16:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:11:22 INFO - mkdir: /builds/slave/test/properties 16:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:22 INFO - Contents: 16:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 16:11:23 INFO - Running post-action listener: _resource_record_post_action 16:11:23 INFO - Running post-action listener: set_extra_try_arguments 16:11:23 INFO - ##### 16:11:23 INFO - ##### Running populate-webroot step. 16:11:23 INFO - ##### 16:11:23 INFO - Running pre-action listener: _resource_record_pre_action 16:11:23 INFO - Running main action method: populate_webroot 16:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:23 INFO - '--tppagecycles', 16:11:23 INFO - '7'], 16:11:23 INFO - 'tests': ['tsvgm']}}, 16:11:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:11:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:11:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['damp', 'tps']}, 16:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['damp', 'tps']}, 16:11:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:23 INFO - 'other': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other_l64': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other_nol64': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'svgr': {'tests': ['tsvgx', 16:11:23 INFO - 'tsvgr_opacity', 16:11:23 INFO - 'tart', 16:11:23 INFO - 'tscrollx', 16:11:23 INFO - 'cart']}, 16:11:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tsvgx', 16:11:23 INFO - 'tsvgr_opacity', 16:11:23 INFO - 'tart', 16:11:23 INFO - 'tscrollx', 16:11:23 INFO - 'cart']}, 16:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['tp5o']}, 16:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tp5o']}, 16:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--xperf_path', 16:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:23 INFO - 'tests': ['tp5n']}, 16:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s', 16:11:23 INFO - '--xperf_path', 16:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:23 INFO - 'tests': ['tp5n']}}, 16:11:23 INFO - 'talos.zip': {'path': '', 16:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:23 INFO - Running post-action listener: _resource_record_post_action 16:11:23 INFO - ##### 16:11:23 INFO - ##### Running create-virtualenv step. 16:11:23 INFO - ##### 16:11:23 INFO - Running pre-action listener: _resource_record_pre_action 16:11:23 INFO - Running main action method: create_virtualenv 16:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:23 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 16:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:23 INFO - Using real prefix '/usr' 16:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:26 INFO - Installing pip.................done. 16:11:26 INFO - Return code: 0 16:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:11:26 INFO - Using env: {'DISPLAY': ':0', 16:11:26 INFO - 'HOME': '/home/cltbld', 16:11:26 INFO - 'LANG': 'en_US.UTF-8', 16:11:26 INFO - 'LANGUAGE': 'en_US:en', 16:11:26 INFO - 'LOGNAME': 'cltbld', 16:11:26 INFO - 'MAIL': '/var/mail/cltbld', 16:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:26 INFO - 'MOZ_NO_REMOTE': '1', 16:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:26 INFO - 'NO_EM_RESTART': '1', 16:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:26 INFO - 'PWD': '/builds/slave/test', 16:11:26 INFO - 'SHELL': '/bin/bash', 16:11:26 INFO - 'SHLVL': '1', 16:11:26 INFO - 'TERM': 'linux', 16:11:26 INFO - 'TMOUT': '86400', 16:11:26 INFO - 'USER': 'cltbld', 16:11:26 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:26 INFO - '_': '/tools/buildbot/bin/python'} 16:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:26 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 16:11:26 INFO - Cleaning up... 16:11:26 INFO - Return code: 0 16:11:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:11:26 INFO - Using env: {'DISPLAY': ':0', 16:11:26 INFO - 'HOME': '/home/cltbld', 16:11:26 INFO - 'LANG': 'en_US.UTF-8', 16:11:26 INFO - 'LANGUAGE': 'en_US:en', 16:11:26 INFO - 'LOGNAME': 'cltbld', 16:11:26 INFO - 'MAIL': '/var/mail/cltbld', 16:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:26 INFO - 'MOZ_NO_REMOTE': '1', 16:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:26 INFO - 'NO_EM_RESTART': '1', 16:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:26 INFO - 'PWD': '/builds/slave/test', 16:11:26 INFO - 'SHELL': '/bin/bash', 16:11:26 INFO - 'SHLVL': '1', 16:11:26 INFO - 'TERM': 'linux', 16:11:26 INFO - 'TMOUT': '86400', 16:11:26 INFO - 'USER': 'cltbld', 16:11:26 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:26 INFO - '_': '/tools/buildbot/bin/python'} 16:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:26 INFO - Downloading/unpacking psutil>=0.7.1 16:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:28 INFO - Installing collected packages: psutil 16:11:28 INFO - Running setup.py install for psutil 16:11:28 INFO - building 'psutil._psutil_linux' extension 16:11:28 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 16:11:28 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 16:11:28 INFO - building 'psutil._psutil_posix' extension 16:11:28 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 16:11:28 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 16:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:29 INFO - Successfully installed psutil 16:11:29 INFO - Cleaning up... 16:11:29 INFO - Return code: 0 16:11:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:29 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 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:29 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 16:11:29 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 16:11:29 INFO - Using env: {'DISPLAY': ':0', 16:11:29 INFO - 'HOME': '/home/cltbld', 16:11:29 INFO - 'LANG': 'en_US.UTF-8', 16:11:29 INFO - 'LANGUAGE': 'en_US:en', 16:11:29 INFO - 'LOGNAME': 'cltbld', 16:11:29 INFO - 'MAIL': '/var/mail/cltbld', 16:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:29 INFO - 'MOZ_NO_REMOTE': '1', 16:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:29 INFO - 'NO_EM_RESTART': '1', 16:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:29 INFO - 'PWD': '/builds/slave/test', 16:11:29 INFO - 'SHELL': '/bin/bash', 16:11:29 INFO - 'SHLVL': '1', 16:11:29 INFO - 'TERM': 'linux', 16:11:29 INFO - 'TMOUT': '86400', 16:11:29 INFO - 'USER': 'cltbld', 16:11:29 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:29 INFO - '_': '/tools/buildbot/bin/python'} 16:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:11:31 INFO - Installing collected packages: mozsystemmonitor 16:11:31 INFO - Running setup.py install for mozsystemmonitor 16:11:31 INFO - Successfully installed mozsystemmonitor 16:11:31 INFO - Cleaning up... 16:11:31 INFO - Return code: 0 16:11:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:11:31 INFO - Using env: {'DISPLAY': ':0', 16:11:31 INFO - 'HOME': '/home/cltbld', 16:11:31 INFO - 'LANG': 'en_US.UTF-8', 16:11:31 INFO - 'LANGUAGE': 'en_US:en', 16:11:31 INFO - 'LOGNAME': 'cltbld', 16:11:31 INFO - 'MAIL': '/var/mail/cltbld', 16:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:31 INFO - 'MOZ_NO_REMOTE': '1', 16:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:31 INFO - 'NO_EM_RESTART': '1', 16:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:31 INFO - 'PWD': '/builds/slave/test', 16:11:31 INFO - 'SHELL': '/bin/bash', 16:11:31 INFO - 'SHLVL': '1', 16:11:31 INFO - 'TERM': 'linux', 16:11:31 INFO - 'TMOUT': '86400', 16:11:31 INFO - 'USER': 'cltbld', 16:11:31 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:31 INFO - '_': '/tools/buildbot/bin/python'} 16:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:31 INFO - Downloading/unpacking blobuploader==1.2.4 16:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:33 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:33 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 16:11:34 INFO - Downloading docopt-0.6.1.tar.gz 16:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:34 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:34 INFO - Running setup.py install for blobuploader 16:11:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:34 INFO - Running setup.py install for requests 16:11:34 INFO - Running setup.py install for docopt 16:11:34 INFO - Successfully installed blobuploader requests docopt 16:11:34 INFO - Cleaning up... 16:11:34 INFO - Return code: 0 16:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:34 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')]} 16:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:34 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')]} 16:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:34 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 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:34 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 16:11:34 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 16:11:34 INFO - Using env: {'DISPLAY': ':0', 16:11:34 INFO - 'HOME': '/home/cltbld', 16:11:34 INFO - 'LANG': 'en_US.UTF-8', 16:11:34 INFO - 'LANGUAGE': 'en_US:en', 16:11:34 INFO - 'LOGNAME': 'cltbld', 16:11:34 INFO - 'MAIL': '/var/mail/cltbld', 16:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:34 INFO - 'MOZ_NO_REMOTE': '1', 16:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:34 INFO - 'NO_EM_RESTART': '1', 16:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:34 INFO - 'PWD': '/builds/slave/test', 16:11:34 INFO - 'SHELL': '/bin/bash', 16:11:34 INFO - 'SHLVL': '1', 16:11:34 INFO - 'TERM': 'linux', 16:11:34 INFO - 'TMOUT': '86400', 16:11:34 INFO - 'USER': 'cltbld', 16:11:34 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:34 INFO - '_': '/tools/buildbot/bin/python'} 16:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:35 INFO - Running setup.py (path:/tmp/pip-ebJ8on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:35 INFO - Running setup.py (path:/tmp/pip-pCnKJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:35 INFO - Running setup.py (path:/tmp/pip-jLIqQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:35 INFO - Running setup.py (path:/tmp/pip-5gb_3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:35 INFO - Running setup.py (path:/tmp/pip-4bYAMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:35 INFO - Running setup.py (path:/tmp/pip-7eiR9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:35 INFO - Running setup.py (path:/tmp/pip-HEj4jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:35 INFO - Running setup.py (path:/tmp/pip-ETGHf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:35 INFO - Running setup.py (path:/tmp/pip-VR2t27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:35 INFO - Running setup.py (path:/tmp/pip-8Y7A4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:35 INFO - Running setup.py (path:/tmp/pip-FWU2dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:35 INFO - Running setup.py (path:/tmp/pip-6S8sbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:35 INFO - Running setup.py (path:/tmp/pip-UMMlk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:35 INFO - Running setup.py (path:/tmp/pip-8n0pCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:36 INFO - Running setup.py (path:/tmp/pip-viBOyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:36 INFO - Running setup.py (path:/tmp/pip-WtYNdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:36 INFO - Running setup.py (path:/tmp/pip-U6XRH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:36 INFO - Running setup.py install for manifestparser 16:11:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:36 INFO - Running setup.py install for mozcrash 16:11:36 INFO - Running setup.py install for mozdebug 16:11:36 INFO - Running setup.py install for mozdevice 16:11:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:36 INFO - Running setup.py install for mozfile 16:11:36 INFO - Running setup.py install for mozhttpd 16:11:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:36 INFO - Running setup.py install for mozinfo 16:11:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:36 INFO - Running setup.py install for mozInstall 16:11:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Running setup.py install for mozleak 16:11:37 INFO - Running setup.py install for mozlog 16:11:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Running setup.py install for moznetwork 16:11:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Running setup.py install for mozprocess 16:11:37 INFO - Running setup.py install for mozprofile 16:11:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Running setup.py install for mozrunner 16:11:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:37 INFO - Running setup.py install for mozscreenshot 16:11:37 INFO - Running setup.py install for moztest 16:11:37 INFO - Running setup.py install for mozversion 16:11:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:38 INFO - Cleaning up... 16:11:38 INFO - Return code: 0 16:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:11:38 INFO - Using env: {'DISPLAY': ':0', 16:11:38 INFO - 'HOME': '/home/cltbld', 16:11:38 INFO - 'LANG': 'en_US.UTF-8', 16:11:38 INFO - 'LANGUAGE': 'en_US:en', 16:11:38 INFO - 'LOGNAME': 'cltbld', 16:11:38 INFO - 'MAIL': '/var/mail/cltbld', 16:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:38 INFO - 'MOZ_NO_REMOTE': '1', 16:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:38 INFO - 'NO_EM_RESTART': '1', 16:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:38 INFO - 'PWD': '/builds/slave/test', 16:11:38 INFO - 'SHELL': '/bin/bash', 16:11:38 INFO - 'SHLVL': '1', 16:11:38 INFO - 'TERM': 'linux', 16:11:38 INFO - 'TMOUT': '86400', 16:11:38 INFO - 'USER': 'cltbld', 16:11:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:38 INFO - '_': '/tools/buildbot/bin/python'} 16:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:38 INFO - Running setup.py (path:/tmp/pip-3flge5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:38 INFO - Running setup.py (path:/tmp/pip-odJNKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:38 INFO - Running setup.py (path:/tmp/pip-Y6h_9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:38 INFO - Running setup.py (path:/tmp/pip-hsvqLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:38 INFO - Running setup.py (path:/tmp/pip-Rr4TNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:38 INFO - Running setup.py (path:/tmp/pip-k1mdiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:38 INFO - Running setup.py (path:/tmp/pip-B8zM5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:38 INFO - Running setup.py (path:/tmp/pip-6V3YJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:38 INFO - Running setup.py (path:/tmp/pip-BWBmzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:38 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)) 16:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:38 INFO - Running setup.py (path:/tmp/pip-dJxfSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:39 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)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:39 INFO - Running setup.py (path:/tmp/pip-DUHuie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:39 INFO - Running setup.py (path:/tmp/pip-n4qnUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:39 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)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:39 INFO - Running setup.py (path:/tmp/pip-eUNB4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:39 INFO - Running setup.py (path:/tmp/pip-cczS22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:39 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)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:39 INFO - Running setup.py (path:/tmp/pip-9jGaPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:39 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)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:39 INFO - Running setup.py (path:/tmp/pip-nUH2vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:39 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)) 16:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:39 INFO - Running setup.py (path:/tmp/pip-oM4JMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:39 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)) 16:11:39 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)) 16:11:39 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)) 16:11:39 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)) 16:11:39 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)) 16:11:39 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)) 16:11:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:41 INFO - Downloading blessings-1.6.tar.gz 16:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:41 INFO - Installing collected packages: blessings 16:11:41 INFO - Running setup.py install for blessings 16:11:41 INFO - Successfully installed blessings 16:11:41 INFO - Cleaning up... 16:11:41 INFO - Return code: 0 16:11:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:41 INFO - Reading from file tmpfile_stdout 16:11:41 INFO - Current package versions: 16:11:41 INFO - argparse == 1.2.1 16:11:41 INFO - blessings == 1.6 16:11:41 INFO - blobuploader == 1.2.4 16:11:41 INFO - docopt == 0.6.1 16:11:41 INFO - manifestparser == 1.1 16:11:41 INFO - mozInstall == 1.12 16:11:41 INFO - mozcrash == 0.17 16:11:41 INFO - mozdebug == 0.1 16:11:41 INFO - mozdevice == 0.48 16:11:41 INFO - mozfile == 1.2 16:11:41 INFO - mozhttpd == 0.7 16:11:41 INFO - mozinfo == 0.9 16:11:41 INFO - mozleak == 0.1 16:11:41 INFO - mozlog == 3.1 16:11:41 INFO - moznetwork == 0.27 16:11:41 INFO - mozprocess == 0.22 16:11:41 INFO - mozprofile == 0.28 16:11:41 INFO - mozrunner == 6.11 16:11:41 INFO - mozscreenshot == 0.1 16:11:41 INFO - mozsystemmonitor == 0.0 16:11:41 INFO - moztest == 0.7 16:11:41 INFO - mozversion == 1.4 16:11:41 INFO - psutil == 3.1.1 16:11:41 INFO - requests == 1.2.3 16:11:41 INFO - wsgiref == 0.1.2 16:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:41 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 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:41 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 16:11:41 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 16:11:41 INFO - Using env: {'DISPLAY': ':0', 16:11:41 INFO - 'HOME': '/home/cltbld', 16:11:41 INFO - 'LANG': 'en_US.UTF-8', 16:11:41 INFO - 'LANGUAGE': 'en_US:en', 16:11:41 INFO - 'LOGNAME': 'cltbld', 16:11:41 INFO - 'MAIL': '/var/mail/cltbld', 16:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:41 INFO - 'MOZ_NO_REMOTE': '1', 16:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:41 INFO - 'NO_EM_RESTART': '1', 16:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:41 INFO - 'PWD': '/builds/slave/test', 16:11:41 INFO - 'SHELL': '/bin/bash', 16:11:41 INFO - 'SHLVL': '1', 16:11:41 INFO - 'TERM': 'linux', 16:11:41 INFO - 'TMOUT': '86400', 16:11:41 INFO - 'USER': 'cltbld', 16:11:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:41 INFO - '_': '/tools/buildbot/bin/python'} 16:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:11:42 INFO - Cleaning up... 16:11:42 INFO - Return code: 0 16:11:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:11:42 INFO - Using env: {'DISPLAY': ':0', 16:11:42 INFO - 'HOME': '/home/cltbld', 16:11:42 INFO - 'LANG': 'en_US.UTF-8', 16:11:42 INFO - 'LANGUAGE': 'en_US:en', 16:11:42 INFO - 'LOGNAME': 'cltbld', 16:11:42 INFO - 'MAIL': '/var/mail/cltbld', 16:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:42 INFO - 'MOZ_NO_REMOTE': '1', 16:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:42 INFO - 'NO_EM_RESTART': '1', 16:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:42 INFO - 'PWD': '/builds/slave/test', 16:11:42 INFO - 'SHELL': '/bin/bash', 16:11:42 INFO - 'SHLVL': '1', 16:11:42 INFO - 'TERM': 'linux', 16:11:42 INFO - 'TMOUT': '86400', 16:11:42 INFO - 'USER': 'cltbld', 16:11:42 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:42 INFO - '_': '/tools/buildbot/bin/python'} 16:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:42 INFO - Downloading/unpacking jsonschema 16:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:44 INFO - Downloading/unpacking functools32 (from jsonschema) 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:44 INFO - warning: no files found matching '*.txt' 16:11:44 INFO - no previously-included directories found matching 'build' 16:11:44 INFO - no previously-included directories found matching 'dist' 16:11:44 INFO - no previously-included directories found matching '.git*' 16:11:44 INFO - Installing collected packages: jsonschema, functools32 16:11:44 INFO - Running setup.py install for functools32 16:11:44 INFO - warning: no files found matching '*.txt' 16:11:44 INFO - no previously-included directories found matching 'build' 16:11:44 INFO - no previously-included directories found matching 'dist' 16:11:44 INFO - no previously-included directories found matching '.git*' 16:11:44 INFO - Successfully installed jsonschema functools32 16:11:44 INFO - Cleaning up... 16:11:44 INFO - Return code: 0 16:11:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ae507f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', '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 16:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:11:44 INFO - Using env: {'DISPLAY': ':0', 16:11:44 INFO - 'HOME': '/home/cltbld', 16:11:44 INFO - 'LANG': 'en_US.UTF-8', 16:11:44 INFO - 'LANGUAGE': 'en_US:en', 16:11:44 INFO - 'LOGNAME': 'cltbld', 16:11:44 INFO - 'MAIL': '/var/mail/cltbld', 16:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:44 INFO - 'MOZ_NO_REMOTE': '1', 16:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:44 INFO - 'NO_EM_RESTART': '1', 16:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:44 INFO - 'PWD': '/builds/slave/test', 16:11:44 INFO - 'SHELL': '/bin/bash', 16:11:44 INFO - 'SHLVL': '1', 16:11:44 INFO - 'TERM': 'linux', 16:11:44 INFO - 'TMOUT': '86400', 16:11:44 INFO - 'USER': 'cltbld', 16:11:44 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:44 INFO - '_': '/tools/buildbot/bin/python'} 16:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:44 INFO - Downloading/unpacking flake8 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:11:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16: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 16: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 16: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 16: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 16: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 16: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 16:11:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:11:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16: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 16: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 16: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 16: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 16: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 16: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 16:11:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:47 INFO - no previously-included directories found matching 'docs/_build' 16:11:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:11:47 INFO - Running setup.py install for pep8 16:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:11:47 INFO - no previously-included directories found matching 'docs/_build' 16:11:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:11:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:11:47 INFO - Cleaning up... 16:11:47 INFO - Return code: 0 16:11:47 INFO - Running post-action listener: _resource_record_post_action 16:11:47 INFO - Running post-action listener: _start_resource_monitoring 16:11:47 INFO - Starting resource monitoring. 16:11:47 INFO - ##### 16:11:47 INFO - ##### Running install step. 16:11:47 INFO - ##### 16:11:47 INFO - Running pre-action listener: _resource_record_pre_action 16:11:47 INFO - Running main action method: install 16:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:47 INFO - Reading from file tmpfile_stdout 16:11:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:11:48 INFO - Reading from file tmpfile_stdout 16:11:48 INFO - Output received: 16:11:48 INFO - Usage: mozinstall [options] installer 16:11:48 INFO - Options: 16:11:48 INFO - -h, --help show this help message and exit 16:11:48 INFO - -d DEST, --destination=DEST 16:11:48 INFO - Directory to install application into. [default: 16:11:48 INFO - "/builds/slave/test"] 16:11:48 INFO - --app=APP Application being installed. [default: firefox] 16:11:48 INFO - mkdir: /builds/slave/test/build/application 16:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:12:00 INFO - Reading from file tmpfile_stdout 16:12:00 INFO - Output received: 16:12:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:00 INFO - Running post-action listener: _resource_record_post_action 16:12:00 INFO - ##### 16:12:00 INFO - ##### Running run-tests step. 16:12:00 INFO - ##### 16:12:00 INFO - Running pre-action listener: _resource_record_pre_action 16:12:00 INFO - Running main action method: run_tests 16:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:00 INFO - Python 2.7.3 16:12:00 INFO - Return code: 0 16:12:00 INFO - grabbing minidump binary from tooltool 16:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:12:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e160>, '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 0x295f060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:12:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:12:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:00 INFO - Return code: 0 16:12:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:01 INFO - Return code: 0 16:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 16:12:01 INFO - Using env: {'DISPLAY': ':0', 16:12:01 INFO - 'HOME': '/home/cltbld', 16:12:01 INFO - 'LANG': 'en_US.UTF-8', 16:12:01 INFO - 'LANGUAGE': 'en_US:en', 16:12:01 INFO - 'LOGNAME': 'cltbld', 16:12:01 INFO - 'MAIL': '/var/mail/cltbld', 16:12:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:01 INFO - 'MOZ_NO_REMOTE': '1', 16:12:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:01 INFO - 'NO_EM_RESTART': '1', 16:12:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:01 INFO - 'PWD': '/builds/slave/test', 16:12:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:01 INFO - 'SHELL': '/bin/bash', 16:12:01 INFO - 'SHLVL': '1', 16:12:01 INFO - 'TERM': 'linux', 16:12:01 INFO - 'TMOUT': '86400', 16:12:01 INFO - 'USER': 'cltbld', 16:12:01 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236', 16:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:01 INFO - '_': '/tools/buildbot/bin/python'} 16:12:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 16:12:02 INFO - mozversion application_buildid: 20160429133634 16:12:02 INFO - mozversion application_changeset: 259d41769207bbf0a55afe7475fc3a71f8a5d724 16:12:02 INFO - mozversion application_display_name: Firefox 16:12:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:02 INFO - mozversion application_name: Firefox 16:12:02 INFO - mozversion application_remotingname: firefox 16:12:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:12:02 INFO - mozversion application_vendor: Mozilla 16:12:02 INFO - mozversion application_version: 47.0 16:12:02 INFO - mozversion platform_buildid: 20160429133634 16:12:02 INFO - mozversion platform_changeset: 259d41769207bbf0a55afe7475fc3a71f8a5d724 16:12:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:12:02 INFO - mozversion platform_version: 47.0 16:12:02 INFO - using testdate: 1461971522 16:12:02 INFO - actual date: 1461971522 16:12:02 INFO - starting webserver on 'localhost:36676' 16:12:02 INFO - SUITE-START | Running 2 tests 16:12:02 INFO - TEST-START | dromaeo_css 16:12:02 INFO - operating with platform_type : linux_ 16:12:02 INFO - Initialising browser for dromaeo_css test... 16:12:02 INFO - TEST-INFO | started process 10254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiyZPx/profile http://localhost:36676/getInfo.html) 16:12:06 INFO - PROCESS | 10254 | __metrics Screen width/height:1600/1200 16:12:06 INFO - PROCESS | 10254 | colorDepth:24 16:12:06 INFO - PROCESS | 10254 | Browser inner width/height: 1024/697 16:12:06 INFO - PROCESS | 10254 | __metrics 16:12:07 INFO - PROCESS | 10254 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:08 INFO - TEST-INFO | 10254: exit 0 16:12:08 INFO - Browser initialized. 16:12:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:08 INFO - TEST-INFO | started process 10343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiyZPx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:19 INFO - PROCESS | 10343 | RSS: Main: 139661312 16:12:19 INFO - PROCESS | 10343 | 16:13:11 INFO - PROCESS | 10343 | 1461971591068 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] 16:15:18 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36676/tests/dromaeo/cssquery-ext.html) 16:15:19 INFO - PROCESS | 10343 | RSS: Main: 253255680 16:15:19 INFO - PROCESS | 10343 | 16:18:21 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-ext.html (next: http://localhost:36676/tests/dromaeo/cssquery-jquery.html) 16:18:22 INFO - PROCESS | 10343 | RSS: Main: 222605312 16:18:22 INFO - PROCESS | 10343 | 16:21:23 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36676/tests/dromaeo/cssquery-mootools.html) 16:21:24 INFO - PROCESS | 10343 | RSS: Main: 223272960 16:21:24 INFO - PROCESS | 10343 | 16:24:26 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36676/tests/dromaeo/cssquery-prototype.html) 16:24:26 INFO - PROCESS | 10343 | RSS: Main: 192618496 16:24:26 INFO - PROCESS | 10343 | 16:27:29 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36676/tests/dromaeo/cssquery-yui.html) 16:27:29 INFO - PROCESS | 10343 | RSS: Main: 213020672 16:27:29 INFO - PROCESS | 10343 | 16:30:31 INFO - PROCESS | 10343 | Cycle 1(1): loaded http://localhost:36676/tests/dromaeo/cssquery-yui.html (next: http://localhost:36676/tests/dromaeo/cssquery-dojo.html) 16:30:32 INFO - PROCESS | 10343 | RSS: Main: 258207744 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | __start_tp_report 16:30:32 INFO - PROCESS | 10343 | _x_x_mozilla_page_load 16:30:32 INFO - PROCESS | 10343 | _x_x_mozilla_page_load_details 16:30:32 INFO - PROCESS | 10343 | |i|pagename|runs| 16:30:32 INFO - PROCESS | 10343 | |0;dojo.html;3270.9018729438117;3320.5351250824906;3336.3660904428157;3337.966620333796;3365.242820365418;5293.6294459387855;5305.681659100447;5310.6813591184555;5315.707636080014;5329.200619907016;5324.227986941891;5330.200469929512;5335.439778823226;5346.625736198458;5347.438518955512;4775.3075804008395;4863.902721945559;4878.268259761029;4906.656534042619;4951.306817045616;4803.039392121572;4833.9516604834025;4878.560929516343;4882.682625629341;4884.462709102014;4826.638002149835;4888.560029597335;4963.25551167326;4988.950110498885;4996.625253106014;4977.3529441172595;4983.476734942815;5010.874728131789;5012.273220383024;5030.773615187307;4778.116048531033;4807.30294107356;4871.780769865364;4876.219804831246;4900;5161.4322424533275;5174.637775355726;5178.482151784829;5186.974065129688;5211.062008838408;5668.631538949996;5681.744321505501;5684.744186511575;5738;5739.167820666022;5761.683107429089;5764;5780;5804.535637149018;5812.825615231508;5406.378266499324;5408.107662235727;5411.512963833274;5414.458554144593;5443.945560544423;5764.942350576524;5799.043157878903;5876.412358764175;5878;5897.380775018647;5728.312602487728;5743.282089738783;5748.770049198069;5748.913766293509;5750.568707346965;5789.507891829157;5801.622894511843;5802.709864506758;5803.506701930299;5808.796692115756;5605.859853503695;5673.914891276634;5745.224394706661;5761.798337058183;5769.538436925036;5668.886622267614;5695.572832037614;5697.686627235459;5697.772089116389;5700.4299570043495;4310.331898555729;4361.738295702268;4361.738295702268;4363.585459381354;4386.780660966939;3912.8434862605745;3913.9217215655526;3976.383660532622;3977.5028121484816;3997.360422332413;5440.891182176334;5448.427915068861;5451.700156491431;5453.618246722771;5484.067708489566;5571.860703482445;5700.458456446631;5740.225069615549;5747.971260143672;5748.798792042258;5231.895362092737;5418.539424148913;5421.2681288025615;5497.8075767347955;5538.723063846792;4924.482929292372;4934.235193544934;4936.802527898843;4940.407151141886;4967.254911763264;5780.682062486603;5896.852578685567;5898.026825573732;5899.793507227227;5906.822795316061;5678.176664383724;5713.628614140068;5728.770849166153;5732.025555655632;5769.68266745333;5835.183074369676;5867.090600956859;5878.588498805214;5883.441073098049;5884.0585506318785;5583.553315734813;5644.85887852807;5647.435256474319;5707.857303567444;5776.018076926848;5853.707314634166;5853.736581853912;5854.648721076749;5855.38518455556;5856.033754430641;5666.320041595035;5675.57433192504;5677.460641239076;5681.375048744718;5684.573656975661;5450.427705090909;5631.802886898939;5646.265985421869;5672.971635141798;5719.941810765022;5537.058700020925;5549.805756798492;5579.553635709052;5583;5589.049861523469;5650.802221922213;5678.119891416837;5706.914396283976;5713.171590119493;5721.25623668937;5408.486193811582;5445.237666726741;5522.088855338824;5605.5515558756015;5637.746301416528 16:30:32 INFO - PROCESS | 10343 | |1;ext.html;557.0335467963083;561.1918836874901;567.214408044858;575.9654420734759;595.1727099331929;39056.60943390565;39730.006749831235;39811.80094099526;39824.203515929665;39878.401823972665;46367.53632463674;47476.76261618687;47683.284750728766;47800.52199478004;47827.84774685139;8837.911620883806;8995.5052472114;9007.909920900805;9014.053524379944;9014.188723014928;9177.54112294386;9332.673356432526;9343;9353.719388418358;9356.953215233914;9303.62785488583;9381.859272110889;9391.59126131079;9404.153626173644;9408.576614052385;9240.5841737122;9310.115539023782;9318.20795232406;9325.160735533767;9331.90668093324;9054.366194366397;9304.395214311047;9305.022972587849;9307.627694892197;9315.254779617615;43097.78451107756;43367.783161084306;43387.34918976218;43446;43633.12733745339;3808.485854409647;3835.8657446989223;3869.9032524186837;3882.9223415531533;3929.980350098231;32689.34621307584;33065.50401743976;33207.16982075443;33620.663793362;33701.831490842385;4252.510961239435;4264;4265.957340426587;4268;4281.48622165339;210060.9496952521;212141;212820;213224;213918;46398.53601463942;61566.69216653888;61568.384316157164;61635.691821540604;61845.69077154675;42821.78589107034;42829;42892.3566146508;42913.570864291585;42960.92597685083;16324.755128672841;16470.7646926481;16495.752563711554;16496.505104846874;16502.504924852274;13417.262050587116;13503.59489215325;13509.324533773271;13517.391717372742;13518.121322114031;15265.923670381577;15665.843341566666;15845.52463426099;15860.127692976997;15871.920640396724;5821.27234095738;5887.646741195542;5929.584929055011;6014.6391216527145;6130.724117414727;1044.6343779677204;1077.3692655750172;1092.939888306135;1098.961536346224;1243.421808858885;30173.855315240897;30414.69585304163;30660.81479828438;30731.2317192072;30920.536191957137;1125.5160281079052;1136.3011747775224;1147.449224372306;1173.16705139352;1225.4485481533345;15964.68070638604;16079.356825727074;16314.102724350274;16336.428225012067;16347.34610615562;344688;347199;347922;349468;350981;58633.70683146557;59592.10611840826;59625;59660;59723.402765972656;1343.6372179511477;1474.108164560447;1474.4323435477418;1481.5185064853965;1527.5341020988706;28913.7108628911;29779.255518612208;30009.849950750107;30356.24109397283;30594.235144121576;46160.53839461562;46418;46698.76650616725;46755.29867051929;46885;180140;181536;193156;193223;193530;30628.84685576647;35036.824815875756;35281.82359088188;35363.939081827586;35425.645743542234;40733;41285.1742965145;41502.89421506551;41504;41922.79038604909;38235.23529529449;38735.61264387433;38778.61221387863;38840.22319553536;39082;36523.26953460969;37333.253334933695;37812.243755125295;38065;38237;37549.06127346838;37579.624203757616;38211.42682859704;38458.23083538258;38757.6124238754;32854.113126574826;34468.65531344654;35051;35054.824725877224;35250.823745881105;26542.203733888015;26790.866045669645;26834.59748103741;27032.189034329003;28846.56665751408 16:30:32 INFO - PROCESS | 10343 | |2;jquery.html;382.5371300726123;387.96314350136726;390.6718356580472;392.57013570140697;400.1556715330652;15114.848851511482;17580.912095439522;18206.3627773028;19171.712424313628;19605.019749012547;17444.215010324533;17720.291188352483;18053.277868885263;18094.09529523522;18099.819001809978;5542.91685624716;5611.354694210157;5625.240592519998;5667.914981275284;5692.743826527795;5488.231647569343;5629.690367029812;5654.151877218409;5668.319801623811;5670.518005969477;5370.43610420906;5601.271834661508;5601.579881508883;5614.157876318564;5624.15637654351;5387.1111266640955;5417.674939503642;5423.430539793304;5425.565954723613;5451.836444906659;4787.40157480315;4796.664233503656;4800;4801.903961920742;4803.615710743132;21456.068953794078;22239;22529.549409011728;22555.548889022128;22575.54848903029;2392.377981724764;2403.218953840009;2529.190658989124;3099.411111888734;3210.598675165604;13606.251656158907;14349.641258968504;14381.137131772128;14491.78262326066;14510.564683059525;1937.7771556271068;1946.8150525700037;1986.324649619122;1992.8740261752064;2036.9185232590678;67738.9839152418;68352.3164768351;69103.30896691019;69128;69141;10056.899431005597;10362.481875906175;10492.747248353035;10584.841227381596;10855.294405863593;13253.867461325262;13434.731305373838;13453.865461345262;13454.125481843648;13667.658308542366;8055.7583272501915;8128.837423251502;8267.62795674196;8377.246047855722;8408.2432581068;7834.138244793068;7875.527468351917;7969.920300797034;7994.480358776661;8001.919740835029;6085.717855804073;6147.538934579924;6160.383961603804;6171.876562468815;6218.81343559694;1861.972070418945;1890.9243630254912;1924.2783956016494;1942.1842826013108;1966.6558352288578;939.8402271613842;1034.4879284754095;1077.5258886090096;1129.5651174297955;1135.9034482069117;17831;18121.728174077398;18342.21138049474;18444.170012349477;18498;1058;1072.8605281313535;1073.6081330314535;1116.9776604468027;1141.8401423800674;9965.601375945025;10837.891621083845;10843.132549396028;10849.000357724864;10870.021698047214;438689;452218;463476;464240;464859;69556;70253.64873175704;71556.92664610036;72677.63661181767;73572.63213683898;1044.7805960748176;1058.1587637827945;1059.7562560611102;1071.8285074388061;1072.4744875011345;16234.269457874188;16252.187390630657;16276.918615406847;16438.178091095637;16609.66780664404;33288.334233314716;34147;34874.651253488155;35397.82301088478;35737.28525429425;43857;45594.316085258084;45959;46290.76854615705;46805.76597116992;8865.335099867665;8973.596188171417;8977.506237156758;9106.635734570544;9157.31320150978;13477.528286509925;13597.796033059314;13889.02776805614;13927.512537061155;13971.510997115052;10867;10895.618653347095;11021.83467247976;11108.44457777124;11386.316820990767;11363.431828408711;11899.226550274205;12267.447964841782;12432.937835310766;12546.12177147591;12213.511459541518;12334.81497777552;12337.691557711129;12400.75198496043;12433.813492797795;8631.223189912938;8665.350098742494;8772.210501054935;8786.38495305348;9089.5000774958;9107.362484626012;11936.940315298369;12203.14577979533;12343.259404435403;12427.130100892851 16:30:32 INFO - PROCESS | 10343 | |3;mootools.html;1452.0561634937283;1561.4847100456848;1567.6159340961465;1816.7365731968864;1959.9020048997547;7772.766816995485;8036.156203598625;8036.718714844981;8037.075736290321;8045.235702608243;7989.36085113191;8160.469569477995;8160.795980100501;8164.550949697764;8171.223733745284;2432.1609044879533;2451.460678650694;2452.288836237489;2461.8276720629565;2462.9507409851794;2366.5148644527917;2404.615261558151;2411.1199412214505;2416.709994800626;2418.6492958521094;2391.0435825669783;2402.843815152018;2423.3578101803037;2424.5514579802793;2432.74456182101;2376.8336216464854;2410.0359856057544;2426.7573242675767;2433.744456832034;2437.049550675238;2414.746451622572;2444.0346063304896;2445.8654773987423;2453.7423570525193;2459.495803360307;8198.918010819934;8240.175982401772;8244;8253.628586713612;8254.793630159294;5141.2545180948555;5359.624826262163;5368.463153684639;5371.543418809406;5375.650582712111;3202.9359412811846;3204.6955539223736;3245.1238165695368;3279.2457734721147;3283.5731354923946;1074.0333699670282;1075.8278675411975;1089.912806975448;2058.752949646037;2061.165228082629;11293.491792869258;11296.209265351428;11416.086713063018;11420.086393088533;11423.143264255132;4568.17772800899;4611.838585649486;4693.78877950493;4818.156822556039;4861.319415281863;9224.40041397307;9242.953785231031;9315.48764817928;9317.767055823522;9377;5199.948000520022;5210.8957820844125;5242.135047717084;5245.659032162897;5257.158854583248;4158.126793373365;4720.268358404453;4757.500462451393;4822.517748225149;4852.17513022787;3713.2387860489075;3760.2103558253075;3766.1714422826935;3814.1608846053823;3822.2546603412625;1130.12415378081;1141.3551343490901;1162.1400163878668;1163.9941800290944;1167.8073117935446;1476.4758510728536;1477.3204326010157;1477.8743806776329;1502.6919481506266;1524.26073354423;8115.837683246302;8131.2681858633005;8161.224683655162;8167.060788009336;8200.753977380688;561.3292115921435;563.4450066684312;565.1155940952397;568.5877738639535;573.9827805165852;5697.173909783141;5706.343770466367;5706.885862282814;5710.8001219957105;5748;9727.805443891224;9941.403515789076;9963.202943764481;10059.647912323033;10082.899171008343;9701.466419346863;9755.560999754885;9772.462514561767;9867.950660246797;9956.900430995598;7902.565358905315;8006.279434850775;8072.87890681652;8130.471519351341;8134.430589858772;7533.209013053551;7551.773446796605;7622.2758837910305;7623.771286861403;7625.6949722010495;8633.611487483204;8775.42959707617;8946.642134314554;9074.27405807547;9095;8955.373123881265;8981.775455613662;9064.546772661472;9180.311476639145;9437.433753974783;6733.93266067333;7199.6760145794615;7233.0597022386755;7346.11846578414;7398.778036658909;7874.488158269694;7877.094134174414;7899.881501777363;7917.802054948673;7951.681932722627;7231.963840180765;7285.23505031964;7418.517796343221;7514.774556763306;7534.095908491016;7221.638918053971;7301.890471642823;7309.415246780139;7359.227281135403;7374.446916481393;7255.818604534928;7310.6710198040155;7362.079740032496;7374.33630973215;7384.446166537424;6753.932460675331;6755.831104222237;6761.594304341756;6765.729370825309;6790.558613690095;7104.147502299757;7162.140543134858;7165.7850264492145;7174.928250717635;7179.9641001796745 16:30:32 INFO - PROCESS | 10343 | |4;prototype.html;341.7351552546776;346.5269906577519;348.1800360151842;350.6073198018219;351.5307065068134;5979.880402391949;5984.790532331369;6034.939650603493;6049.909251361233;6057.969710151454;5983.2820061592665;5986.132010858423;6000.6099603525845;6000.87998240036;6007;4492.415985921842;4574.634029277667;4643.674942754009;4661.44062712475;4710.364100846393;4649.023705021949;4673.8831529211875;4686;4695.624350051988;4701.200795864711;4623.42207224097;4644.790984405709;4651.046535460223;4655.324977878206;4665.0669866026765;4458.8885277867985;4548.749818759967;4649.279361698908;4656.254999200146;4675.766211689402;4112.485939257593;4113.239050775616;4114.773687447189;4125.030617804813;4125.29869922111;5711.4579063653;5717.857053573653;5725.427457254283;5726.112452569859;5741.913871291934;5442.401335853053;5450.182472629098;5451.209574611698;5455.372632147314;5463.508284254396;6361.777337793202;6364.809055728336;6382.553221274513;6387.361263873622;6393.680315984182;4302;4409.867703968886;4415;4416.823327066913;4593.242115051013;6425.325340839191;6481.805545833632;6593.076969224312;6594.868102637968;6603.141591593158;4566.337881007302;4571.177188106106;4581.702189357681;4582.106489234568;4582.587567118975;4626.930596041062;4635.281531362644;4637.118947399983;4639.164950308909;4639.420072490939;5334.199870019451;5341.759620817073;5346.492083252085;5346.7861285548925;5351.224072509464;6292.339304373067;6326.6520341381665;6409;6427.260865000491;6427.421532062137;1601.735713607265;1612.0569466861782;1623.8619717323922;1625.9268332925046;1629.6414788746456;1024.7847951930178;1045.4093437207953;1069.7272195590074;1073.5437439088357;1112.67732357617;6029.517638588903;6045.21412216409;6048.334683184846;6054.66699331541;6056;6419.422251997343;6535.477161827042;6538.313477084933;6543.574667646588;6553.934460655428;6129.049997250433;6136.417040381246;6143.416375444325;6147.170132032208;6147.969260153671;3490.458978858281;3522.5244591980268;3523.136831476305;3527.8236088195486;3529.6646818552194;6541.247756507967;6685.6322902240845;6821.249662537117;6830.760923367758;6849.760258391032;6819.624920629413;6833.589984600841;6844.5208835382045;6845.657717114224;6847.726090956306;6788.524803263823;6799.218089919624;6800.727970881208;6805.455563554904;6808.93191068083;6636.502262330248;6642.83392915181;6651.16860392451;6651.201855777144;6657.900131498128;6350.7777227796805;6565.409113179837;6573.1454910861285;6606.504512161511;6610.867782644224;6785.321467853175;6813.693383797642;6815.522913396015;6816.7614133505085;6834.658267086526;4586.862394128181;4620.607248383925;4626.1210370029585;4632.3977882875015;4634.745089020002;6640.601563906181;6647.60114393138;6657.933420665731;6659.433948114271;6668.499862510234;6363.395477429637;6467.935320646733;6478.611283323015;6481.935180648322;6490.51321150925;6453.644419786838;6475.64383958868;6485.28661847187;6485.902711459237;6493.22081350241;6315.368463153648;6333.334999824952;6334.968325158345;6336.398042185985;6357.618542887441;6509.121268628674;6511.218653761579;6514.413702766774;6516;6522.412982831568;6050.6369617823075;6120.143179954721;6198.6280823150755;6329.335419781041;6344.746210151542 16:30:32 INFO - PROCESS | 10343 | |5;yui.html;773.1804287455298;789.4947233770391;805.8952336196297;848.9278411335036;855.4140413816536;14451.060681055736;14899;16075.356985720571;16300.673986520262;16377.344906203767;15344.923275383635;15368;15368.846311536881;15439;15498.225088745574;758.7496126278315;929.9023602521705;939.2814496909853;959.0649117110831;969.1132613658494;963.2582911158404;965.6041023180497;967.6081187119192;968.2641192693568;968.4818622037211;1004.3521928356242;1005.1807776661997;1006.0291818395248;1007.0433088565892;1007.4358359318768;810.5703976892256;971.4851128901694;1000.8498725191243;1001.409168590535;1003.8193125237455;735.6836560279078;735.7351353512731;736.3446532586003;736.6427282767853;736.8010637127945;13779;13834.861651383459;13846;13853.51512697061;13863.306834658226;13189.472421103144;13271.86728132716;13375.188746721775;13581.11722738019;14058.578242652635;11693.883061169365;11699.23954942926;11804.291742495478;11822.349770762605;11893.702657433547;3735.925281494382;3775.377062784637;3814.1036856338737;3822.388417853158;3822.6750726188307;53352;53815.46184538144;53999.46000539984;54399.99999999961;54400.45599544033;10745.677629671123;10788.51451684676;10842.566297348018;10995.890041099487;11194.720131996764;19195.232190712217;19219.80780192208;19231.51921201981;19298.22807087729;19342.32301869428;8136.877946830802;8139.79650508742;8222.876656850152;8396.034456037634;8684.261837743863;4336.176126535948;4454.309582014793;4475.888102797391;4480.977595112004;4581.381513495702;3403.0471467989005;3434.3818112739946;3449.7757645752945;3451.4132597458492;3456.222349971287;539.387794852837;581.6626356713097;603.2007589943343;604.1783174882157;610.0239616613383;562.637099071105;653.2096163641951;653.2389765922742;659.2682122843639;661.9106420633249;8754.037055923844;8797.252233560092;8802.647894084164;8898.777530561787;9129.269658427309;529.5631104338936;593.7150167919423;667.5260564998905;702.922678505364;727.7198278662753;3919.980400097981;3973.92052158961;4172.4993000840095;4241.639460645818;4248.872533823928;64114.358856410836;64965.675171623836;65221;65356;65516.34483655198;55574;56744;56926.43073569294;57010;57598;49575.256371154464;50479.747601261755;50855.74572127116;51233.48766512287;51236.74381628068;8473.49159050459;8640.26557742599;8640.913590864011;8755.255803256794;8793.988691300583;37134.44298335581;37673.62326376811;37978.81010594929;38624.613753862104;39131.47457998653;43895;44342.556574433846;44931.32603011023;47396;47666.76166619144;10171.949140254252;10379.53292101842;10602.787944241227;10629.574817007542;10648.520816563117;12070.27578345302;12171.391430428266;12294;12317.815232771336;12580.30808305552;10840.67477975662;10866.945665271624;10975.737790153915;11259;11486.655400338002;11203.551857925591;11260.887391125983;11283.266587671775;11337.659870203906;11437.19939604253;10898.50956706966;11563.884361156617;11775.941120294343;12009.63971080869;12205.511779528719;10175.287729859136;10565.735856603338;10981.176411768989;11295.209335346775;11402.315861048364;10278.640247591298;10322.690319290434;10360.119389851947;10380.844287335847;10397.11624511925 16:30:32 INFO - PROCESS | 10343 | __end_tp_report 16:30:32 INFO - PROCESS | 10343 | __start_cc_report 16:30:32 INFO - PROCESS | 10343 | _x_x_mozilla_cycle_collect,879 16:30:32 INFO - PROCESS | 10343 | __end_cc_report 16:30:32 INFO - PROCESS | 10343 | __startTimestamp1461972632156__endTimestamp 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | ------- Summary: start ------- 16:30:32 INFO - PROCESS | 10343 | Number of tests: 6 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#0] dojo.html Cycles:165 Average:5341.90 Median:5579.55 stddev:580.00 (10.4%) stddev-sans-first:558.56 16:30:32 INFO - PROCESS | 10343 | Values: 3270.9 3320.5 3336.4 3338.0 3365.2 5293.6 5305.7 5310.7 5315.7 5329.2 5324.2 5330.2 5335.4 5346.6 5347.4 4775.3 4863.9 4878.3 4906.7 4951.3 4803.0 4834.0 4878.6 4882.7 4884.5 4826.6 4888.6 4963.3 4989.0 4996.6 4977.4 4983.5 5010.9 5012.3 5030.8 4778.1 4807.3 4871.8 4876.2 4900.0 5161.4 5174.6 5178.5 5187.0 5211.1 5668.6 5681.7 5684.7 5738.0 5739.2 5761.7 5764.0 5780.0 5804.5 5812.8 5406.4 5408.1 5411.5 5414.5 5443.9 5764.9 5799.0 5876.4 5878.0 5897.4 5728.3 5743.3 5748.8 5748.9 5750.6 5789.5 5801.6 5802.7 5803.5 5808.8 5605.9 5673.9 5745.2 5761.8 5769.5 5668.9 5695.6 5697.7 5697.8 5700.4 4310.3 4361.7 4361.7 4363.6 4386.8 3912.8 3913.9 3976.4 3977.5 3997.4 5440.9 5448.4 5451.7 5453.6 5484.1 5571.9 5700.5 5740.2 5748.0 5748.8 5231.9 5418.5 5421.3 5497.8 5538.7 4924.5 4934.2 4936.8 4940.4 4967.3 5780.7 5896.9 5898.0 5899.8 5906.8 5678.2 5713.6 5728.8 5732.0 5769.7 5835.2 5867.1 5878.6 5883.4 5884.1 5583.6 5644.9 5647.4 5707.9 5776.0 5853.7 5853.7 5854.6 5855.4 5856.0 5666.3 5675.6 5677.5 5681.4 5684.6 5450.4 5631.8 5646.3 5673.0 5719.9 5537.1 5549.8 5579.6 5583.0 5589.0 5650.8 5678.1 5706.9 5713.2 5721.3 5408.5 5445.2 5522.1 5605.6 5637.7 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#1] ext.html Cycles:180 Average:43304.65 Median:21147.05 stddev:67803.36 (320.6%) stddev-sans-first:67917.59 16:30:32 INFO - PROCESS | 10343 | Values: 557.0 561.2 567.2 576.0 595.2 39056.6 39730.0 39811.8 39824.2 39878.4 46367.5 47476.8 47683.3 47800.5 47827.8 8837.9 8995.5 9007.9 9014.1 9014.2 9177.5 9332.7 9343.0 9353.7 9357.0 9303.6 9381.9 9391.6 9404.2 9408.6 9240.6 9310.1 9318.2 9325.2 9331.9 9054.4 9304.4 9305.0 9307.6 9315.3 43097.8 43367.8 43387.3 43446.0 43633.1 3808.5 3835.9 3869.9 3882.9 3930.0 32689.3 33065.5 33207.2 33620.7 33701.8 4252.5 4264.0 4266.0 4268.0 4281.5 210060.9 212141.0 212820.0 213224.0 213918.0 46398.5 61566.7 61568.4 61635.7 61845.7 42821.8 42829.0 42892.4 42913.6 42960.9 16324.8 16470.8 16495.8 16496.5 16502.5 13417.3 13503.6 13509.3 13517.4 13518.1 15265.9 15665.8 15845.5 15860.1 15871.9 5821.3 5887.6 5929.6 6014.6 6130.7 1044.6 1077.4 1092.9 1099.0 1243.4 30173.9 30414.7 30660.8 30731.2 30920.5 1125.5 1136.3 1147.4 1173.2 1225.4 15964.7 16079.4 16314.1 16336.4 16347.3 344688.0 347199.0 347922.0 349468.0 350981.0 58633.7 59592.1 59625.0 59660.0 59723.4 1343.6 1474.1 1474.4 1481.5 1527.5 28913.7 29779.3 30009.8 30356.2 30594.2 46160.5 46418.0 46698.8 46755.3 46885.0 180140.0 181536.0 193156.0 193223.0 193530.0 30628.8 35036.8 35281.8 35363.9 35425.6 40733.0 41285.2 41502.9 41504.0 41922.8 38235.2 38735.6 38778.6 38840.2 39082.0 36523.3 37333.3 37812.2 38065.0 38237.0 37549.1 37579.6 38211.4 38458.2 38757.6 32854.1 34468.7 35051.0 35054.8 35250.8 26542.2 26790.9 26834.6 27032.2 28846.6 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#2] jquery.html Cycles:180 Average:26587.58 Median:22565.55 stddev:74733.43 (331.2%) stddev-sans-first:74917.18 16:30:32 INFO - PROCESS | 10343 | Values: 382.5 388.0 390.7 392.6 400.2 15114.8 17580.9 18206.4 19171.7 19605.0 17444.2 17720.3 18053.3 18094.1 18099.8 5542.9 5611.4 5625.2 5667.9 5692.7 5488.2 5629.7 5654.2 5668.3 5670.5 5370.4 5601.3 5601.6 5614.2 5624.2 5387.1 5417.7 5423.4 5425.6 5451.8 4787.4 4796.7 4800.0 4801.9 4803.6 21456.1 22239.0 22529.5 22555.5 22575.5 2392.4 2403.2 2529.2 3099.4 3210.6 13606.3 14349.6 14381.1 14491.8 14510.6 1937.8 1946.8 1986.3 1992.9 2036.9 67739.0 68352.3 69103.3 69128.0 69141.0 10056.9 10362.5 10492.7 10584.8 10855.3 13253.9 13434.7 13453.9 13454.1 13667.7 8055.8 8128.8 8267.6 8377.2 8408.2 7834.1 7875.5 7969.9 7994.5 8001.9 6085.7 6147.5 6160.4 6171.9 6218.8 1862.0 1890.9 1924.3 1942.2 1966.7 939.8 1034.5 1077.5 1129.6 1135.9 17831.0 18121.7 18342.2 18444.2 18498.0 1058.0 1072.9 1073.6 1117.0 1141.8 9965.6 10837.9 10843.1 10849.0 10870.0 438689.0 452218.0 463476.0 464240.0 464859.0 69556.0 70253.6 71556.9 72677.6 73572.6 1044.8 1058.2 1059.8 1071.8 1072.5 16234.3 16252.2 16276.9 16438.2 16609.7 33288.3 34147.0 34874.7 35397.8 35737.3 43857.0 45594.3 45959.0 46290.8 46805.8 8865.3 8973.6 8977.5 9106.6 9157.3 13477.5 13597.8 13889.0 13927.5 13971.5 10867.0 10895.6 11021.8 11108.4 11386.3 11363.4 11899.2 12267.4 12432.9 12546.1 12213.5 12334.8 12337.7 12400.8 12433.8 8631.2 8665.4 8772.2 8786.4 9089.5 9107.4 11936.9 12203.1 12343.3 12427.1 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#3] mootools.html Cycles:180 Average:5800.32 Median:3160.99 stddev:2980.52 (94.3%) stddev-sans-first:2970.96 16:30:32 INFO - PROCESS | 10343 | Values: 1452.1 1561.5 1567.6 1816.7 1959.9 7772.8 8036.2 8036.7 8037.1 8045.2 7989.4 8160.5 8160.8 8164.6 8171.2 2432.2 2451.5 2452.3 2461.8 2463.0 2366.5 2404.6 2411.1 2416.7 2418.6 2391.0 2402.8 2423.4 2424.6 2432.7 2376.8 2410.0 2426.8 2433.7 2437.0 2414.7 2444.0 2445.9 2453.7 2459.5 8198.9 8240.2 8244.0 8253.6 8254.8 5141.3 5359.6 5368.5 5371.5 5375.7 3202.9 3204.7 3245.1 3279.2 3283.6 1074.0 1075.8 1089.9 2058.8 2061.2 11293.5 11296.2 11416.1 11420.1 11423.1 4568.2 4611.8 4693.8 4818.2 4861.3 9224.4 9243.0 9315.5 9317.8 9377.0 5199.9 5210.9 5242.1 5245.7 5257.2 4158.1 4720.3 4757.5 4822.5 4852.2 3713.2 3760.2 3766.2 3814.2 3822.3 1130.1 1141.4 1162.1 1164.0 1167.8 1476.5 1477.3 1477.9 1502.7 1524.3 8115.8 8131.3 8161.2 8167.1 8200.8 561.3 563.4 565.1 568.6 574.0 5697.2 5706.3 5706.9 5710.8 5748.0 9727.8 9941.4 9963.2 10059.6 10082.9 9701.5 9755.6 9772.5 9868.0 9956.9 7902.6 8006.3 8072.9 8130.5 8134.4 7533.2 7551.8 7622.3 7623.8 7625.7 8633.6 8775.4 8946.6 9074.3 9095.0 8955.4 8981.8 9064.5 9180.3 9437.4 6733.9 7199.7 7233.1 7346.1 7398.8 7874.5 7877.1 7899.9 7917.8 7951.7 7232.0 7285.2 7418.5 7514.8 7534.1 7221.6 7301.9 7309.4 7359.2 7374.4 7255.8 7310.7 7362.1 7374.3 7384.4 6753.9 6755.8 6761.6 6765.7 6790.6 7104.1 7162.1 7165.8 7174.9 7180.0 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#4] prototype.html Cycles:180 Average:5362.38 Median:6049.12 stddev:1608.11 (26.6%) stddev-sans-first:1567.85 16:30:32 INFO - PROCESS | 10343 | Values: 341.7 346.5 348.2 350.6 351.5 5979.9 5984.8 6034.9 6049.9 6058.0 5983.3 5986.1 6000.6 6000.9 6007.0 4492.4 4574.6 4643.7 4661.4 4710.4 4649.0 4673.9 4686.0 4695.6 4701.2 4623.4 4644.8 4651.0 4655.3 4665.1 4458.9 4548.7 4649.3 4656.3 4675.8 4112.5 4113.2 4114.8 4125.0 4125.3 5711.5 5717.9 5725.4 5726.1 5741.9 5442.4 5450.2 5451.2 5455.4 5463.5 6361.8 6364.8 6382.6 6387.4 6393.7 4302.0 4409.9 4415.0 4416.8 4593.2 6425.3 6481.8 6593.1 6594.9 6603.1 4566.3 4571.2 4581.7 4582.1 4582.6 4626.9 4635.3 4637.1 4639.2 4639.4 5334.2 5341.8 5346.5 5346.8 5351.2 6292.3 6326.7 6409.0 6427.3 6427.4 1601.7 1612.1 1623.9 1625.9 1629.6 1024.8 1045.4 1069.7 1073.5 1112.7 6029.5 6045.2 6048.3 6054.7 6056.0 6419.4 6535.5 6538.3 6543.6 6553.9 6129.0 6136.4 6143.4 6147.2 6148.0 3490.5 3522.5 3523.1 3527.8 3529.7 6541.2 6685.6 6821.2 6830.8 6849.8 6819.6 6833.6 6844.5 6845.7 6847.7 6788.5 6799.2 6800.7 6805.5 6808.9 6636.5 6642.8 6651.2 6651.2 6657.9 6350.8 6565.4 6573.1 6606.5 6610.9 6785.3 6813.7 6815.5 6816.8 6834.7 4586.9 4620.6 4626.1 4632.4 4634.7 6640.6 6647.6 6657.9 6659.4 6668.5 6363.4 6467.9 6478.6 6481.9 6490.5 6453.6 6475.6 6485.3 6485.9 6493.2 6315.4 6333.3 6335.0 6336.4 6357.6 6509.1 6511.2 6514.4 6516.0 6522.4 6050.6 6120.1 6198.6 6329.3 6344.7 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - PROCESS | 10343 | [#5] yui.html Cycles:180 Average:14931.95 Median:21223.64 stddev:17608.48 (83.0%) stddev-sans-first:17625.78 16:30:32 INFO - PROCESS | 10343 | Values: 773.2 789.5 805.9 848.9 855.4 14451.1 14899.0 16075.4 16300.7 16377.3 15344.9 15368.0 15368.8 15439.0 15498.2 758.7 929.9 939.3 959.1 969.1 963.3 965.6 967.6 968.3 968.5 1004.4 1005.2 1006.0 1007.0 1007.4 810.6 971.5 1000.8 1001.4 1003.8 735.7 735.7 736.3 736.6 736.8 13779.0 13834.9 13846.0 13853.5 13863.3 13189.5 13271.9 13375.2 13581.1 14058.6 11693.9 11699.2 11804.3 11822.3 11893.7 3735.9 3775.4 3814.1 3822.4 3822.7 53352.0 53815.5 53999.5 54400.0 54400.5 10745.7 10788.5 10842.6 10995.9 11194.7 19195.2 19219.8 19231.5 19298.2 19342.3 8136.9 8139.8 8222.9 8396.0 8684.3 4336.2 4454.3 4475.9 4481.0 4581.4 3403.0 3434.4 3449.8 3451.4 3456.2 539.4 581.7 603.2 604.2 610.0 562.6 653.2 653.2 659.3 661.9 8754.0 8797.3 8802.6 8898.8 9129.3 529.6 593.7 667.5 702.9 727.7 3920.0 3973.9 4172.5 4241.6 4248.9 64114.4 64965.7 65221.0 65356.0 65516.3 55574.0 56744.0 56926.4 57010.0 57598.0 49575.3 50479.7 50855.7 51233.5 51236.7 8473.5 8640.3 8640.9 8755.3 8794.0 37134.4 37673.6 37978.8 38624.6 39131.5 43895.0 44342.6 44931.3 47396.0 47666.8 10171.9 10379.5 10602.8 10629.6 10648.5 12070.3 12171.4 12294.0 12317.8 12580.3 10840.7 10866.9 10975.7 11259.0 11486.7 11203.6 11260.9 11283.3 11337.7 11437.2 10898.5 11563.9 11775.9 12009.6 12205.5 10175.3 10565.7 10981.2 11295.2 11402.3 10278.6 10322.7 10360.1 10380.8 10397.1 16:30:32 INFO - PROCESS | 10343 | -------- Summary: end -------- 16:30:32 INFO - PROCESS | 10343 | 16:30:32 INFO - TEST-INFO | 10343: exit 0 16:30:32 INFO - TEST-OK | dromaeo_css | took 1110842ms 16:30:32 INFO - TEST-START | kraken 16:30:32 INFO - operating with platform_type : linux_ 16:30:32 INFO - Initialising browser for kraken test... 16:30:32 INFO - TEST-INFO | started process 10539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtaiTK/profile http://localhost:36676/getInfo.html) 16:30:36 INFO - PROCESS | 10539 | __metrics Screen width/height:1600/1200 16:30:36 INFO - PROCESS | 10539 | colorDepth:24 16:30:36 INFO - PROCESS | 10539 | Browser inner width/height: 1024/697 16:30:36 INFO - PROCESS | 10539 | __metrics 16:30:37 INFO - PROCESS | 10539 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:30:38 INFO - TEST-INFO | 10539: exit 0 16:30:38 INFO - Browser initialized. 16:30:38 INFO - Running cycle 1/1 for kraken test... 16:30:38 INFO - TEST-INFO | started process 10630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwtaiTK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:50 INFO - PROCESS | 10630 | RSS: Main: 140005376 16:30:50 INFO - PROCESS | 10630 | 16:30:53 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36676/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:53 INFO - PROCESS | 10630 | RSS: Main: 175751168 16:30:53 INFO - PROCESS | 10630 | 16:30:56 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36676/tests/kraken/driver.html?testName=audio-dft) 16:30:57 INFO - PROCESS | 10630 | RSS: Main: 173666304 16:30:57 INFO - PROCESS | 10630 | 16:30:59 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36676/tests/kraken/driver.html?testName=audio-fft) 16:31:00 INFO - PROCESS | 10630 | RSS: Main: 169975808 16:31:00 INFO - PROCESS | 10630 | 16:31:02 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36676/tests/kraken/driver.html?testName=audio-oscillator) 16:31:03 INFO - PROCESS | 10630 | RSS: Main: 170541056 16:31:03 INFO - PROCESS | 10630 | 16:31:05 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:05 INFO - PROCESS | 10630 | RSS: Main: 168239104 16:31:05 INFO - PROCESS | 10630 | 16:31:08 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36676/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:09 INFO - PROCESS | 10630 | RSS: Main: 168714240 16:31:09 INFO - PROCESS | 10630 | 16:31:12 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36676/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:13 INFO - PROCESS | 10630 | RSS: Main: 169291776 16:31:13 INFO - PROCESS | 10630 | 16:31:16 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36676/tests/kraken/driver.html?testName=json-parse-financial) 16:31:16 INFO - PROCESS | 10630 | RSS: Main: 168656896 16:31:16 INFO - PROCESS | 10630 | 16:31:18 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:18 INFO - PROCESS | 10630 | RSS: Main: 176087040 16:31:18 INFO - PROCESS | 10630 | 16:31:20 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:21 INFO - PROCESS | 10630 | RSS: Main: 173047808 16:31:21 INFO - PROCESS | 10630 | 16:31:23 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:23 INFO - PROCESS | 10630 | RSS: Main: 180310016 16:31:23 INFO - PROCESS | 10630 | 16:31:26 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:26 INFO - PROCESS | 10630 | RSS: Main: 185884672 16:31:26 INFO - PROCESS | 10630 | 16:31:29 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:31:29 INFO - PROCESS | 10630 | RSS: Main: 184287232 16:31:29 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | Cycle 1(1): loaded http://localhost:36676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36676/tests/kraken/driver.html?testName=ai-astar) 16:31:31 INFO - PROCESS | 10630 | RSS: Main: 247316480 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | __start_tp_report 16:31:31 INFO - PROCESS | 10630 | _x_x_mozilla_page_load 16:31:31 INFO - PROCESS | 10630 | _x_x_mozilla_page_load_details 16:31:31 INFO - PROCESS | 10630 | |i|pagename|runs| 16:31:31 INFO - PROCESS | 10630 | |0;ai-astar;110;113;106;112;112;114;100;112;111;112 16:31:31 INFO - PROCESS | 10630 | |1;audio-beat-detection;156;137;156;170;129;160;156;128;185;127 16:31:31 INFO - PROCESS | 10630 | |2;audio-dft;162;162;161;160;162;160;159;163;161;162 16:31:31 INFO - PROCESS | 10630 | |3;audio-fft;79;77;76;172;76;77;76;74;166;78 16:31:31 INFO - PROCESS | 10630 | |4;audio-oscillator;94;93;146;93;94;93;152;94;93;145 16:31:31 INFO - PROCESS | 10630 | |5;imaging-gaussian-blur;117;117;116;116;116;117;116;117;117;116 16:31:31 INFO - PROCESS | 10630 | |6;imaging-darkroom;145;146;146;145;145;145;146;145;144;145 16:31:31 INFO - PROCESS | 10630 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;95;95 16:31:31 INFO - PROCESS | 10630 | |8;json-parse-financial;56;57;57;58;58;58;56;58;55;58 16:31:31 INFO - PROCESS | 10630 | |9;json-stringify-tinderbox;64;64;64;65;65;65;65;64;65;65 16:31:31 INFO - PROCESS | 10630 | |10;stanford-crypto-aes;78;87;79;78;79;86;79;78;80;78 16:31:31 INFO - PROCESS | 10630 | |11;stanford-crypto-ccm;118;115;112;127;111;113;116;118;116;122 16:31:31 INFO - PROCESS | 10630 | |12;stanford-crypto-pbkdf2;142;144;153;145;154;143;149;149;147;138 16:31:31 INFO - PROCESS | 10630 | |13;stanford-crypto-sha256-iterative;68;69;70;70;68;68;67;69;66;67 16:31:31 INFO - PROCESS | 10630 | __end_tp_report 16:31:31 INFO - PROCESS | 10630 | __start_cc_report 16:31:31 INFO - PROCESS | 10630 | _x_x_mozilla_cycle_collect,1077 16:31:31 INFO - PROCESS | 10630 | __end_cc_report 16:31:31 INFO - PROCESS | 10630 | __startTimestamp1461972691826__endTimestamp 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | ------- Summary: start ------- 16:31:31 INFO - PROCESS | 10630 | Number of tests: 14 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.18 (3.7%) stddev-sans-first:4.44 16:31:31 INFO - PROCESS | 10630 | Values: 110.0 113.0 106.0 112.0 112.0 114.0 100.0 112.0 111.0 112.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:156.00 stddev:19.59 (12.6%) stddev-sans-first:20.67 16:31:31 INFO - PROCESS | 10630 | Values: 156.0 137.0 156.0 170.0 129.0 160.0 156.0 128.0 185.0 127.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 16:31:31 INFO - PROCESS | 10630 | Values: 162.0 162.0 161.0 160.0 162.0 160.0 159.0 163.0 161.0 162.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.50 stddev:39.00 (51.0%) stddev-sans-first:40.93 16:31:31 INFO - PROCESS | 10630 | Values: 79.0 77.0 76.0 172.0 76.0 77.0 76.0 74.0 166.0 78.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:26.26 (28.2%) stddev-sans-first:27.24 16:31:31 INFO - PROCESS | 10630 | Values: 94.0 93.0 146.0 93.0 94.0 93.0 152.0 94.0 93.0 145.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:31:31 INFO - PROCESS | 10630 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:31:31 INFO - PROCESS | 10630 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 144.0 145.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:31:31 INFO - PROCESS | 10630 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:1.10 (1.9%) stddev-sans-first:1.09 16:31:31 INFO - PROCESS | 10630 | Values: 56.0 57.0 57.0 58.0 58.0 58.0 56.0 58.0 55.0 58.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:31:31 INFO - PROCESS | 10630 | Values: 64.0 64.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:3.39 (4.3%) stddev-sans-first:3.50 16:31:31 INFO - PROCESS | 10630 | Values: 78.0 87.0 79.0 78.0 79.0 86.0 79.0 78.0 80.0 78.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:117.00 stddev:4.83 (4.1%) stddev-sans-first:5.10 16:31:31 INFO - PROCESS | 10630 | Values: 118.0 115.0 112.0 127.0 111.0 113.0 116.0 118.0 116.0 122.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:148.00 stddev:4.99 (3.4%) stddev-sans-first:5.04 16:31:31 INFO - PROCESS | 10630 | Values: 142.0 144.0 153.0 145.0 154.0 143.0 149.0 149.0 147.0 138.0 16:31:31 INFO - PROCESS | 10630 | 16:31:31 INFO - PROCESS | 10630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.32 (1.9%) stddev-sans-first:1.39 16:31:31 INFO - PROCESS | 10630 | Values: 68.0 69.0 70.0 70.0 68.0 68.0 67.0 69.0 66.0 67.0 16:31:31 INFO - PROCESS | 10630 | -------- Summary: end -------- 16:31:31 INFO - PROCESS | 10630 | 16:31:32 INFO - TEST-INFO | 10630: exit 0 16:31:32 INFO - TEST-OK | kraken | took 59841ms 16:31:32 INFO - SUITE-END | took 1170s 16:31:32 INFO - Completed test suite (00:19:30) 16:31:32 INFO - javascript benchmark 16:31:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3270.9018729438117, 3320.5351250824906, 3336.3660904428157, 3337.966620333796, 3365.242820365418, 5293.6294459387855, 5305.681659100447, 5310.6813591184555, 5315.707636080014, 5329.200619907016, 5324.227986941891, 5330.200469929512, 5335.439778823226, 5346.625736198458, 5347.438518955512, 4775.3075804008395, 4863.902721945559, 4878.268259761029, 4906.656534042619, 4951.306817045616, 4803.039392121572, 4833.9516604834025, 4878.560929516343, 4882.682625629341, 4884.462709102014, 4826.638002149835, 4888.560029597335, 4963.25551167326, 4988.950110498885, 4996.625253106014, 4977.3529441172595, 4983.476734942815, 5010.874728131789, 5012.273220383024, 5030.773615187307, 4778.116048531033, 4807.30294107356, 4871.780769865364, 4876.219804831246, 4900.0, 5161.4322424533275, 5174.637775355726, 5178.482151784829, 5186.974065129688, 5211.062008838408, 5668.631538949996, 5681.744321505501, 5684.744186511575, 5738.0, 5739.167820666022, 5761.683107429089, 5764.0, 5780.0, 5804.535637149018, 5812.825615231508, 5406.378266499324, 5408.107662235727, 5411.512963833274, 5414.458554144593, 5443.945560544423, 5764.942350576524, 5799.043157878903, 5876.412358764175, 5878.0, 5897.380775018647, 5728.312602487728, 5743.282089738783, 5748.770049198069, 5748.913766293509, 5750.568707346965, 5789.507891829157, 5801.622894511843, 5802.709864506758, 5803.506701930299, 5808.796692115756, 5605.859853503695, 5673.914891276634, 5745.224394706661, 5761.798337058183, 5769.538436925036, 5668.886622267614, 5695.572832037614, 5697.686627235459, 5697.772089116389, 5700.4299570043495, 4310.331898555729, 4361.738295702268, 4361.738295702268, 4363.585459381354, 4386.780660966939, 3912.8434862605745, 3913.9217215655526, 3976.383660532622, 3977.5028121484816, 3997.360422332413, 5440.891182176334, 5448.427915068861, 5451.700156491431, 5453.618246722771, 5484.067708489566, 5571.860703482445, 5700.458456446631, 5740.225069615549, 5747.971260143672, 5748.798792042258, 5231.895362092737, 5418.539424148913, 5421.2681288025615, 5497.8075767347955, 5538.723063846792, 4924.482929292372, 4934.235193544934, 4936.802527898843, 4940.407151141886, 4967.254911763264, 5780.682062486603, 5896.852578685567, 5898.026825573732, 5899.793507227227, 5906.822795316061, 5678.176664383724, 5713.628614140068, 5728.770849166153, 5732.025555655632, 5769.68266745333, 5835.183074369676, 5867.090600956859, 5878.588498805214, 5883.441073098049, 5884.0585506318785, 5583.553315734813, 5644.85887852807, 5647.435256474319, 5707.857303567444, 5776.018076926848, 5853.707314634166, 5853.736581853912, 5854.648721076749, 5855.38518455556, 5856.033754430641, 5666.320041595035, 5675.57433192504, 5677.460641239076, 5681.375048744718, 5684.573656975661, 5450.427705090909, 5631.802886898939, 5646.265985421869, 5672.971635141798, 5719.941810765022, 5537.058700020925, 5549.805756798492, 5579.553635709052, 5583.0, 5589.049861523469, 5650.802221922213, 5678.119891416837, 5706.914396283976, 5713.171590119493, 5721.25623668937, 5408.486193811582, 5445.237666726741, 5522.088855338824, 5605.5515558756015, 5637.746301416528], "unit": "score", "name": "dojo.html", "value": 5305.475521117447}, {"lowerIsBetter": false, "replicates": [557.0335467963083, 561.1918836874901, 567.214408044858, 575.9654420734759, 595.1727099331929, 39056.60943390565, 39730.006749831235, 39811.80094099526, 39824.203515929665, 39878.401823972665, 46367.53632463674, 47476.76261618687, 47683.284750728766, 47800.52199478004, 47827.84774685139, 8837.911620883806, 8995.5052472114, 9007.909920900805, 9014.053524379944, 9014.188723014928, 9177.54112294386, 9332.673356432526, 9343.0, 9353.719388418358, 9356.953215233914, 9303.62785488583, 9381.859272110889, 9391.59126131079, 9404.153626173644, 9408.576614052385, 9240.5841737122, 9310.115539023782, 9318.20795232406, 9325.160735533767, 9331.90668093324, 9054.366194366397, 9304.395214311047, 9305.022972587849, 9307.627694892197, 9315.254779617615, 43097.78451107756, 43367.783161084306, 43387.34918976218, 43446.0, 43633.12733745339, 3808.485854409647, 3835.8657446989223, 3869.9032524186837, 3882.9223415531533, 3929.980350098231, 32689.34621307584, 33065.50401743976, 33207.16982075443, 33620.663793362, 33701.831490842385, 4252.510961239435, 4264.0, 4265.957340426587, 4268.0, 4281.48622165339, 210060.9496952521, 212141.0, 212820.0, 213224.0, 213918.0, 46398.53601463942, 61566.69216653888, 61568.384316157164, 61635.691821540604, 61845.69077154675, 42821.78589107034, 42829.0, 42892.3566146508, 42913.570864291585, 42960.92597685083, 16324.755128672841, 16470.7646926481, 16495.752563711554, 16496.505104846874, 16502.504924852274, 13417.262050587116, 13503.59489215325, 13509.324533773271, 13517.391717372742, 13518.121322114031, 15265.923670381577, 15665.843341566666, 15845.52463426099, 15860.127692976997, 15871.920640396724, 5821.27234095738, 5887.646741195542, 5929.584929055011, 6014.6391216527145, 6130.724117414727, 1044.6343779677204, 1077.3692655750172, 1092.939888306135, 1098.961536346224, 1243.421808858885, 30173.855315240897, 30414.69585304163, 30660.81479828438, 30731.2317192072, 30920.536191957137, 1125.5160281079052, 1136.3011747775224, 1147.449224372306, 1173.16705139352, 1225.4485481533345, 15964.68070638604, 16079.356825727074, 16314.102724350274, 16336.428225012067, 16347.34610615562, 344688.0, 347199.0, 347922.0, 349468.0, 350981.0, 58633.70683146557, 59592.10611840826, 59625.0, 59660.0, 59723.402765972656, 1343.6372179511477, 1474.108164560447, 1474.4323435477418, 1481.5185064853965, 1527.5341020988706, 28913.7108628911, 29779.255518612208, 30009.849950750107, 30356.24109397283, 30594.235144121576, 46160.53839461562, 46418.0, 46698.76650616725, 46755.29867051929, 46885.0, 180140.0, 181536.0, 193156.0, 193223.0, 193530.0, 30628.84685576647, 35036.824815875756, 35281.82359088188, 35363.939081827586, 35425.645743542234, 40733.0, 41285.1742965145, 41502.89421506551, 41504.0, 41922.79038604909, 38235.23529529449, 38735.61264387433, 38778.61221387863, 38840.22319553536, 39082.0, 36523.26953460969, 37333.253334933695, 37812.243755125295, 38065.0, 38237.0, 37549.06127346838, 37579.624203757616, 38211.42682859704, 38458.23083538258, 38757.6124238754, 32854.113126574826, 34468.65531344654, 35051.0, 35054.824725877224, 35250.823745881105, 26542.203733888015, 26790.866045669645, 26834.59748103741, 27032.189034329003, 28846.56665751408], "unit": "score", "name": "ext.html", "value": 18787.73548097722}, {"lowerIsBetter": false, "replicates": [382.5371300726123, 387.96314350136726, 390.6718356580472, 392.57013570140697, 400.1556715330652, 15114.848851511482, 17580.912095439522, 18206.3627773028, 19171.712424313628, 19605.019749012547, 17444.215010324533, 17720.291188352483, 18053.277868885263, 18094.09529523522, 18099.819001809978, 5542.91685624716, 5611.354694210157, 5625.240592519998, 5667.914981275284, 5692.743826527795, 5488.231647569343, 5629.690367029812, 5654.151877218409, 5668.319801623811, 5670.518005969477, 5370.43610420906, 5601.271834661508, 5601.579881508883, 5614.157876318564, 5624.15637654351, 5387.1111266640955, 5417.674939503642, 5423.430539793304, 5425.565954723613, 5451.836444906659, 4787.40157480315, 4796.664233503656, 4800.0, 4801.903961920742, 4803.615710743132, 21456.068953794078, 22239.0, 22529.549409011728, 22555.548889022128, 22575.54848903029, 2392.377981724764, 2403.218953840009, 2529.190658989124, 3099.411111888734, 3210.598675165604, 13606.251656158907, 14349.641258968504, 14381.137131772128, 14491.78262326066, 14510.564683059525, 1937.7771556271068, 1946.8150525700037, 1986.324649619122, 1992.8740261752064, 2036.9185232590678, 67738.9839152418, 68352.3164768351, 69103.30896691019, 69128.0, 69141.0, 10056.899431005597, 10362.481875906175, 10492.747248353035, 10584.841227381596, 10855.294405863593, 13253.867461325262, 13434.731305373838, 13453.865461345262, 13454.125481843648, 13667.658308542366, 8055.7583272501915, 8128.837423251502, 8267.62795674196, 8377.246047855722, 8408.2432581068, 7834.138244793068, 7875.527468351917, 7969.920300797034, 7994.480358776661, 8001.919740835029, 6085.717855804073, 6147.538934579924, 6160.383961603804, 6171.876562468815, 6218.81343559694, 1861.972070418945, 1890.9243630254912, 1924.2783956016494, 1942.1842826013108, 1966.6558352288578, 939.8402271613842, 1034.4879284754095, 1077.5258886090096, 1129.5651174297955, 1135.9034482069117, 17831.0, 18121.728174077398, 18342.21138049474, 18444.170012349477, 18498.0, 1058.0, 1072.8605281313535, 1073.6081330314535, 1116.9776604468027, 1141.8401423800674, 9965.601375945025, 10837.891621083845, 10843.132549396028, 10849.000357724864, 10870.021698047214, 438689.0, 452218.0, 463476.0, 464240.0, 464859.0, 69556.0, 70253.64873175704, 71556.92664610036, 72677.63661181767, 73572.63213683898, 1044.7805960748176, 1058.1587637827945, 1059.7562560611102, 1071.8285074388061, 1072.4744875011345, 16234.269457874188, 16252.187390630657, 16276.918615406847, 16438.178091095637, 16609.66780664404, 33288.334233314716, 34147.0, 34874.651253488155, 35397.82301088478, 35737.28525429425, 43857.0, 45594.316085258084, 45959.0, 46290.76854615705, 46805.76597116992, 8865.335099867665, 8973.596188171417, 8977.506237156758, 9106.635734570544, 9157.31320150978, 13477.528286509925, 13597.796033059314, 13889.02776805614, 13927.512537061155, 13971.510997115052, 10867.0, 10895.618653347095, 11021.83467247976, 11108.44457777124, 11386.316820990767, 11363.431828408711, 11899.226550274205, 12267.447964841782, 12432.937835310766, 12546.12177147591, 12213.511459541518, 12334.81497777552, 12337.691557711129, 12400.75198496043, 12433.813492797795, 8631.223189912938, 8665.350098742494, 8772.210501054935, 8786.38495305348, 9089.5000774958, 9107.362484626012, 11936.940315298369, 12203.14577979533, 12343.259404435403, 12427.130100892851], "unit": "score", "name": "jquery.html", "value": 9084.166916101382}, {"lowerIsBetter": false, "replicates": [1452.0561634937283, 1561.4847100456848, 1567.6159340961465, 1816.7365731968864, 1959.9020048997547, 7772.766816995485, 8036.156203598625, 8036.718714844981, 8037.075736290321, 8045.235702608243, 7989.36085113191, 8160.469569477995, 8160.795980100501, 8164.550949697764, 8171.223733745284, 2432.1609044879533, 2451.460678650694, 2452.288836237489, 2461.8276720629565, 2462.9507409851794, 2366.5148644527917, 2404.615261558151, 2411.1199412214505, 2416.709994800626, 2418.6492958521094, 2391.0435825669783, 2402.843815152018, 2423.3578101803037, 2424.5514579802793, 2432.74456182101, 2376.8336216464854, 2410.0359856057544, 2426.7573242675767, 2433.744456832034, 2437.049550675238, 2414.746451622572, 2444.0346063304896, 2445.8654773987423, 2453.7423570525193, 2459.495803360307, 8198.918010819934, 8240.175982401772, 8244.0, 8253.628586713612, 8254.793630159294, 5141.2545180948555, 5359.624826262163, 5368.463153684639, 5371.543418809406, 5375.650582712111, 3202.9359412811846, 3204.6955539223736, 3245.1238165695368, 3279.2457734721147, 3283.5731354923946, 1074.0333699670282, 1075.8278675411975, 1089.912806975448, 2058.752949646037, 2061.165228082629, 11293.491792869258, 11296.209265351428, 11416.086713063018, 11420.086393088533, 11423.143264255132, 4568.17772800899, 4611.838585649486, 4693.78877950493, 4818.156822556039, 4861.319415281863, 9224.40041397307, 9242.953785231031, 9315.48764817928, 9317.767055823522, 9377.0, 5199.948000520022, 5210.8957820844125, 5242.135047717084, 5245.659032162897, 5257.158854583248, 4158.126793373365, 4720.268358404453, 4757.500462451393, 4822.517748225149, 4852.17513022787, 3713.2387860489075, 3760.2103558253075, 3766.1714422826935, 3814.1608846053823, 3822.2546603412625, 1130.12415378081, 1141.3551343490901, 1162.1400163878668, 1163.9941800290944, 1167.8073117935446, 1476.4758510728536, 1477.3204326010157, 1477.8743806776329, 1502.6919481506266, 1524.26073354423, 8115.837683246302, 8131.2681858633005, 8161.224683655162, 8167.060788009336, 8200.753977380688, 561.3292115921435, 563.4450066684312, 565.1155940952397, 568.5877738639535, 573.9827805165852, 5697.173909783141, 5706.343770466367, 5706.885862282814, 5710.8001219957105, 5748.0, 9727.805443891224, 9941.403515789076, 9963.202943764481, 10059.647912323033, 10082.899171008343, 9701.466419346863, 9755.560999754885, 9772.462514561767, 9867.950660246797, 9956.900430995598, 7902.565358905315, 8006.279434850775, 8072.87890681652, 8130.471519351341, 8134.430589858772, 7533.209013053551, 7551.773446796605, 7622.2758837910305, 7623.771286861403, 7625.6949722010495, 8633.611487483204, 8775.42959707617, 8946.642134314554, 9074.27405807547, 9095.0, 8955.373123881265, 8981.775455613662, 9064.546772661472, 9180.311476639145, 9437.433753974783, 6733.93266067333, 7199.6760145794615, 7233.0597022386755, 7346.11846578414, 7398.778036658909, 7874.488158269694, 7877.094134174414, 7899.881501777363, 7917.802054948673, 7951.681932722627, 7231.963840180765, 7285.23505031964, 7418.517796343221, 7514.774556763306, 7534.095908491016, 7221.638918053971, 7301.890471642823, 7309.415246780139, 7359.227281135403, 7374.446916481393, 7255.818604534928, 7310.6710198040155, 7362.079740032496, 7374.33630973215, 7384.446166537424, 6753.932460675331, 6755.831104222237, 6761.594304341756, 6765.729370825309, 6790.558613690095, 7104.147502299757, 7162.140543134858, 7165.7850264492145, 7174.928250717635, 7179.9641001796745], "unit": "score", "name": "mootools.html", "value": 4738.801415671366}, {"lowerIsBetter": false, "replicates": [341.7351552546776, 346.5269906577519, 348.1800360151842, 350.6073198018219, 351.5307065068134, 5979.880402391949, 5984.790532331369, 6034.939650603493, 6049.909251361233, 6057.969710151454, 5983.2820061592665, 5986.132010858423, 6000.6099603525845, 6000.87998240036, 6007.0, 4492.415985921842, 4574.634029277667, 4643.674942754009, 4661.44062712475, 4710.364100846393, 4649.023705021949, 4673.8831529211875, 4686.0, 4695.624350051988, 4701.200795864711, 4623.42207224097, 4644.790984405709, 4651.046535460223, 4655.324977878206, 4665.0669866026765, 4458.8885277867985, 4548.749818759967, 4649.279361698908, 4656.254999200146, 4675.766211689402, 4112.485939257593, 4113.239050775616, 4114.773687447189, 4125.030617804813, 4125.29869922111, 5711.4579063653, 5717.857053573653, 5725.427457254283, 5726.112452569859, 5741.913871291934, 5442.401335853053, 5450.182472629098, 5451.209574611698, 5455.372632147314, 5463.508284254396, 6361.777337793202, 6364.809055728336, 6382.553221274513, 6387.361263873622, 6393.680315984182, 4302.0, 4409.867703968886, 4415.0, 4416.823327066913, 4593.242115051013, 6425.325340839191, 6481.805545833632, 6593.076969224312, 6594.868102637968, 6603.141591593158, 4566.337881007302, 4571.177188106106, 4581.702189357681, 4582.106489234568, 4582.587567118975, 4626.930596041062, 4635.281531362644, 4637.118947399983, 4639.164950308909, 4639.420072490939, 5334.199870019451, 5341.759620817073, 5346.492083252085, 5346.7861285548925, 5351.224072509464, 6292.339304373067, 6326.6520341381665, 6409.0, 6427.260865000491, 6427.421532062137, 1601.735713607265, 1612.0569466861782, 1623.8619717323922, 1625.9268332925046, 1629.6414788746456, 1024.7847951930178, 1045.4093437207953, 1069.7272195590074, 1073.5437439088357, 1112.67732357617, 6029.517638588903, 6045.21412216409, 6048.334683184846, 6054.66699331541, 6056.0, 6419.422251997343, 6535.477161827042, 6538.313477084933, 6543.574667646588, 6553.934460655428, 6129.049997250433, 6136.417040381246, 6143.416375444325, 6147.170132032208, 6147.969260153671, 3490.458978858281, 3522.5244591980268, 3523.136831476305, 3527.8236088195486, 3529.6646818552194, 6541.247756507967, 6685.6322902240845, 6821.249662537117, 6830.760923367758, 6849.760258391032, 6819.624920629413, 6833.589984600841, 6844.5208835382045, 6845.657717114224, 6847.726090956306, 6788.524803263823, 6799.218089919624, 6800.727970881208, 6805.455563554904, 6808.93191068083, 6636.502262330248, 6642.83392915181, 6651.16860392451, 6651.201855777144, 6657.900131498128, 6350.7777227796805, 6565.409113179837, 6573.1454910861285, 6606.504512161511, 6610.867782644224, 6785.321467853175, 6813.693383797642, 6815.522913396015, 6816.7614133505085, 6834.658267086526, 4586.862394128181, 4620.607248383925, 4626.1210370029585, 4632.3977882875015, 4634.745089020002, 6640.601563906181, 6647.60114393138, 6657.933420665731, 6659.433948114271, 6668.499862510234, 6363.395477429637, 6467.935320646733, 6478.611283323015, 6481.935180648322, 6490.51321150925, 6453.644419786838, 6475.64383958868, 6485.28661847187, 6485.902711459237, 6493.22081350241, 6315.368463153648, 6333.334999824952, 6334.968325158345, 6336.398042185985, 6357.618542887441, 6509.121268628674, 6511.218653761579, 6514.413702766774, 6516.0, 6522.412982831568, 6050.6369617823075, 6120.143179954721, 6198.6280823150755, 6329.335419781041, 6344.746210151542], "unit": "score", "name": "prototype.html", "value": 4839.270107301595}, {"lowerIsBetter": false, "replicates": [773.1804287455298, 789.4947233770391, 805.8952336196297, 848.9278411335036, 855.4140413816536, 14451.060681055736, 14899.0, 16075.356985720571, 16300.673986520262, 16377.344906203767, 15344.923275383635, 15368.0, 15368.846311536881, 15439.0, 15498.225088745574, 758.7496126278315, 929.9023602521705, 939.2814496909853, 959.0649117110831, 969.1132613658494, 963.2582911158404, 965.6041023180497, 967.6081187119192, 968.2641192693568, 968.4818622037211, 1004.3521928356242, 1005.1807776661997, 1006.0291818395248, 1007.0433088565892, 1007.4358359318768, 810.5703976892256, 971.4851128901694, 1000.8498725191243, 1001.409168590535, 1003.8193125237455, 735.6836560279078, 735.7351353512731, 736.3446532586003, 736.6427282767853, 736.8010637127945, 13779.0, 13834.861651383459, 13846.0, 13853.51512697061, 13863.306834658226, 13189.472421103144, 13271.86728132716, 13375.188746721775, 13581.11722738019, 14058.578242652635, 11693.883061169365, 11699.23954942926, 11804.291742495478, 11822.349770762605, 11893.702657433547, 3735.925281494382, 3775.377062784637, 3814.1036856338737, 3822.388417853158, 3822.6750726188307, 53352.0, 53815.46184538144, 53999.46000539984, 54399.99999999961, 54400.45599544033, 10745.677629671123, 10788.51451684676, 10842.566297348018, 10995.890041099487, 11194.720131996764, 19195.232190712217, 19219.80780192208, 19231.51921201981, 19298.22807087729, 19342.32301869428, 8136.877946830802, 8139.79650508742, 8222.876656850152, 8396.034456037634, 8684.261837743863, 4336.176126535948, 4454.309582014793, 4475.888102797391, 4480.977595112004, 4581.381513495702, 3403.0471467989005, 3434.3818112739946, 3449.7757645752945, 3451.4132597458492, 3456.222349971287, 539.387794852837, 581.6626356713097, 603.2007589943343, 604.1783174882157, 610.0239616613383, 562.637099071105, 653.2096163641951, 653.2389765922742, 659.2682122843639, 661.9106420633249, 8754.037055923844, 8797.252233560092, 8802.647894084164, 8898.777530561787, 9129.269658427309, 529.5631104338936, 593.7150167919423, 667.5260564998905, 702.922678505364, 727.7198278662753, 3919.980400097981, 3973.92052158961, 4172.4993000840095, 4241.639460645818, 4248.872533823928, 64114.358856410836, 64965.675171623836, 65221.0, 65356.0, 65516.34483655198, 55574.0, 56744.0, 56926.43073569294, 57010.0, 57598.0, 49575.256371154464, 50479.747601261755, 50855.74572127116, 51233.48766512287, 51236.74381628068, 8473.49159050459, 8640.26557742599, 8640.913590864011, 8755.255803256794, 8793.988691300583, 37134.44298335581, 37673.62326376811, 37978.81010594929, 38624.613753862104, 39131.47457998653, 43895.0, 44342.556574433846, 44931.32603011023, 47396.0, 47666.76166619144, 10171.949140254252, 10379.53292101842, 10602.787944241227, 10629.574817007542, 10648.520816563117, 12070.27578345302, 12171.391430428266, 12294.0, 12317.815232771336, 12580.30808305552, 10840.67477975662, 10866.945665271624, 10975.737790153915, 11259.0, 11486.655400338002, 11203.551857925591, 11260.887391125983, 11283.266587671775, 11337.659870203906, 11437.19939604253, 10898.50956706966, 11563.884361156617, 11775.941120294343, 12009.63971080869, 12205.511779528719, 10175.287729859136, 10565.735856603338, 10981.176411768989, 11295.209335346775, 11402.315861048364, 10278.640247591298, 10322.690319290434, 10360.119389851947, 10380.844287335847, 10397.11624511925], "unit": "score", "name": "yui.html", "value": 6768.36619306492}], "name": "dromaeo_css", "value": 7210.668082245625}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 112.0, 112.0, 114.0, 100.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 137.0, 156.0, 170.0, 129.0, 160.0, 156.0, 128.0, 185.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 160.0, 159.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 76.0, 172.0, 76.0, 77.0, 76.0, 74.0, 166.0, 78.0], "unit": "score", "name": "audio-fft", "value": 95.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 93.0, 94.0, 93.0, 152.0, 94.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 144.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 58.0, 58.0, 58.0, 56.0, 58.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 87.0, 79.0, 78.0, 79.0, 86.0, 79.0, 78.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 112.0, 127.0, 111.0, 113.0, 116.0, 118.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 153.0, 145.0, 154.0, 143.0, 149.0, 149.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 70.0, 68.0, 68.0, 67.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1517.1}]} 16:31:33 INFO - Return code: 0 16:31:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:31:33 INFO - # TBPL SUCCESS # 16:31:33 INFO - Running post-action listener: _resource_record_post_action 16:31:33 INFO - Running post-run listener: _resource_record_post_run 16:31:34 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 310120448; Read time: 0; Write time: 138220 16:31:34 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 93360128; Read time: 0; Write time: 49884 16:31:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 216760320; Read time: 0; Write time: 88336 16:31:34 INFO - Running post-run listener: _upload_blobber_files 16:31:34 INFO - Blob upload gear active. 16:31:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:31:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:31:34 INFO - (blobuploader) - INFO - Open directory for files ... 16:31:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:31:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:31:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:35 INFO - (blobuploader) - INFO - Done attempting. 16:31:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:31:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:36 INFO - (blobuploader) - INFO - Done attempting. 16:31:36 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:36 INFO - Return code: 0 16:31:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d47676fd73afb5fe6fbac791beb13f941387d2e862b820eda091fef34e9017b8f48d97d1dabd4ebdde11f00279b4813637e0d91686c35c02ded9b8691333d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/162d5f2f2283c28a2ca618bdb77340085b04cb126f2c85fe7b12bc8ea980344530eefd23cb088f017c33863042d815e11df1920b20ec4208fb54913cd622307a"} 16:31:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:36 INFO - Contents: 16:31:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d47676fd73afb5fe6fbac791beb13f941387d2e862b820eda091fef34e9017b8f48d97d1dabd4ebdde11f00279b4813637e0d91686c35c02ded9b8691333d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/162d5f2f2283c28a2ca618bdb77340085b04cb126f2c85fe7b12bc8ea980344530eefd23cb088f017c33863042d815e11df1920b20ec4208fb54913cd622307a"} 16:31:36 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:36 INFO - Copying logs to upload dir... 16:31:36 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1321.867857 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-04-29 16:31:35.678933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 16:31:35.682770) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d47676fd73afb5fe6fbac791beb13f941387d2e862b820eda091fef34e9017b8f48d97d1dabd4ebdde11f00279b4813637e0d91686c35c02ded9b8691333d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/162d5f2f2283c28a2ca618bdb77340085b04cb126f2c85fe7b12bc8ea980344530eefd23cb088f017c33863042d815e11df1920b20ec4208fb54913cd622307a"} build_url:https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/ajrRDKIxQHCkxMouEWjLhQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d47676fd73afb5fe6fbac791beb13f941387d2e862b820eda091fef34e9017b8f48d97d1dabd4ebdde11f00279b4813637e0d91686c35c02ded9b8691333d65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/162d5f2f2283c28a2ca618bdb77340085b04cb126f2c85fe7b12bc8ea980344530eefd23cb088f017c33863042d815e11df1920b20ec4208fb54913cd622307a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 16:31:35.707265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:31:35.707581) ========= 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=aa08bb06ff6271ef470a76a4000001be-1461971356.255153-836360236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 16:31:35.791121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 16:31:35.791439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 16:31:35.791733) ========= ========= Total master_lag: 0.20 =========