builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1460767453.38 results: success (0) buildid: 20160415145632 builduid: 12b723d2206b4b58ab423d564e4f6ce9 revision: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.377884) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.378341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.378697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.395318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.395602) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 17:44:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-15 17:44:13 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.350603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.759294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.759642) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018808 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.808808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:13.809171) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 --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-aurora --rev ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 --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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 17:44:13,967 truncating revision to first 12 chars 2016-04-15 17:44:13,967 Setting DEBUG logging. 2016-04-15 17:44:13,967 attempt 1/10 2016-04-15 17:44:13,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce4b3f7285ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 17:44:14,268 unpacking tar archive at: mozilla-aurora-ce4b3f7285ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:14.390885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:14.391212) ========= script_repo_revision: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:14.391625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:14.391901) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 17:44:14.401838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-15 17:44:14.402235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:14 INFO - MultiFileLogger online at 20160415 17:44:14 in /builds/slave/test 17:44:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:44:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:14 INFO - {'append_to_log': False, 17:44:14 INFO - 'base_work_dir': '/builds/slave/test', 17:44:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:44:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:14 INFO - 'branch': 'Mozilla-Aurora', 17:44:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:14 INFO - 'config_files': ('talos/linux_config.py',), 17:44:14 INFO - 'default_actions': ('clobber', 17:44:14 INFO - 'read-buildbot-config', 17:44:14 INFO - 'download-and-extract', 17:44:14 INFO - 'populate-webroot', 17:44:14 INFO - 'create-virtualenv', 17:44:14 INFO - 'install', 17:44:14 INFO - 'run-tests'), 17:44:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:14 INFO - 'download_minidump_stackwalk': True, 17:44:14 INFO - 'download_symbols': 'ondemand', 17:44:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:44:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:44:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:44:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:44:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:14 INFO - 'installer_path': 'installer.exe', 17:44:14 INFO - 'log_level': 'info', 17:44:14 INFO - 'log_name': 'talos', 17:44:14 INFO - 'log_to_console': True, 17:44:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:14 INFO - 'opt_config_files': (), 17:44:14 INFO - 'pip_index': False, 17:44:14 INFO - 'sps_profile': False, 17:44:14 INFO - 'sps_profile_interval': 0, 17:44:14 INFO - 'suite': 'dromaeojs', 17:44:14 INFO - 'system_bits': '32', 17:44:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:14 INFO - 'title': 'talos-linux64-ix-001', 17:44:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:14 INFO - 'use_talos_json': True, 17:44:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:14 INFO - 'work_dir': 'build'} 17:44:14 INFO - ##### 17:44:14 INFO - ##### Running clobber step. 17:44:14 INFO - ##### 17:44:14 INFO - Running pre-action listener: _resource_record_pre_action 17:44:14 INFO - Running main action method: clobber 17:44:14 INFO - rmtree: /builds/slave/test/build 17:44:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:15 INFO - Running post-action listener: _resource_record_post_action 17:44:15 INFO - ##### 17:44:15 INFO - ##### Running read-buildbot-config step. 17:44:15 INFO - ##### 17:44:15 INFO - Running pre-action listener: _resource_record_pre_action 17:44:15 INFO - Running main action method: read_buildbot_config 17:44:15 INFO - Using buildbot properties: 17:44:15 INFO - { 17:44:15 INFO - "project": "", 17:44:15 INFO - "product": "firefox", 17:44:15 INFO - "script_repo_revision": "production", 17:44:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:44:15 INFO - "repository": "", 17:44:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:44:15 INFO - "buildid": "20160415145632", 17:44:15 INFO - "pgo_build": "True", 17:44:15 INFO - "basedir": "/builds/slave/test", 17:44:15 INFO - "buildnumber": 436, 17:44:15 INFO - "slavename": "talos-linux64-ix-001", 17:44:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:44:15 INFO - "platform": "ubuntu64_hw", 17:44:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:44:15 INFO - "branch": "mozilla-aurora", 17:44:15 INFO - "repo_path": "releases/mozilla-aurora", 17:44:15 INFO - "revision": "ce4b3f7285ab1ec78032fd0529bfe47ea8189a92", 17:44:15 INFO - "stage_platform": "linux64-pgo", 17:44:15 INFO - "builduid": "12b723d2206b4b58ab423d564e4f6ce9", 17:44:15 INFO - "slavebuilddir": "test" 17:44:15 INFO - } 17:44:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 17:44:15 INFO - Running post-action listener: _resource_record_post_action 17:44:15 INFO - ##### 17:44:15 INFO - ##### Running download-and-extract step. 17:44:15 INFO - ##### 17:44:15 INFO - Running pre-action listener: _resource_record_pre_action 17:44:15 INFO - Running main action method: download_and_extract 17:44:15 INFO - mkdir: /builds/slave/test/build/tests 17:44:15 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')]} 17:44:15 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:44:18 INFO - Downloaded 1448 bytes. 17:44:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:44:18 INFO - Using the following test package requirements: 17:44:18 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:44:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:44:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'jsshell-linux-x86_64.zip'], 17:44:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:44:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:44:18 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:44:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:44:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:18 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:44:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:44:18 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')]} 17:44:18 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:19 INFO - Downloaded 23352311 bytes. 17:44:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:44:20 INFO - Return code: 0 17:44:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:44:20 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')]} 17:44:20 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:21 INFO - Downloaded 23352311 bytes. 17:44:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:44:23 INFO - Return code: 0 17:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:23 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:44:24 INFO - Downloaded 10845168 bytes. 17:44:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:44:24 INFO - Return code: 0 17:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:24 INFO - https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:44:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:44:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:44:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:44:27 INFO - Downloaded 60573235 bytes. 17:44:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:44:27 INFO - mkdir: /builds/slave/test/properties 17:44:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:27 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:27 INFO - Contents: 17:44:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:44:27 INFO - Running post-action listener: _resource_record_post_action 17:44:27 INFO - Running post-action listener: set_extra_try_arguments 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running populate-webroot step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: populate_webroot 17:44:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:27 INFO - '--tppagecycles', 17:44:27 INFO - '7'], 17:44:27 INFO - 'tests': ['tsvgm']}}, 17:44:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:44:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:44:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'tests': ['damp', 'tps']}, 17:44:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['damp', 'tps']}, 17:44:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:44:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:27 INFO - 'other': {'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'other_l64': {'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'other_nol64': {'tests': ['a11yr', 17:44:27 INFO - 'ts_paint', 17:44:27 INFO - 'tpaint', 17:44:27 INFO - 'sessionrestore', 17:44:27 INFO - 'sessionrestore_no_auto_restore', 17:44:27 INFO - 'tabpaint']}, 17:44:27 INFO - 'svgr': {'tests': ['tsvgx', 17:44:27 INFO - 'tsvgr_opacity', 17:44:27 INFO - 'tart', 17:44:27 INFO - 'tscrollx', 17:44:27 INFO - 'cart']}, 17:44:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['tsvgx', 17:44:27 INFO - 'tsvgr_opacity', 17:44:27 INFO - 'tart', 17:44:27 INFO - 'tscrollx', 17:44:27 INFO - 'cart']}, 17:44:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'tests': ['tp5o']}, 17:44:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'talos_options': ['--e10s'], 17:44:27 INFO - 'tests': ['tp5o']}, 17:44:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'talos_options': ['--xperf_path', 17:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:27 INFO - 'tests': ['tp5n']}, 17:44:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:27 INFO - 'talos_options': ['--e10s', 17:44:27 INFO - '--xperf_path', 17:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:27 INFO - 'tests': ['tp5n']}}, 17:44:27 INFO - 'talos.zip': {'path': '', 17:44:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:27 INFO - Running post-action listener: _resource_record_post_action 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running create-virtualenv step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: create_virtualenv 17:44:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:27 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 17:44:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:28 INFO - Using real prefix '/usr' 17:44:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:30 INFO - Installing pip.................done. 17:44:30 INFO - Return code: 0 17:44:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:30 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')]} 17:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:30 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')]} 17:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:30 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:30 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 17:44:30 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 17:44:30 INFO - Using env: {'DISPLAY': ':0', 17:44:30 INFO - 'HOME': '/home/cltbld', 17:44:30 INFO - 'LANG': 'en_US.UTF-8', 17:44:30 INFO - 'LANGUAGE': 'en_US:en', 17:44:30 INFO - 'LOGNAME': 'cltbld', 17:44:30 INFO - 'MAIL': '/var/mail/cltbld', 17:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:30 INFO - 'MOZ_NO_REMOTE': '1', 17:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:30 INFO - 'NO_EM_RESTART': '1', 17:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:30 INFO - 'PWD': '/builds/slave/test', 17:44:30 INFO - 'SHELL': '/bin/bash', 17:44:30 INFO - 'SHLVL': '1', 17:44:30 INFO - 'TERM': 'linux', 17:44:30 INFO - 'TMOUT': '86400', 17:44:30 INFO - 'USER': 'cltbld', 17:44:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:30 INFO - '_': '/tools/buildbot/bin/python'} 17:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:30 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 17:44:30 INFO - Cleaning up... 17:44:30 INFO - Return code: 0 17:44:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:44:30 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')]} 17:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:30 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')]} 17:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:30 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:30 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 17:44:30 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 17:44:30 INFO - Using env: {'DISPLAY': ':0', 17:44:30 INFO - 'HOME': '/home/cltbld', 17:44:30 INFO - 'LANG': 'en_US.UTF-8', 17:44:30 INFO - 'LANGUAGE': 'en_US:en', 17:44:30 INFO - 'LOGNAME': 'cltbld', 17:44:30 INFO - 'MAIL': '/var/mail/cltbld', 17:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:30 INFO - 'MOZ_NO_REMOTE': '1', 17:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:30 INFO - 'NO_EM_RESTART': '1', 17:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:30 INFO - 'PWD': '/builds/slave/test', 17:44:30 INFO - 'SHELL': '/bin/bash', 17:44:30 INFO - 'SHLVL': '1', 17:44:30 INFO - 'TERM': 'linux', 17:44:30 INFO - 'TMOUT': '86400', 17:44:30 INFO - 'USER': 'cltbld', 17:44:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:30 INFO - '_': '/tools/buildbot/bin/python'} 17:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:30 INFO - Downloading/unpacking psutil>=0.7.1 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:30 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 17:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:32 INFO - Installing collected packages: psutil 17:44:32 INFO - Running setup.py install for psutil 17:44:32 INFO - building 'psutil._psutil_linux' extension 17:44:32 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 17:44:33 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 17:44:33 INFO - building 'psutil._psutil_posix' extension 17:44:33 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 17:44:33 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 17:44:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:33 INFO - Successfully installed psutil 17:44:33 INFO - Cleaning up... 17:44:33 INFO - Return code: 0 17:44:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:44:33 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')]} 17:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:33 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')]} 17:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:33 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:33 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 17:44:33 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 17:44:33 INFO - Using env: {'DISPLAY': ':0', 17:44:33 INFO - 'HOME': '/home/cltbld', 17:44:33 INFO - 'LANG': 'en_US.UTF-8', 17:44:33 INFO - 'LANGUAGE': 'en_US:en', 17:44:33 INFO - 'LOGNAME': 'cltbld', 17:44:33 INFO - 'MAIL': '/var/mail/cltbld', 17:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:33 INFO - 'MOZ_NO_REMOTE': '1', 17:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:33 INFO - 'NO_EM_RESTART': '1', 17:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:33 INFO - 'PWD': '/builds/slave/test', 17:44:33 INFO - 'SHELL': '/bin/bash', 17:44:33 INFO - 'SHLVL': '1', 17:44:33 INFO - 'TERM': 'linux', 17:44:33 INFO - 'TMOUT': '86400', 17:44:33 INFO - 'USER': 'cltbld', 17:44:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:33 INFO - '_': '/tools/buildbot/bin/python'} 17:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:44:35 INFO - Installing collected packages: mozsystemmonitor 17:44:35 INFO - Running setup.py install for mozsystemmonitor 17:44:35 INFO - Successfully installed mozsystemmonitor 17:44:35 INFO - Cleaning up... 17:44:35 INFO - Return code: 0 17:44:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:35 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:35 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 17:44:35 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 17:44:35 INFO - Using env: {'DISPLAY': ':0', 17:44:35 INFO - 'HOME': '/home/cltbld', 17:44:35 INFO - 'LANG': 'en_US.UTF-8', 17:44:35 INFO - 'LANGUAGE': 'en_US:en', 17:44:35 INFO - 'LOGNAME': 'cltbld', 17:44:35 INFO - 'MAIL': '/var/mail/cltbld', 17:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:35 INFO - 'MOZ_NO_REMOTE': '1', 17:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:35 INFO - 'NO_EM_RESTART': '1', 17:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:35 INFO - 'PWD': '/builds/slave/test', 17:44:35 INFO - 'SHELL': '/bin/bash', 17:44:35 INFO - 'SHLVL': '1', 17:44:35 INFO - 'TERM': 'linux', 17:44:35 INFO - 'TMOUT': '86400', 17:44:35 INFO - 'USER': 'cltbld', 17:44:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:35 INFO - '_': '/tools/buildbot/bin/python'} 17:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:35 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:35 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 17:44:35 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 17:44:35 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 17:44:35 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 17:44:35 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 17:44:35 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 17:44:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:37 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 17:44:37 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 17:44:37 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 17:44:37 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 17:44:37 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 17:44:37 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 17:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:38 INFO - Downloading docopt-0.6.1.tar.gz 17:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:38 INFO - Running setup.py install for blobuploader 17:44:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:38 INFO - Running setup.py install for requests 17:44:39 INFO - Running setup.py install for docopt 17:44:39 INFO - Successfully installed blobuploader requests docopt 17:44:39 INFO - Cleaning up... 17:44:39 INFO - Return code: 0 17:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:39 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')]} 17:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 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')]} 17:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:39 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:39 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 17:44:39 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 17:44:39 INFO - Using env: {'DISPLAY': ':0', 17:44:39 INFO - 'HOME': '/home/cltbld', 17:44:39 INFO - 'LANG': 'en_US.UTF-8', 17:44:39 INFO - 'LANGUAGE': 'en_US:en', 17:44:39 INFO - 'LOGNAME': 'cltbld', 17:44:39 INFO - 'MAIL': '/var/mail/cltbld', 17:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:39 INFO - 'MOZ_NO_REMOTE': '1', 17:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:39 INFO - 'NO_EM_RESTART': '1', 17:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:39 INFO - 'PWD': '/builds/slave/test', 17:44:39 INFO - 'SHELL': '/bin/bash', 17:44:39 INFO - 'SHLVL': '1', 17:44:39 INFO - 'TERM': 'linux', 17:44:39 INFO - 'TMOUT': '86400', 17:44:39 INFO - 'USER': 'cltbld', 17:44:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:39 INFO - '_': '/tools/buildbot/bin/python'} 17:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:39 INFO - Running setup.py (path:/tmp/pip-94Serm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:39 INFO - Running setup.py (path:/tmp/pip-2Ra0tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:39 INFO - Running setup.py (path:/tmp/pip-boZ8iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:39 INFO - Running setup.py (path:/tmp/pip-BCaUEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:39 INFO - Running setup.py (path:/tmp/pip-h_qlh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:39 INFO - Running setup.py (path:/tmp/pip-mrMNp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:39 INFO - Running setup.py (path:/tmp/pip-MCqvJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:39 INFO - Running setup.py (path:/tmp/pip-q8NeTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:39 INFO - Running setup.py (path:/tmp/pip-4ldl_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:40 INFO - Running setup.py (path:/tmp/pip-ySRAWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:40 INFO - Running setup.py (path:/tmp/pip-qjHrrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:40 INFO - Running setup.py (path:/tmp/pip-7cyJry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:40 INFO - Running setup.py (path:/tmp/pip-CDSmnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:40 INFO - Running setup.py (path:/tmp/pip-5HSiXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:40 INFO - Running setup.py (path:/tmp/pip-kGpXuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:40 INFO - Running setup.py (path:/tmp/pip-R7UhWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:40 INFO - Running setup.py (path:/tmp/pip-B4qZAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:40 INFO - Running setup.py install for manifestparser 17:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:40 INFO - Running setup.py install for mozcrash 17:44:40 INFO - Running setup.py install for mozdebug 17:44:40 INFO - Running setup.py install for mozdevice 17:44:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozfile 17:44:41 INFO - Running setup.py install for mozhttpd 17:44:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozinfo 17:44:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozInstall 17:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozleak 17:44:41 INFO - Running setup.py install for mozlog 17:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for moznetwork 17:44:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozprocess 17:44:41 INFO - Running setup.py install for mozprofile 17:44:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:41 INFO - Running setup.py install for mozrunner 17:44:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:42 INFO - Running setup.py install for mozscreenshot 17:44:42 INFO - Running setup.py install for moztest 17:44:42 INFO - Running setup.py install for mozversion 17:44:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:42 INFO - Cleaning up... 17:44:42 INFO - Return code: 0 17:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:42 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:42 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 17:44:42 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 17:44:42 INFO - Using env: {'DISPLAY': ':0', 17:44:42 INFO - 'HOME': '/home/cltbld', 17:44:42 INFO - 'LANG': 'en_US.UTF-8', 17:44:42 INFO - 'LANGUAGE': 'en_US:en', 17:44:42 INFO - 'LOGNAME': 'cltbld', 17:44:42 INFO - 'MAIL': '/var/mail/cltbld', 17:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:42 INFO - 'MOZ_NO_REMOTE': '1', 17:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:42 INFO - 'NO_EM_RESTART': '1', 17:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:42 INFO - 'PWD': '/builds/slave/test', 17:44:42 INFO - 'SHELL': '/bin/bash', 17:44:42 INFO - 'SHLVL': '1', 17:44:42 INFO - 'TERM': 'linux', 17:44:42 INFO - 'TMOUT': '86400', 17:44:42 INFO - 'USER': 'cltbld', 17:44:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:42 INFO - '_': '/tools/buildbot/bin/python'} 17:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:42 INFO - Running setup.py (path:/tmp/pip-i_mYNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:42 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)) 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:42 INFO - Running setup.py (path:/tmp/pip-pI_A2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:42 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)) 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:42 INFO - Running setup.py (path:/tmp/pip-uL3ACh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:42 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)) 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:42 INFO - Running setup.py (path:/tmp/pip-fwB3r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:42 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)) 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:42 INFO - Running setup.py (path:/tmp/pip-dtR7xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:42 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)) 17:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:42 INFO - Running setup.py (path:/tmp/pip-OTQGCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:43 INFO - Running setup.py (path:/tmp/pip-lp_HPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:43 INFO - Running setup.py (path:/tmp/pip-ICNu2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:43 INFO - Running setup.py (path:/tmp/pip-RoSSR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:43 INFO - Running setup.py (path:/tmp/pip-kz5BIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:43 INFO - Running setup.py (path:/tmp/pip-wIDQZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:43 INFO - Running setup.py (path:/tmp/pip-uAav98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:43 INFO - Running setup.py (path:/tmp/pip-LKN_S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:43 INFO - Running setup.py (path:/tmp/pip-K5b0qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:43 INFO - Running setup.py (path:/tmp/pip-APBEQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:43 INFO - Running setup.py (path:/tmp/pip-3HOW0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:43 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)) 17:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:43 INFO - Running setup.py (path:/tmp/pip-qSe1Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:43 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)) 17:44:43 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)) 17:44:43 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)) 17:44:43 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)) 17:44:43 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)) 17:44:43 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)) 17:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:45 INFO - Downloading blessings-1.6.tar.gz 17:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:45 INFO - Installing collected packages: blessings 17:44:45 INFO - Running setup.py install for blessings 17:44:45 INFO - Successfully installed blessings 17:44:45 INFO - Cleaning up... 17:44:45 INFO - Return code: 0 17:44:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:46 INFO - Reading from file tmpfile_stdout 17:44:46 INFO - Current package versions: 17:44:46 INFO - argparse == 1.2.1 17:44:46 INFO - blessings == 1.6 17:44:46 INFO - blobuploader == 1.2.4 17:44:46 INFO - docopt == 0.6.1 17:44:46 INFO - manifestparser == 1.1 17:44:46 INFO - mozInstall == 1.12 17:44:46 INFO - mozcrash == 0.17 17:44:46 INFO - mozdebug == 0.1 17:44:46 INFO - mozdevice == 0.48 17:44:46 INFO - mozfile == 1.2 17:44:46 INFO - mozhttpd == 0.7 17:44:46 INFO - mozinfo == 0.9 17:44:46 INFO - mozleak == 0.1 17:44:46 INFO - mozlog == 3.1 17:44:46 INFO - moznetwork == 0.27 17:44:46 INFO - mozprocess == 0.22 17:44:46 INFO - mozprofile == 0.28 17:44:46 INFO - mozrunner == 6.11 17:44:46 INFO - mozscreenshot == 0.1 17:44:46 INFO - mozsystemmonitor == 0.0 17:44:46 INFO - moztest == 0.7 17:44:46 INFO - mozversion == 1.4 17:44:46 INFO - psutil == 3.1.1 17:44:46 INFO - requests == 1.2.3 17:44:46 INFO - wsgiref == 0.1.2 17:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:46 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')]} 17:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:46 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')]} 17:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:46 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:46 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 17:44:46 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 17:44:46 INFO - Using env: {'DISPLAY': ':0', 17:44:46 INFO - 'HOME': '/home/cltbld', 17:44:46 INFO - 'LANG': 'en_US.UTF-8', 17:44:46 INFO - 'LANGUAGE': 'en_US:en', 17:44:46 INFO - 'LOGNAME': 'cltbld', 17:44:46 INFO - 'MAIL': '/var/mail/cltbld', 17:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:46 INFO - 'MOZ_NO_REMOTE': '1', 17:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:46 INFO - 'NO_EM_RESTART': '1', 17:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:46 INFO - 'PWD': '/builds/slave/test', 17:44:46 INFO - 'SHELL': '/bin/bash', 17:44:46 INFO - 'SHLVL': '1', 17:44:46 INFO - 'TERM': 'linux', 17:44:46 INFO - 'TMOUT': '86400', 17:44:46 INFO - 'USER': 'cltbld', 17:44:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:46 INFO - '_': '/tools/buildbot/bin/python'} 17:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 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)) 17:44:46 INFO - Cleaning up... 17:44:46 INFO - Return code: 0 17:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:46 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')]} 17:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:46 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')]} 17:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:46 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:46 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 17:44:46 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 17:44:46 INFO - Using env: {'DISPLAY': ':0', 17:44:46 INFO - 'HOME': '/home/cltbld', 17:44:46 INFO - 'LANG': 'en_US.UTF-8', 17:44:46 INFO - 'LANGUAGE': 'en_US:en', 17:44:46 INFO - 'LOGNAME': 'cltbld', 17:44:46 INFO - 'MAIL': '/var/mail/cltbld', 17:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:46 INFO - 'MOZ_NO_REMOTE': '1', 17:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:46 INFO - 'NO_EM_RESTART': '1', 17:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:46 INFO - 'PWD': '/builds/slave/test', 17:44:46 INFO - 'SHELL': '/bin/bash', 17:44:46 INFO - 'SHLVL': '1', 17:44:46 INFO - 'TERM': 'linux', 17:44:46 INFO - 'TMOUT': '86400', 17:44:46 INFO - 'USER': 'cltbld', 17:44:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:46 INFO - '_': '/tools/buildbot/bin/python'} 17:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:46 INFO - Downloading/unpacking jsonschema 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:44:48 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 17:44:48 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 17:44:48 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 17:44:48 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 17:44:48 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 17:44:48 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 17:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:48 INFO - warning: no files found matching '*.txt' 17:44:48 INFO - no previously-included directories found matching 'build' 17:44:48 INFO - no previously-included directories found matching 'dist' 17:44:48 INFO - no previously-included directories found matching '.git*' 17:44:48 INFO - Installing collected packages: jsonschema, functools32 17:44:48 INFO - Running setup.py install for functools32 17:44:48 INFO - warning: no files found matching '*.txt' 17:44:48 INFO - no previously-included directories found matching 'build' 17:44:48 INFO - no previously-included directories found matching 'dist' 17:44:48 INFO - no previously-included directories found matching '.git*' 17:44:48 INFO - Successfully installed jsonschema functools32 17:44:48 INFO - Cleaning up... 17:44:48 INFO - Return code: 0 17:44:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:44:48 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')]} 17:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:48 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')]} 17:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:48 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 0x7f18aeb04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', '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 17:44:48 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 17:44:48 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 17:44:48 INFO - Using env: {'DISPLAY': ':0', 17:44:48 INFO - 'HOME': '/home/cltbld', 17:44:48 INFO - 'LANG': 'en_US.UTF-8', 17:44:48 INFO - 'LANGUAGE': 'en_US:en', 17:44:48 INFO - 'LOGNAME': 'cltbld', 17:44:48 INFO - 'MAIL': '/var/mail/cltbld', 17:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:48 INFO - 'MOZ_NO_REMOTE': '1', 17:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:48 INFO - 'NO_EM_RESTART': '1', 17:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:48 INFO - 'PWD': '/builds/slave/test', 17:44:48 INFO - 'SHELL': '/bin/bash', 17:44:48 INFO - 'SHLVL': '1', 17:44:48 INFO - 'TERM': 'linux', 17:44:48 INFO - 'TMOUT': '86400', 17:44:48 INFO - 'USER': 'cltbld', 17:44:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:48 INFO - '_': '/tools/buildbot/bin/python'} 17:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:49 INFO - Downloading/unpacking flake8 17:44:49 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 17:44:49 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 17:44:49 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 17:44:49 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 17:44:49 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 17:44:49 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 17:44:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:44:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:44:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:51 INFO - no previously-included directories found matching 'docs/_build' 17:44:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:44:51 INFO - Running setup.py install for pep8 17:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:51 INFO - no previously-included directories found matching 'docs/_build' 17:44:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:44:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:44:51 INFO - Cleaning up... 17:44:51 INFO - Return code: 0 17:44:51 INFO - Running post-action listener: _resource_record_post_action 17:44:51 INFO - Running post-action listener: _start_resource_monitoring 17:44:52 INFO - Starting resource monitoring. 17:44:52 INFO - ##### 17:44:52 INFO - ##### Running install step. 17:44:52 INFO - ##### 17:44:52 INFO - Running pre-action listener: _resource_record_pre_action 17:44:52 INFO - Running main action method: install 17:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:52 INFO - Reading from file tmpfile_stdout 17:44:52 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:52 INFO - Reading from file tmpfile_stdout 17:44:52 INFO - Output received: 17:44:52 INFO - Usage: mozinstall [options] installer 17:44:52 INFO - Options: 17:44:52 INFO - -h, --help show this help message and exit 17:44:52 INFO - -d DEST, --destination=DEST 17:44:52 INFO - Directory to install application into. [default: 17:44:52 INFO - "/builds/slave/test"] 17:44:52 INFO - --app=APP Application being installed. [default: firefox] 17:44:52 INFO - mkdir: /builds/slave/test/build/application 17:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:45:07 INFO - Reading from file tmpfile_stdout 17:45:07 INFO - Output received: 17:45:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:45:07 INFO - Running post-action listener: _resource_record_post_action 17:45:07 INFO - ##### 17:45:07 INFO - ##### Running run-tests step. 17:45:07 INFO - ##### 17:45:07 INFO - Running pre-action listener: _resource_record_pre_action 17:45:07 INFO - Running main action method: run_tests 17:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:45:07 INFO - Python 2.7.3 17:45:07 INFO - Return code: 0 17:45:07 INFO - grabbing minidump binary from tooltool 17:45:07 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')]} 17:45:07 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 0x2afa160>, '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 0x2afb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2afb4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:45:07 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 17:45:07 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 17:45:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:45:07 INFO - Return code: 0 17:45:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:45:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:45:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:45:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:45:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:45:08 INFO - Return code: 0 17:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 17:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 17:45:08 INFO - Using env: {'DISPLAY': ':0', 17:45:08 INFO - 'HOME': '/home/cltbld', 17:45:08 INFO - 'LANG': 'en_US.UTF-8', 17:45:08 INFO - 'LANGUAGE': 'en_US:en', 17:45:08 INFO - 'LOGNAME': 'cltbld', 17:45:08 INFO - 'MAIL': '/var/mail/cltbld', 17:45:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:08 INFO - 'MOZ_NO_REMOTE': '1', 17:45:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:08 INFO - 'NO_EM_RESTART': '1', 17:45:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:08 INFO - 'PWD': '/builds/slave/test', 17:45:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:08 INFO - 'SHELL': '/bin/bash', 17:45:08 INFO - 'SHLVL': '1', 17:45:08 INFO - 'TERM': 'linux', 17:45:08 INFO - 'TMOUT': '86400', 17:45:08 INFO - 'USER': 'cltbld', 17:45:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238', 17:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:08 INFO - '_': '/tools/buildbot/bin/python'} 17:45:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 17:45:08 INFO - mozversion application_buildid: 20160415145632 17:45:08 INFO - mozversion application_changeset: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 17:45:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:45:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:45:08 INFO - mozversion application_name: Firefox 17:45:08 INFO - mozversion application_remotingname: firefox-dev 17:45:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:08 INFO - mozversion application_vendor: Mozilla 17:45:08 INFO - mozversion application_version: 47.0a2 17:45:08 INFO - mozversion platform_buildid: 20160415145632 17:45:08 INFO - mozversion platform_changeset: ce4b3f7285ab1ec78032fd0529bfe47ea8189a92 17:45:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:08 INFO - mozversion platform_version: 47.0a2 17:45:08 INFO - using testdate: 1460767508 17:45:08 INFO - actual date: 1460767508 17:45:08 INFO - starting webserver on 'localhost:42124' 17:45:08 INFO - SUITE-START | Running 2 tests 17:45:08 INFO - TEST-START | dromaeo_css 17:45:08 INFO - operating with platform_type : linux_ 17:45:08 INFO - Initialising browser for dromaeo_css test... 17:45:08 INFO - TEST-INFO | started process 10969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0mZVq/profile http://localhost:42124/getInfo.html) 17:45:13 INFO - PROCESS | 10969 | __metrics Screen width/height:1600/1200 17:45:13 INFO - PROCESS | 10969 | colorDepth:24 17:45:13 INFO - PROCESS | 10969 | Browser inner width/height: 1024/697 17:45:13 INFO - PROCESS | 10969 | __metrics 17:45:14 INFO - PROCESS | 10969 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:15 INFO - TEST-INFO | 10969: exit 0 17:45:15 INFO - Browser initialized. 17:45:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:15 INFO - TEST-INFO | started process 11059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0mZVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:26 INFO - PROCESS | 11059 | RSS: Main: 141713408 17:45:26 INFO - PROCESS | 11059 | 17:46:17 INFO - PROCESS | 11059 | 1460767577761 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] 17:48:25 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42124/tests/dromaeo/cssquery-ext.html) 17:48:26 INFO - PROCESS | 11059 | RSS: Main: 254668800 17:48:26 INFO - PROCESS | 11059 | 17:51:28 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-ext.html (next: http://localhost:42124/tests/dromaeo/cssquery-jquery.html) 17:51:29 INFO - PROCESS | 11059 | RSS: Main: 216391680 17:51:29 INFO - PROCESS | 11059 | 17:54:30 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42124/tests/dromaeo/cssquery-mootools.html) 17:54:31 INFO - PROCESS | 11059 | RSS: Main: 213684224 17:54:31 INFO - PROCESS | 11059 | 17:57:33 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42124/tests/dromaeo/cssquery-prototype.html) 17:57:33 INFO - PROCESS | 11059 | RSS: Main: 189898752 17:57:33 INFO - PROCESS | 11059 | 18:00:36 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42124/tests/dromaeo/cssquery-yui.html) 18:00:37 INFO - PROCESS | 11059 | RSS: Main: 205832192 18:00:37 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | Cycle 1(1): loaded http://localhost:42124/tests/dromaeo/cssquery-yui.html (next: http://localhost:42124/tests/dromaeo/cssquery-dojo.html) 18:03:39 INFO - PROCESS | 11059 | RSS: Main: 252047360 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | __start_tp_report 18:03:39 INFO - PROCESS | 11059 | _x_x_mozilla_page_load 18:03:39 INFO - PROCESS | 11059 | _x_x_mozilla_page_load_details 18:03:39 INFO - PROCESS | 11059 | |i|pagename|runs| 18:03:39 INFO - PROCESS | 11059 | |0;dojo.html;3256.413845507808;3310.536524886518;3324.717399021083;3331.2338162222686;3348.162959260185;5336.332958380202;5338.519533242007;5356.062689029419;5361.678299302044;5393.406725260218;5303.840884773454;5309.203619457084;5344.118220493624;5345.33183352081;5350.8127215547465;4848.321235027099;4905.901881962359;4910.435299940499;4913.926291105637;4958.975205123969;4877.561019508244;4960.156773348539;4961.652684312099;4995.850124496253;5046.82336118236;4987.451380348159;5023.271625614284;5031.11955407804;5038.093143234217;5049.217371307434;4842.007388485352;4964.007198560266;4991.800327986876;5008.023435430075;5018.999999999982;4849.224124140121;4925.482824303468;4960.206366981266;4965.751712414401;4985.651004429691;5281.788728450857;5296.708681022542;5312.256284120226;5316.840494785162;5363.249145119647;5629.127485239795;5696.686682232517;5779.537636989031;5797.623154494944;5799.82600521985;5727.140928860663;5776.913346299809;5778.104393818965;5786.739596718157;5806.274215723035;5347.6256662033675;5368.0605893968395;5372.0330340538685;5386.057439947994;5392.91910621345;5798.768049278066;5822.767089316465;5834.620749651259;5862.267216597926;5956.463918247378;5689.544836413077;5697;5697.145428185722;5700.686462244616;5713.400092990176;5737.196792449061;5771.018926782457;5792.391798861143;5797.797077102281;5801.187833703285;5504.091824848935;5684.914726279109;5756.740946657411;5809.50619197373;5810.738516766755;5771.192033115367;5783.19035335045;5786.71066446676;5790.392008839011;5792.94207057924;4353.434053573015;4368.650507959355;4382.583654552813;4393.319035549495;4397.934030989538;3848.5381754189675;3942.1918506706056;3957.050307926135;3992.2813893499447;4001.579834117434;5420.512153906167;5471.917921231185;5474.972625136928;5475.151351540518;5495.395506494282;5621.606487545832;5795.913061304083;5818.5054270386645;5825.650460972355;5835.503982161564;5330.600204984642;5377.462253774591;5392.973035134799;5420.91868621971;5431.592630552725;4924.8276310328965;4931.13705101613;4932.03825254072;4935.703857768545;4962.875928101754;5838.67887266196;5857.150713146655;5868.383819698955;5871.236739223959;5883.352831188566;5689.800856969986;5709.82870513877;5717.514011309086;5717.656940583578;5746.195532625352;5846.707664616837;5847.883042339045;5865.354810970704;5865.5600829937075;5873.823785286449;5544.556435485071;5629.971850140887;5645.887082258414;5678.488935995781;5766.509846663081;5788.797392091256;5789.913151302818;5790.971045144747;5794.739236734273;5820.592558520862;5607.243022191952;5611.579131565068;5628.521575666115;5632.127020311858;5636.85907852307;5477.917831232455;5652.971735141463;5709.143628455598;5757.309122905278;5806.1000544915605;5433.891322173614;5516.917246241229;5517.420670829666;5522.22688823573;5537.612367134262;5586.916196257141;5598.21624972496;5647.519960803378;5648.322201335866;5655.406182350958;5470.72646367672;5504.559635229252;5511.917321240105;5594.692291923983;5609.27079479665 18:03:39 INFO - PROCESS | 11059 | |1;ext.html;558.6619700963124;566.6571724106918;584.7047241143222;611.4802417944748;627.654789865574;40449.79775101124;41196.38205426913;41238.58761412385;41271;41351.79324103375;44366.33450498237;45131.77434112833;45275.32087018697;45297.54702452975;45334.77332613341;9010.14403631654;9185.678501252458;9193;9218.17036466718;9221.262299016063;8890.110988901091;9061.818763624724;9062;9269.119433653792;9275.257979361635;9225.677101301455;9301;9320.813583728355;9328.11382918625;9328.48693321867;9216.17054465098;9299.72100836976;9307.34848560601;9307.72076837696;9315.301352398563;9243.584038718274;9405.76485587859;9407.29445291606;9412.058794120534;9415.62337506499;44519;44929.101417971455;44976.3253551197;44989.77505112486;45056.54943450556;3772.5284339457567;3906.2187562487616;4102.979485102585;4305.870823875289;4609.078184363141;32387.352252955043;32855.507167392505;33103.6689633103;33247.3350532988;33437.33125337504;3735.1035751419463;3845.6346647068485;3863.092173339263;3864.787436690981;3945.704072194568;284809;285068;285297;286463;288000;65963;66921.66539167272;66923.33076669171;66964.3303566958;66994.66502667456;73472.26527734761;74964;74965;74972.62513687396;74983.62508187424;16539.6692066158;16639.16804159787;16714;16723;16736.079515626512;13835.584932452042;13902.791458128137;13906.304684765924;13920.58238252854;13932.37304321308;22310.10759569599;22597;22601.547969040526;22624.773752262266;23577.88211058968;8218.589070546568;8480.321574274043;8542.974843018877;8544.572771361407;8774.868376974351;1042.9153680172535;1062.0706881478707;1133.4162906103363;1166.6266794625637;1184.9526018959318;28530;28722.13833584996;28994.27514312159;29765.553516697266;29927.700722992926;1134.2570616246371;1158.1082566423806;1167.96496105117;1196.0670676872053;1253.1040306181123;15428.305726242346;15910.76133857993;15995.520134395987;16010.759838602196;16257.349706011628;309452;311567;313215;313442;313748;63110;63572;63754.36245637577;63765.36234637687;63884;1359.6328991172527;1408.5915084625344;1500.6248437890526;1520.3918432627038;1522.5812901451968;29753.702462975092;30375.848120759256;30519.847400762854;30599.847000764854;32066.19834504156;51897.740511297205;52571.21143182779;52670.73664631652;52985.735071324394;53134.4686553145;244767;247516;248177;248343;312522;51196;51570.74214628903;51821;51847.74076129595;52527.47472525226;52957.205641916174;53802.73098634638;53866.461335387714;54186.72906635599;55179;42534.78732606441;42692.786536068365;43529.347059793494;43712.78143609261;44422.3336649944;42857.35713964231;43125;43200.56799432091;43544.782276088416;44661;43355.78322108369;43828.34257486076;44354;44990.77504612456;45245;39003.80498097605;40198;40252.3962140574;40519;40850;29289.974850880117;29739;29918.25204369908;29937.85031074831;29977.550336745404 18:03:39 INFO - PROCESS | 11059 | |2;jquery.html;376.66476835616305;377.0930911158663;377.256804095931;380.90858194033405;382.32519602900885;17716.73424898626;18231.179596918137;19092.713609295835;19114.522136946583;19122.71315930262;16800.915995420004;17559.561010974732;17855.821441785578;17979.460616181535;17996.55008624782;5452.59105567082;5567.693776842272;5579.246801681782;5607.691576963265;5609.719514024303;4163.3130533461945;5503.6147469677135;5909.527237820964;6150.907736383958;6178.196834411543;6076.39236076391;6096.939030609704;6108.908366374486;6115.602485838406;6116.96941515294;5828.708564571775;5999.820005399802;6023.608465449775;6027.789027384064;6036.969815150918;3756.3614185588244;5142.202958541432;5303.310569625924;5363.061464243741;5370.677759334413;20716.274930377516;20748.688769668468;20825.68761468579;22460;22506.32481025572;2397.113068164773;2426.5632186206476;2432.3311089450367;2480.404702871298;2494.4761600064007;13473.932630336785;13585.660358491117;13696.383662735201;13929.442822287096;14081.155130692192;1893.1480833624923;1978.5251539630528;2015.8084981926693;2117.4071260047212;2136.2096024471043;60507.69746151285;62492.37507624911;62622.68688656573;63182.68408657928;63960.68019659872;10306;10356.637517686995;10425.947870260752;10443;10447.320924139907;14742.926285368505;14750;14826.258687065603;14842.960992730405;14848.925755371154;7505.62471876404;7735.381169506426;7750.883736743954;7788.104367997753;7859.449838511364;7194.820129496805;7262.600556969312;7275.0542429484885;7661.272179142972;7940;4361.520232774392;4546.045330480636;4595.701279416827;4600.240960241523;4727.976360118178;1776.2948533736976;1898.9525261868287;1910.8566857485744;1915.396650055228;1930.1700268884515;989.7773001074845;1023.3603997501561;1047.6280920273346;1066.706655669697;1124.8425220469142;17317.48047558575;17504.5623859402;17595.384161554284;17648.294068237126;17787.644247114986;982.9066238707311;1008.6419321141036;1020.78563501664;1030.6701855406197;1034.75165960169;10137.746556336151;10166.694999150037;10185.388876667275;10206.744831379276;10244.977830620901;457789;459044;461536;464226;470921;80294.598527007;81780.59109704533;81996.18003820005;82262.58868705618;82832;975.4050029482011;1001.4241810958582;1016.4968340671268;1115.760111576015;1133.9433028348549;15319.693606128038;15323.923380383027;15329.310181041657;15408.537743867702;15416.383344666536;31961.840190798895;32460.51309230316;33823.66176338205;34018.14954626154;34678.479822802175;47786.522134778206;49580.75209624073;52362.73818630882;52838.73580632072;52881.47118528919;8253.257206851413;8387;8418.915810841812;8467.068622451403;8519;9722.319437639297;10969.890301096886;12811;12917.418716157608;13170.143940643828;10978.890211097787;11277.492512837107;11323.263987840764;11361.715957101138;11438.42807859587;10857.945710271399;10968.451577420938;10973.286736362112;11027.61403350879;11124.666260012213;10932.94533527359;11547.249428787101;11563.421828908353;11565.421728913352;11999;8231.753047408587;8300.501969881827;8503.149685031447;8572.871406928776;8577.95711021441;10713.89286107129;11691.356975366096;11715.648530544097;11835.940820295844;11932.821007685065 18:03:39 INFO - PROCESS | 11059 | |3;mootools.html;1361.2445092973396;1585.714571377152;1589.2848218301763;1836.0819590204896;1944.9708254376178;8317.085120636733;8532.786680332994;8534.103919088491;8540.35947303953;8545.102764209754;8381.664733410671;8557.058723540405;8559.48643081414;8563.65745370186;8564.3148548116;2103.968440473394;2398.59223931932;2416.1543459789063;2442.65802787609;2468.0374653885;2362.3857796972825;2378.3816207785926;2383.7020372453444;2388.4028992751814;2392.7487613800477;2286.9542609147807;2327.755585663498;2341.730700969385;2341.800946919514;2342.3324352559525;2387.3912152401113;2404.350825277174;2438.305083051322;2440.0727723465147;2463.531928933515;2402.4114092047384;2428.174420696954;2428.210831479776;2491.8504889706674;2493.376655836041;8639.52482613456;8701.390902636818;8711.564421778885;8721.563921803885;8733.956330218309;5152.536271735525;5303.098473259516;5304.9655317213155;5312.495312945264;5313.07021271276;3068.2329417645587;3162.2884850908363;3175.4601717708047;3256.7394608431505;3298.09302441828;965.6089283839985;976.7899901521207;983.4050399508266;984.1782111936542;993.4138858073699;12358.258504489759;12362.44369003388;12369.319687417188;12409;12412.069094817834;4616.376789133491;4757;4795.544423279783;4799.232122860326;4816.783244753994;9652.372595781251;9683.612655493842;9696.17582505495;9715.659951901649;9718.562664680107;4687.460941991646;5286.259923610698;5293.682379057269;5307.283516725192;5311.681299122065;4720.291956206596;4791.161546729378;4795.496472870368;4802.255650374198;4810.4467986182035;3629.8003609801185;3691.2986532559266;3718.888433347004;3734.4958430612064;3752.1745216052423;1070.2133931560452;1091.2252300866314;1101.9889801102047;1104.4201794058183;1110.5890820396505;1459.6204986703533;1482.8813694904597;1496.678214183934;1516.5753588995099;1537.34662768323;8397.286230670461;8443.155684431631;8493.617787199591;8496.53269070207;8503.872441913376;495.38324785642106;504.3393154967005;507.1505228741916;508.509288536564;509.89292248627464;6342.23893132827;6352.36476352361;6356.459700925473;6402.967985160044;6420.871582568322;10567.735806604742;10898.618548350929;10914.617988370368;11060.778784424267;11075.224734268684;10470.685879423629;10823.783524329468;10897.509612067475;10906.236563440641;10981.83527247076;8356.832863342699;8420.4947703138;8466.365022623328;8467.026291976501;8505.277051450572;8063.113057563781;8080.959595201986;8093;8102.351811855156;8180.631871565913;9500.762480938032;9643.614255429704;9669;9725.319227653996;9736.123748862636;9784.119429251401;9870.062344077302;9972.700818975442;9993.550290236812;10158.441285729356;6340.207474065742;6956.478264130109;7177.641117944187;7302.890456643261;7377.594232317274;8299;8327.50034997902;8363.581820909052;8384.161583841567;8384.41309108381;7158.606276654834;7337.0828646419195;7491.3632341251605;7532.811679708051;7639.57982310956;7266.491345605757;7339;7399.667014984231;7438.256174382518;7488.138864030706;7304.379127774198;7317.487775855639;7337.1929087799235;7346.375558077623;7353.70585176587;7046.295370462913;7079.044329015723;7164.749233776793;7205.747798827016;7217.530860494051;7201;7266.96366518164;7293.635318233961;7349.154847192642;7370.299821516947 18:03:39 INFO - PROCESS | 11059 | |4;prototype.html;346.4785497825772;347.9060653623522;349.67130896956843;355.38873138202285;355.9483874838148;5987.880242395155;5990.101484777286;5998.0702991036405;6009.699515024253;6023.518118550516;5956.791512297071;5959.195508606337;5962;5962.940370596293;5966.5823392362445;4474.507804141542;4510.052888893337;4631.39791827062;4637.65217608679;4692.483826779052;4659.301104834285;4670.953290467103;4682.367880336145;4684.414448193976;4691.695039822418;4607.7004994675235;4619.561141691551;4637.976810115962;4644.558766917137;4656.092062047902;4436.800343984529;4506.864794056167;4625.606823420013;4637.513061128567;4645.047765208158;4087.9182416351805;4100.753954762724;4103.651189648884;4107.835686572534;4113.321301985169;5708.4291570843;5784.219130417382;5791.855203619901;5795.478406943354;5801.883962320772;5383.192521121863;5390.245365648812;5391.137418013138;5392.487713667196;5401.378841433247;6319.3680631936895;6323.114763933053;6326.367363263636;6326.620402775849;6332.461740752042;4162.188373267214;4342.348647702838;4379.693421460467;4389;4539.4098767160385;6526.836829079263;6559.6064236145985;6569.244536878273;6579.572327798678;6582.959282622354;4519.231730605805;4525.411696479437;4529.8641040768825;4529.932051019237;4537.682362234678;4574.725516469022;4590.104929538707;4598.632109431237;4606.631469482433;4606.815727370935;5302.2311764793885;5321.175217841241;5322.866928326823;5329.067413202752;5329.680219186861;6126.846828829315;6321.273053598895;6357.459615932605;6439.484841212786;6442.6778661066755;1592.235726851118;1595.4814685227348;1601.2554162314348;1603.8235794062643;1609.7182992976182;996.4220751963844;1052.9578816847393;1064.2071656615872;1072.785442911421;1083.4799296337644;6011.909821352683;6017;6019.398060194033;6024.1265016573225;6090.086487026982;6476.125723027425;6523.967380163163;6531.869362612816;6545.345465453416;6553.672316384162;6068.787592434243;6070.0591408331775;6074.271087469444;6082.847928801727;6084.452399284086;3491.284286721216;3530.435130379178;3531.858725650945;3531.876384326536;3540.097275194809;6687.063811066455;6746.628935408599;6763.222229443579;6854.725810967605;6856.965715171392;6668.099806526056;6685.966570167216;6782.084418603426;6810.182778066664;6876.793696189123;6828.385445309946;6844.21291551468;6847.281035491302;6911.101556797584;6931;6556.672166391566;6604.669766511559;6609.272979972296;6621.5364924454825;6622.900656490253;6266;6522.902156467562;6526.608403495806;6538.607683539003;6550.83622909412;6832.248452670302;6874.4844136690945;6904.067950826775;6915.308469153045;6918.10064691607;4661.254199328091;4726.26742854858;4742.66801323904;4746.833860814855;4747.2879068140055;6587.703553340207;6604.405603495708;6604.669766511752;6608.273089960197;6611.07444957716;6256.06159076124;6346.873062538631;6349.936500635119;6402.647854368054;6420.6468644225015;6384.680765961776;6390.712417941111;6406.775762848278;6411.743530258924;6424.839379015562;6274.968625156845;6278.089676996901;6282.623042617458;6285.2457705075685;6285.96857015712;6409.903851442139;6416.550841441054;6427.775027874189;6433.324500927522;6444.8388790280615;6058.12157237207;6128;6277.74889004453;6293.527985401205;6296.842578935563 18:03:39 INFO - PROCESS | 11059 | |5;yui.html;688.2566827825948;779.9961000194999;787.1380837982409;796.1799346672929;797.1868693932189;12940.35298235088;13047.869521304785;13048.086633935629;13080.084394092417;13082.411291491882;12306.200096993689;12309.38453077347;12311.815322770166;12313;12320.938395308034;736.9963150184242;917.6191880369655;925.546482223709;946.7869729310885;947.1901524196816;934.3319526538523;935.6818681648239;936.1901954809109;940.3699521320732;940.7507010642151;984.0405604535592;989.159214667534;991.0931497679614;991.8760154980628;992.2558081438921;783.8079670480712;968.3173362779258;984.4388698441891;984.9704508864745;985.0740304114146;719.4747834081098;724.90213821134;725.1696807155777;725.8004048886546;726.9563826170447;11872.168948173632;11881.762364752656;11916.225445346025;11925.105617078667;11930.642080737505;13034.283114428703;13341.39963701626;13417.66455838602;13438.932805336008;14083;10004.749881252954;10454.111400530965;10531.94734026325;10696.465176741209;10769.299995500267;3720.5535335759882;3874.6512813846607;3889.1638297765835;3908.394198899175;3976.980115099435;50845.74577127128;51539.48460515384;51569.74215128938;51785.22322165208;51871.221931671054;9944.602215911282;10223.335483193569;10264.692059238234;10331.793364132674;10515.26393152472;17858.374956876447;18015.819841801414;18019;18055.819441805415;18056.18747156381;6762.154730658668;6914.585124892523;6919.065926100013;6957.130358705162;6997.545159564612;4251.87244382669;4254.255505286625;4264.040590867092;4328.805203765838;4360.193364227564;3142.7328677062706;3154.495280755068;3176.7617428692943;3185.569948057029;3221.0014895382506;584.4885724990634;587.5329113354893;625.9405356491126;629.6599836088461;633.8415396150963;483.12795404294883;599.8980173370537;604.6613896218132;605.8212827215982;642.1812189458478;8309.916900830915;8369.698114332903;8457.619407126695;8516.1058088901;8635.654573817103;527.7704198673589;579.3250862744856;608.5253502268238;639.67376637915;678.2098854834162;3953.2686453006286;4031.717779755389;4070.4911886014247;4116.279651061052;4126.7523948563185;56347.71826140843;56612;56721.71639141778;56950;57138.7143064282;51220.48779512232;52603.73698131561;53165.468345316825;53672.194917076275;53781.73109134429;46962.76518617385;47717.761411192725;47984.760076199396;48039.87740796907;48645.51354486481;7676.923230767621;8059.427094979053;8118.2693557580105;8177.836443271221;8179.63191656365;35725.64274357223;36597.45103823498;36679.81660091683;36862.8156859214;37031.444528332635;41892.371614425196;42002.78998604987;45509;45766.08467830558;46719.532804671515;9785.902140978498;9845;9853.359531630707;9855.556499957376;9891.505424728879;10768.246222764332;10804.24370294072;10857.13142948578;11019.724506887393;11272.718182045515;10757.784844303227;10814.188935830001;10852.45737713127;10908.945455272673;11031.889681103086;10821.67534973952;11394.601188958346;11563.364014979257;11771.411429428666;11937.224080434744;10574.735631609272;10757.515911784145;11106.111511078932;11273.436328183721;11673.12451566119;9123.49820759838;9147.679831205876;9324.580393882427;9354.345195836226;9409.811803763749;9945.850812237677;10139.290249682452;10182.592696292066;10205.591776328863;10227.386356818615 18:03:39 INFO - PROCESS | 11059 | __end_tp_report 18:03:39 INFO - PROCESS | 11059 | __start_cc_report 18:03:39 INFO - PROCESS | 11059 | _x_x_mozilla_cycle_collect,931 18:03:39 INFO - PROCESS | 11059 | __end_cc_report 18:03:39 INFO - PROCESS | 11059 | __startTimestamp1460768619581__endTimestamp 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | ------- Summary: start ------- 18:03:39 INFO - PROCESS | 11059 | Number of tests: 6 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#0] dojo.html Cycles:165 Average:5351.80 Median:5517.42 stddev:572.42 (10.4%) stddev-sans-first:550.06 18:03:39 INFO - PROCESS | 11059 | Values: 3256.4 3310.5 3324.7 3331.2 3348.2 5336.3 5338.5 5356.1 5361.7 5393.4 5303.8 5309.2 5344.1 5345.3 5350.8 4848.3 4905.9 4910.4 4913.9 4959.0 4877.6 4960.2 4961.7 4995.9 5046.8 4987.5 5023.3 5031.1 5038.1 5049.2 4842.0 4964.0 4991.8 5008.0 5019.0 4849.2 4925.5 4960.2 4965.8 4985.7 5281.8 5296.7 5312.3 5316.8 5363.2 5629.1 5696.7 5779.5 5797.6 5799.8 5727.1 5776.9 5778.1 5786.7 5806.3 5347.6 5368.1 5372.0 5386.1 5392.9 5798.8 5822.8 5834.6 5862.3 5956.5 5689.5 5697.0 5697.1 5700.7 5713.4 5737.2 5771.0 5792.4 5797.8 5801.2 5504.1 5684.9 5756.7 5809.5 5810.7 5771.2 5783.2 5786.7 5790.4 5792.9 4353.4 4368.7 4382.6 4393.3 4397.9 3848.5 3942.2 3957.1 3992.3 4001.6 5420.5 5471.9 5475.0 5475.2 5495.4 5621.6 5795.9 5818.5 5825.7 5835.5 5330.6 5377.5 5393.0 5420.9 5431.6 4924.8 4931.1 4932.0 4935.7 4962.9 5838.7 5857.2 5868.4 5871.2 5883.4 5689.8 5709.8 5717.5 5717.7 5746.2 5846.7 5847.9 5865.4 5865.6 5873.8 5544.6 5630.0 5645.9 5678.5 5766.5 5788.8 5789.9 5791.0 5794.7 5820.6 5607.2 5611.6 5628.5 5632.1 5636.9 5477.9 5653.0 5709.1 5757.3 5806.1 5433.9 5516.9 5517.4 5522.2 5537.6 5586.9 5598.2 5647.5 5648.3 5655.4 5470.7 5504.6 5511.9 5594.7 5609.3 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#1] ext.html Cycles:180 Average:49538.22 Median:23581.61 stddev:74827.27 (317.3%) stddev-sans-first:74946.80 18:03:39 INFO - PROCESS | 11059 | Values: 558.7 566.7 584.7 611.5 627.7 40449.8 41196.4 41238.6 41271.0 41351.8 44366.3 45131.8 45275.3 45297.5 45334.8 9010.1 9185.7 9193.0 9218.2 9221.3 8890.1 9061.8 9062.0 9269.1 9275.3 9225.7 9301.0 9320.8 9328.1 9328.5 9216.2 9299.7 9307.3 9307.7 9315.3 9243.6 9405.8 9407.3 9412.1 9415.6 44519.0 44929.1 44976.3 44989.8 45056.5 3772.5 3906.2 4103.0 4305.9 4609.1 32387.4 32855.5 33103.7 33247.3 33437.3 3735.1 3845.6 3863.1 3864.8 3945.7 284809.0 285068.0 285297.0 286463.0 288000.0 65963.0 66921.7 66923.3 66964.3 66994.7 73472.3 74964.0 74965.0 74972.6 74983.6 16539.7 16639.2 16714.0 16723.0 16736.1 13835.6 13902.8 13906.3 13920.6 13932.4 22310.1 22597.0 22601.5 22624.8 23577.9 8218.6 8480.3 8543.0 8544.6 8774.9 1042.9 1062.1 1133.4 1166.6 1185.0 28530.0 28722.1 28994.3 29765.6 29927.7 1134.3 1158.1 1168.0 1196.1 1253.1 15428.3 15910.8 15995.5 16010.8 16257.3 309452.0 311567.0 313215.0 313442.0 313748.0 63110.0 63572.0 63754.4 63765.4 63884.0 1359.6 1408.6 1500.6 1520.4 1522.6 29753.7 30375.8 30519.8 30599.8 32066.2 51897.7 52571.2 52670.7 52985.7 53134.5 244767.0 247516.0 248177.0 248343.0 312522.0 51196.0 51570.7 51821.0 51847.7 52527.5 52957.2 53802.7 53866.5 54186.7 55179.0 42534.8 42692.8 43529.3 43712.8 44422.3 42857.4 43125.0 43200.6 43544.8 44661.0 43355.8 43828.3 44354.0 44990.8 45245.0 39003.8 40198.0 40252.4 40519.0 40850.0 29290.0 29739.0 29918.3 29937.9 29977.6 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#2] jquery.html Cycles:180 Average:26759.64 Median:12451.72 stddev:75871.06 (609.3%) stddev-sans-first:76058.04 18:03:39 INFO - PROCESS | 11059 | Values: 376.7 377.1 377.3 380.9 382.3 17716.7 18231.2 19092.7 19114.5 19122.7 16800.9 17559.6 17855.8 17979.5 17996.6 5452.6 5567.7 5579.2 5607.7 5609.7 4163.3 5503.6 5909.5 6150.9 6178.2 6076.4 6096.9 6108.9 6115.6 6117.0 5828.7 5999.8 6023.6 6027.8 6037.0 3756.4 5142.2 5303.3 5363.1 5370.7 20716.3 20748.7 20825.7 22460.0 22506.3 2397.1 2426.6 2432.3 2480.4 2494.5 13473.9 13585.7 13696.4 13929.4 14081.2 1893.1 1978.5 2015.8 2117.4 2136.2 60507.7 62492.4 62622.7 63182.7 63960.7 10306.0 10356.6 10425.9 10443.0 10447.3 14742.9 14750.0 14826.3 14843.0 14848.9 7505.6 7735.4 7750.9 7788.1 7859.4 7194.8 7262.6 7275.1 7661.3 7940.0 4361.5 4546.0 4595.7 4600.2 4728.0 1776.3 1899.0 1910.9 1915.4 1930.2 989.8 1023.4 1047.6 1066.7 1124.8 17317.5 17504.6 17595.4 17648.3 17787.6 982.9 1008.6 1020.8 1030.7 1034.8 10137.7 10166.7 10185.4 10206.7 10245.0 457789.0 459044.0 461536.0 464226.0 470921.0 80294.6 81780.6 81996.2 82262.6 82832.0 975.4 1001.4 1016.5 1115.8 1133.9 15319.7 15323.9 15329.3 15408.5 15416.4 31961.8 32460.5 33823.7 34018.1 34678.5 47786.5 49580.8 52362.7 52838.7 52881.5 8253.3 8387.0 8418.9 8467.1 8519.0 9722.3 10969.9 12811.0 12917.4 13170.1 10978.9 11277.5 11323.3 11361.7 11438.4 10857.9 10968.5 10973.3 11027.6 11124.7 10932.9 11547.2 11563.4 11565.4 11999.0 8231.8 8300.5 8503.1 8572.9 8578.0 10713.9 11691.4 11715.6 11835.9 11932.8 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#3] mootools.html Cycles:180 Average:6029.84 Median:5826.64 stddev:3274.71 (56.2%) stddev-sans-first:3265.10 18:03:39 INFO - PROCESS | 11059 | Values: 1361.2 1585.7 1589.3 1836.1 1945.0 8317.1 8532.8 8534.1 8540.4 8545.1 8381.7 8557.1 8559.5 8563.7 8564.3 2104.0 2398.6 2416.2 2442.7 2468.0 2362.4 2378.4 2383.7 2388.4 2392.7 2287.0 2327.8 2341.7 2341.8 2342.3 2387.4 2404.4 2438.3 2440.1 2463.5 2402.4 2428.2 2428.2 2491.9 2493.4 8639.5 8701.4 8711.6 8721.6 8734.0 5152.5 5303.1 5305.0 5312.5 5313.1 3068.2 3162.3 3175.5 3256.7 3298.1 965.6 976.8 983.4 984.2 993.4 12358.3 12362.4 12369.3 12409.0 12412.1 4616.4 4757.0 4795.5 4799.2 4816.8 9652.4 9683.6 9696.2 9715.7 9718.6 4687.5 5286.3 5293.7 5307.3 5311.7 4720.3 4791.2 4795.5 4802.3 4810.4 3629.8 3691.3 3718.9 3734.5 3752.2 1070.2 1091.2 1102.0 1104.4 1110.6 1459.6 1482.9 1496.7 1516.6 1537.3 8397.3 8443.2 8493.6 8496.5 8503.9 495.4 504.3 507.2 508.5 509.9 6342.2 6352.4 6356.5 6403.0 6420.9 10567.7 10898.6 10914.6 11060.8 11075.2 10470.7 10823.8 10897.5 10906.2 10981.8 8356.8 8420.5 8466.4 8467.0 8505.3 8063.1 8081.0 8093.0 8102.4 8180.6 9500.8 9643.6 9669.0 9725.3 9736.1 9784.1 9870.1 9972.7 9993.6 10158.4 6340.2 6956.5 7177.6 7302.9 7377.6 8299.0 8327.5 8363.6 8384.2 8384.4 7158.6 7337.1 7491.4 7532.8 7639.6 7266.5 7339.0 7399.7 7438.3 7488.1 7304.4 7317.5 7337.2 7346.4 7353.7 7046.3 7079.0 7164.7 7205.7 7217.5 7201.0 7267.0 7293.6 7349.2 7370.3 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#4] prototype.html Cycles:180 Average:5341.71 Median:6021.46 stddev:1603.43 (26.6%) stddev-sans-first:1563.48 18:03:39 INFO - PROCESS | 11059 | Values: 346.5 347.9 349.7 355.4 355.9 5987.9 5990.1 5998.1 6009.7 6023.5 5956.8 5959.2 5962.0 5962.9 5966.6 4474.5 4510.1 4631.4 4637.7 4692.5 4659.3 4671.0 4682.4 4684.4 4691.7 4607.7 4619.6 4638.0 4644.6 4656.1 4436.8 4506.9 4625.6 4637.5 4645.0 4087.9 4100.8 4103.7 4107.8 4113.3 5708.4 5784.2 5791.9 5795.5 5801.9 5383.2 5390.2 5391.1 5392.5 5401.4 6319.4 6323.1 6326.4 6326.6 6332.5 4162.2 4342.3 4379.7 4389.0 4539.4 6526.8 6559.6 6569.2 6579.6 6583.0 4519.2 4525.4 4529.9 4529.9 4537.7 4574.7 4590.1 4598.6 4606.6 4606.8 5302.2 5321.2 5322.9 5329.1 5329.7 6126.8 6321.3 6357.5 6439.5 6442.7 1592.2 1595.5 1601.3 1603.8 1609.7 996.4 1053.0 1064.2 1072.8 1083.5 6011.9 6017.0 6019.4 6024.1 6090.1 6476.1 6524.0 6531.9 6545.3 6553.7 6068.8 6070.1 6074.3 6082.8 6084.5 3491.3 3530.4 3531.9 3531.9 3540.1 6687.1 6746.6 6763.2 6854.7 6857.0 6668.1 6686.0 6782.1 6810.2 6876.8 6828.4 6844.2 6847.3 6911.1 6931.0 6556.7 6604.7 6609.3 6621.5 6622.9 6266.0 6522.9 6526.6 6538.6 6550.8 6832.2 6874.5 6904.1 6915.3 6918.1 4661.3 4726.3 4742.7 4746.8 4747.3 6587.7 6604.4 6604.7 6608.3 6611.1 6256.1 6346.9 6349.9 6402.6 6420.6 6384.7 6390.7 6406.8 6411.7 6424.8 6275.0 6278.1 6282.6 6285.2 6286.0 6409.9 6416.6 6427.8 6433.3 6444.8 6058.1 6128.0 6277.7 6293.5 6296.8 18:03:39 INFO - PROCESS | 11059 | 18:03:39 INFO - PROCESS | 11059 | [#5] yui.html Cycles:180 Average:13860.75 Median:48012.32 stddev:16353.35 (34.1%) stddev-sans-first:16369.31 18:03:39 INFO - PROCESS | 11059 | Values: 688.3 780.0 787.1 796.2 797.2 12940.4 13047.9 13048.1 13080.1 13082.4 12306.2 12309.4 12311.8 12313.0 12320.9 737.0 917.6 925.5 946.8 947.2 934.3 935.7 936.2 940.4 940.8 984.0 989.2 991.1 991.9 992.3 783.8 968.3 984.4 985.0 985.1 719.5 724.9 725.2 725.8 727.0 11872.2 11881.8 11916.2 11925.1 11930.6 13034.3 13341.4 13417.7 13438.9 14083.0 10004.7 10454.1 10531.9 10696.5 10769.3 3720.6 3874.7 3889.2 3908.4 3977.0 50845.7 51539.5 51569.7 51785.2 51871.2 9944.6 10223.3 10264.7 10331.8 10515.3 17858.4 18015.8 18019.0 18055.8 18056.2 6762.2 6914.6 6919.1 6957.1 6997.5 4251.9 4254.3 4264.0 4328.8 4360.2 3142.7 3154.5 3176.8 3185.6 3221.0 584.5 587.5 625.9 629.7 633.8 483.1 599.9 604.7 605.8 642.2 8309.9 8369.7 8457.6 8516.1 8635.7 527.8 579.3 608.5 639.7 678.2 3953.3 4031.7 4070.5 4116.3 4126.8 56347.7 56612.0 56721.7 56950.0 57138.7 51220.5 52603.7 53165.5 53672.2 53781.7 46962.8 47717.8 47984.8 48039.9 48645.5 7676.9 8059.4 8118.3 8177.8 8179.6 35725.6 36597.5 36679.8 36862.8 37031.4 41892.4 42002.8 45509.0 45766.1 46719.5 9785.9 9845.0 9853.4 9855.6 9891.5 10768.2 10804.2 10857.1 11019.7 11272.7 10757.8 10814.2 10852.5 10908.9 11031.9 10821.7 11394.6 11563.4 11771.4 11937.2 10574.7 10757.5 11106.1 11273.4 11673.1 9123.5 9147.7 9324.6 9354.3 9409.8 9945.9 10139.3 10182.6 10205.6 10227.4 18:03:39 INFO - PROCESS | 11059 | -------- Summary: end -------- 18:03:39 INFO - PROCESS | 11059 | 18:03:40 INFO - TEST-INFO | 11059: exit 0 18:03:40 INFO - TEST-OK | dromaeo_css | took 1111536ms 18:03:40 INFO - TEST-START | kraken 18:03:40 INFO - operating with platform_type : linux_ 18:03:40 INFO - Initialising browser for kraken test... 18:03:40 INFO - TEST-INFO | started process 11252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9R0Qk/profile http://localhost:42124/getInfo.html) 18:03:44 INFO - PROCESS | 11252 | __metrics Screen width/height:1600/1200 18:03:44 INFO - PROCESS | 11252 | colorDepth:24 18:03:44 INFO - PROCESS | 11252 | Browser inner width/height: 1024/697 18:03:44 INFO - PROCESS | 11252 | __metrics 18:03:45 INFO - PROCESS | 11252 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:46 INFO - TEST-INFO | 11252: exit 0 18:03:46 INFO - Browser initialized. 18:03:46 INFO - Running cycle 1/1 for kraken test... 18:03:46 INFO - TEST-INFO | started process 11340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9R0Qk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:58 INFO - PROCESS | 11340 | RSS: Main: 141832192 18:03:58 INFO - PROCESS | 11340 | 18:04:00 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42124/tests/kraken/driver.html?testName=audio-beat-detection) 18:04:01 INFO - PROCESS | 11340 | RSS: Main: 177426432 18:04:01 INFO - PROCESS | 11340 | 18:04:03 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42124/tests/kraken/driver.html?testName=audio-dft) 18:04:04 INFO - PROCESS | 11340 | RSS: Main: 175616000 18:04:04 INFO - PROCESS | 11340 | 18:04:07 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42124/tests/kraken/driver.html?testName=audio-fft) 18:04:07 INFO - PROCESS | 11340 | RSS: Main: 174637056 18:04:07 INFO - PROCESS | 11340 | 18:04:09 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42124/tests/kraken/driver.html?testName=audio-oscillator) 18:04:10 INFO - PROCESS | 11340 | RSS: Main: 174936064 18:04:10 INFO - PROCESS | 11340 | 18:04:12 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42124/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:13 INFO - PROCESS | 11340 | RSS: Main: 172122112 18:04:13 INFO - PROCESS | 11340 | 18:04:16 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42124/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:16 INFO - PROCESS | 11340 | RSS: Main: 171921408 18:04:16 INFO - PROCESS | 11340 | 18:04:20 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42124/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:20 INFO - PROCESS | 11340 | RSS: Main: 172232704 18:04:20 INFO - PROCESS | 11340 | 18:04:23 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42124/tests/kraken/driver.html?testName=json-parse-financial) 18:04:24 INFO - PROCESS | 11340 | RSS: Main: 172011520 18:04:24 INFO - PROCESS | 11340 | 18:04:25 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42124/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:26 INFO - PROCESS | 11340 | RSS: Main: 176414720 18:04:26 INFO - PROCESS | 11340 | 18:04:27 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:28 INFO - PROCESS | 11340 | RSS: Main: 174182400 18:04:28 INFO - PROCESS | 11340 | 18:04:30 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:31 INFO - PROCESS | 11340 | RSS: Main: 180264960 18:04:31 INFO - PROCESS | 11340 | 18:04:33 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:33 INFO - PROCESS | 11340 | RSS: Main: 187158528 18:04:33 INFO - PROCESS | 11340 | 18:04:36 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:37 INFO - PROCESS | 11340 | RSS: Main: 187195392 18:04:37 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | Cycle 1(1): loaded http://localhost:42124/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42124/tests/kraken/driver.html?testName=ai-astar) 18:04:38 INFO - PROCESS | 11340 | RSS: Main: 249729024 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | __start_tp_report 18:04:38 INFO - PROCESS | 11340 | _x_x_mozilla_page_load 18:04:38 INFO - PROCESS | 11340 | _x_x_mozilla_page_load_details 18:04:38 INFO - PROCESS | 11340 | |i|pagename|runs| 18:04:38 INFO - PROCESS | 11340 | |0;ai-astar;110;110;103;109;109;110;98;109;109;107 18:04:38 INFO - PROCESS | 11340 | |1;audio-beat-detection;152;135;159;165;135;161;153;128;175;127 18:04:38 INFO - PROCESS | 11340 | |2;audio-dft;161;161;163;161;159;162;159;165;161;162 18:04:38 INFO - PROCESS | 11340 | |3;audio-fft;75;73;75;169;75;76;76;76;172;78 18:04:38 INFO - PROCESS | 11340 | |4;audio-oscillator;93;94;137;93;93;93;149;94;95;141 18:04:38 INFO - PROCESS | 11340 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 18:04:38 INFO - PROCESS | 11340 | |6;imaging-darkroom;145;145;145;147;146;145;145;146;146;145 18:04:38 INFO - PROCESS | 11340 | |7;imaging-desaturate;96;95;95;95;95;96;96;95;96;96 18:04:38 INFO - PROCESS | 11340 | |8;json-parse-financial;53;57;54;59;55;54;54;67;53;53 18:04:38 INFO - PROCESS | 11340 | |9;json-stringify-tinderbox;64;66;66;66;66;65;65;65;65;65 18:04:38 INFO - PROCESS | 11340 | |10;stanford-crypto-aes;83;79;78;77;79;78;77;78;80;78 18:04:38 INFO - PROCESS | 11340 | |11;stanford-crypto-ccm;116;114;111;113;110;115;110;117;117;114 18:04:38 INFO - PROCESS | 11340 | |12;stanford-crypto-pbkdf2;142;135;145;142;142;141;141;142;142;142 18:04:38 INFO - PROCESS | 11340 | |13;stanford-crypto-sha256-iterative;69;68;67;66;73;65;67;70;65;67 18:04:38 INFO - PROCESS | 11340 | __end_tp_report 18:04:38 INFO - PROCESS | 11340 | __start_cc_report 18:04:38 INFO - PROCESS | 11340 | _x_x_mozilla_cycle_collect,1045 18:04:38 INFO - PROCESS | 11340 | __end_cc_report 18:04:38 INFO - PROCESS | 11340 | __startTimestamp1460768678975__endTimestamp 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | ------- Summary: start ------- 18:04:38 INFO - PROCESS | 11340 | Number of tests: 14 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#0] ai-astar Cycles:10 Average:107.40 Median:109.50 stddev:3.92 (3.6%) stddev-sans-first:4.04 18:04:38 INFO - PROCESS | 11340 | Values: 110.0 110.0 103.0 109.0 109.0 110.0 98.0 109.0 109.0 107.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.00 stddev:16.73 (10.7%) stddev-sans-first:17.71 18:04:38 INFO - PROCESS | 11340 | Values: 152.0 135.0 159.0 165.0 135.0 161.0 153.0 128.0 175.0 127.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 18:04:38 INFO - PROCESS | 11340 | Values: 161.0 161.0 163.0 161.0 159.0 162.0 159.0 165.0 161.0 162.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:40.08 (53.1%) stddev-sans-first:41.89 18:04:38 INFO - PROCESS | 11340 | Values: 75.0 73.0 75.0 169.0 75.0 76.0 76.0 76.0 172.0 78.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:23.74 (25.5%) stddev-sans-first:24.53 18:04:38 INFO - PROCESS | 11340 | Values: 93.0 94.0 137.0 93.0 93.0 93.0 149.0 94.0 95.0 141.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:04:38 INFO - PROCESS | 11340 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:04:38 INFO - PROCESS | 11340 | Values: 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 146.0 145.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:04:38 INFO - PROCESS | 11340 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:54.50 stddev:4.36 (8.0%) stddev-sans-first:4.49 18:04:38 INFO - PROCESS | 11340 | Values: 53.0 57.0 54.0 59.0 55.0 54.0 54.0 67.0 53.0 53.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 18:04:38 INFO - PROCESS | 11340 | Values: 64.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:1.77 (2.3%) stddev-sans-first:0.97 18:04:38 INFO - PROCESS | 11340 | Values: 83.0 79.0 78.0 77.0 79.0 78.0 77.0 78.0 80.0 78.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:114.50 stddev:2.67 (2.3%) stddev-sans-first:2.70 18:04:38 INFO - PROCESS | 11340 | Values: 116.0 114.0 111.0 113.0 110.0 115.0 110.0 117.0 117.0 114.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.00 stddev:2.50 (1.8%) stddev-sans-first:2.65 18:04:38 INFO - PROCESS | 11340 | Values: 142.0 135.0 145.0 142.0 142.0 141.0 141.0 142.0 142.0 142.0 18:04:38 INFO - PROCESS | 11340 | 18:04:38 INFO - PROCESS | 11340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.45 (3.6%) stddev-sans-first:2.55 18:04:38 INFO - PROCESS | 11340 | Values: 69.0 68.0 67.0 66.0 73.0 65.0 67.0 70.0 65.0 67.0 18:04:38 INFO - PROCESS | 11340 | -------- Summary: end -------- 18:04:38 INFO - PROCESS | 11340 | 18:04:39 INFO - TEST-INFO | 11340: exit 0 18:04:39 INFO - TEST-OK | kraken | took 59601ms 18:04:39 INFO - SUITE-END | took 1171s 18:04:40 INFO - Completed test suite (00:19:31) 18:04:40 INFO - javascript benchmark 18:04:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.413845507808, 3310.536524886518, 3324.717399021083, 3331.2338162222686, 3348.162959260185, 5336.332958380202, 5338.519533242007, 5356.062689029419, 5361.678299302044, 5393.406725260218, 5303.840884773454, 5309.203619457084, 5344.118220493624, 5345.33183352081, 5350.8127215547465, 4848.321235027099, 4905.901881962359, 4910.435299940499, 4913.926291105637, 4958.975205123969, 4877.561019508244, 4960.156773348539, 4961.652684312099, 4995.850124496253, 5046.82336118236, 4987.451380348159, 5023.271625614284, 5031.11955407804, 5038.093143234217, 5049.217371307434, 4842.007388485352, 4964.007198560266, 4991.800327986876, 5008.023435430075, 5018.999999999982, 4849.224124140121, 4925.482824303468, 4960.206366981266, 4965.751712414401, 4985.651004429691, 5281.788728450857, 5296.708681022542, 5312.256284120226, 5316.840494785162, 5363.249145119647, 5629.127485239795, 5696.686682232517, 5779.537636989031, 5797.623154494944, 5799.82600521985, 5727.140928860663, 5776.913346299809, 5778.104393818965, 5786.739596718157, 5806.274215723035, 5347.6256662033675, 5368.0605893968395, 5372.0330340538685, 5386.057439947994, 5392.91910621345, 5798.768049278066, 5822.767089316465, 5834.620749651259, 5862.267216597926, 5956.463918247378, 5689.544836413077, 5697.0, 5697.145428185722, 5700.686462244616, 5713.400092990176, 5737.196792449061, 5771.018926782457, 5792.391798861143, 5797.797077102281, 5801.187833703285, 5504.091824848935, 5684.914726279109, 5756.740946657411, 5809.50619197373, 5810.738516766755, 5771.192033115367, 5783.19035335045, 5786.71066446676, 5790.392008839011, 5792.94207057924, 4353.434053573015, 4368.650507959355, 4382.583654552813, 4393.319035549495, 4397.934030989538, 3848.5381754189675, 3942.1918506706056, 3957.050307926135, 3992.2813893499447, 4001.579834117434, 5420.512153906167, 5471.917921231185, 5474.972625136928, 5475.151351540518, 5495.395506494282, 5621.606487545832, 5795.913061304083, 5818.5054270386645, 5825.650460972355, 5835.503982161564, 5330.600204984642, 5377.462253774591, 5392.973035134799, 5420.91868621971, 5431.592630552725, 4924.8276310328965, 4931.13705101613, 4932.03825254072, 4935.703857768545, 4962.875928101754, 5838.67887266196, 5857.150713146655, 5868.383819698955, 5871.236739223959, 5883.352831188566, 5689.800856969986, 5709.82870513877, 5717.514011309086, 5717.656940583578, 5746.195532625352, 5846.707664616837, 5847.883042339045, 5865.354810970704, 5865.5600829937075, 5873.823785286449, 5544.556435485071, 5629.971850140887, 5645.887082258414, 5678.488935995781, 5766.509846663081, 5788.797392091256, 5789.913151302818, 5790.971045144747, 5794.739236734273, 5820.592558520862, 5607.243022191952, 5611.579131565068, 5628.521575666115, 5632.127020311858, 5636.85907852307, 5477.917831232455, 5652.971735141463, 5709.143628455598, 5757.309122905278, 5806.1000544915605, 5433.891322173614, 5516.917246241229, 5517.420670829666, 5522.22688823573, 5537.612367134262, 5586.916196257141, 5598.21624972496, 5647.519960803378, 5648.322201335866, 5655.406182350958, 5470.72646367672, 5504.559635229252, 5511.917321240105, 5594.692291923983, 5609.27079479665], "unit": "score", "name": "dojo.html", "value": 5316.113645094571}, {"lowerIsBetter": false, "replicates": [558.6619700963124, 566.6571724106918, 584.7047241143222, 611.4802417944748, 627.654789865574, 40449.79775101124, 41196.38205426913, 41238.58761412385, 41271.0, 41351.79324103375, 44366.33450498237, 45131.77434112833, 45275.32087018697, 45297.54702452975, 45334.77332613341, 9010.14403631654, 9185.678501252458, 9193.0, 9218.17036466718, 9221.262299016063, 8890.110988901091, 9061.818763624724, 9062.0, 9269.119433653792, 9275.257979361635, 9225.677101301455, 9301.0, 9320.813583728355, 9328.11382918625, 9328.48693321867, 9216.17054465098, 9299.72100836976, 9307.34848560601, 9307.72076837696, 9315.301352398563, 9243.584038718274, 9405.76485587859, 9407.29445291606, 9412.058794120534, 9415.62337506499, 44519.0, 44929.101417971455, 44976.3253551197, 44989.77505112486, 45056.54943450556, 3772.5284339457567, 3906.2187562487616, 4102.979485102585, 4305.870823875289, 4609.078184363141, 32387.352252955043, 32855.507167392505, 33103.6689633103, 33247.3350532988, 33437.33125337504, 3735.1035751419463, 3845.6346647068485, 3863.092173339263, 3864.787436690981, 3945.704072194568, 284809.0, 285068.0, 285297.0, 286463.0, 288000.0, 65963.0, 66921.66539167272, 66923.33076669171, 66964.3303566958, 66994.66502667456, 73472.26527734761, 74964.0, 74965.0, 74972.62513687396, 74983.62508187424, 16539.6692066158, 16639.16804159787, 16714.0, 16723.0, 16736.079515626512, 13835.584932452042, 13902.791458128137, 13906.304684765924, 13920.58238252854, 13932.37304321308, 22310.10759569599, 22597.0, 22601.547969040526, 22624.773752262266, 23577.88211058968, 8218.589070546568, 8480.321574274043, 8542.974843018877, 8544.572771361407, 8774.868376974351, 1042.9153680172535, 1062.0706881478707, 1133.4162906103363, 1166.6266794625637, 1184.9526018959318, 28530.0, 28722.13833584996, 28994.27514312159, 29765.553516697266, 29927.700722992926, 1134.2570616246371, 1158.1082566423806, 1167.96496105117, 1196.0670676872053, 1253.1040306181123, 15428.305726242346, 15910.76133857993, 15995.520134395987, 16010.759838602196, 16257.349706011628, 309452.0, 311567.0, 313215.0, 313442.0, 313748.0, 63110.0, 63572.0, 63754.36245637577, 63765.36234637687, 63884.0, 1359.6328991172527, 1408.5915084625344, 1500.6248437890526, 1520.3918432627038, 1522.5812901451968, 29753.702462975092, 30375.848120759256, 30519.847400762854, 30599.847000764854, 32066.19834504156, 51897.740511297205, 52571.21143182779, 52670.73664631652, 52985.735071324394, 53134.4686553145, 244767.0, 247516.0, 248177.0, 248343.0, 312522.0, 51196.0, 51570.74214628903, 51821.0, 51847.74076129595, 52527.47472525226, 52957.205641916174, 53802.73098634638, 53866.461335387714, 54186.72906635599, 55179.0, 42534.78732606441, 42692.786536068365, 43529.347059793494, 43712.78143609261, 44422.3336649944, 42857.35713964231, 43125.0, 43200.56799432091, 43544.782276088416, 44661.0, 43355.78322108369, 43828.34257486076, 44354.0, 44990.77504612456, 45245.0, 39003.80498097605, 40198.0, 40252.3962140574, 40519.0, 40850.0, 29289.974850880117, 29739.0, 29918.25204369908, 29937.85031074831, 29977.550336745404], "unit": "score", "name": "ext.html", "value": 20695.189530926687}, {"lowerIsBetter": false, "replicates": [376.66476835616305, 377.0930911158663, 377.256804095931, 380.90858194033405, 382.32519602900885, 17716.73424898626, 18231.179596918137, 19092.713609295835, 19114.522136946583, 19122.71315930262, 16800.915995420004, 17559.561010974732, 17855.821441785578, 17979.460616181535, 17996.55008624782, 5452.59105567082, 5567.693776842272, 5579.246801681782, 5607.691576963265, 5609.719514024303, 4163.3130533461945, 5503.6147469677135, 5909.527237820964, 6150.907736383958, 6178.196834411543, 6076.39236076391, 6096.939030609704, 6108.908366374486, 6115.602485838406, 6116.96941515294, 5828.708564571775, 5999.820005399802, 6023.608465449775, 6027.789027384064, 6036.969815150918, 3756.3614185588244, 5142.202958541432, 5303.310569625924, 5363.061464243741, 5370.677759334413, 20716.274930377516, 20748.688769668468, 20825.68761468579, 22460.0, 22506.32481025572, 2397.113068164773, 2426.5632186206476, 2432.3311089450367, 2480.404702871298, 2494.4761600064007, 13473.932630336785, 13585.660358491117, 13696.383662735201, 13929.442822287096, 14081.155130692192, 1893.1480833624923, 1978.5251539630528, 2015.8084981926693, 2117.4071260047212, 2136.2096024471043, 60507.69746151285, 62492.37507624911, 62622.68688656573, 63182.68408657928, 63960.68019659872, 10306.0, 10356.637517686995, 10425.947870260752, 10443.0, 10447.320924139907, 14742.926285368505, 14750.0, 14826.258687065603, 14842.960992730405, 14848.925755371154, 7505.62471876404, 7735.381169506426, 7750.883736743954, 7788.104367997753, 7859.449838511364, 7194.820129496805, 7262.600556969312, 7275.0542429484885, 7661.272179142972, 7940.0, 4361.520232774392, 4546.045330480636, 4595.701279416827, 4600.240960241523, 4727.976360118178, 1776.2948533736976, 1898.9525261868287, 1910.8566857485744, 1915.396650055228, 1930.1700268884515, 989.7773001074845, 1023.3603997501561, 1047.6280920273346, 1066.706655669697, 1124.8425220469142, 17317.48047558575, 17504.5623859402, 17595.384161554284, 17648.294068237126, 17787.644247114986, 982.9066238707311, 1008.6419321141036, 1020.78563501664, 1030.6701855406197, 1034.75165960169, 10137.746556336151, 10166.694999150037, 10185.388876667275, 10206.744831379276, 10244.977830620901, 457789.0, 459044.0, 461536.0, 464226.0, 470921.0, 80294.598527007, 81780.59109704533, 81996.18003820005, 82262.58868705618, 82832.0, 975.4050029482011, 1001.4241810958582, 1016.4968340671268, 1115.760111576015, 1133.9433028348549, 15319.693606128038, 15323.923380383027, 15329.310181041657, 15408.537743867702, 15416.383344666536, 31961.840190798895, 32460.51309230316, 33823.66176338205, 34018.14954626154, 34678.479822802175, 47786.522134778206, 49580.75209624073, 52362.73818630882, 52838.73580632072, 52881.47118528919, 8253.257206851413, 8387.0, 8418.915810841812, 8467.068622451403, 8519.0, 9722.319437639297, 10969.890301096886, 12811.0, 12917.418716157608, 13170.143940643828, 10978.890211097787, 11277.492512837107, 11323.263987840764, 11361.715957101138, 11438.42807859587, 10857.945710271399, 10968.451577420938, 10973.286736362112, 11027.61403350879, 11124.666260012213, 10932.94533527359, 11547.249428787101, 11563.421828908353, 11565.421728913352, 11999.0, 8231.753047408587, 8300.501969881827, 8503.149685031447, 8572.871406928776, 8577.95711021441, 10713.89286107129, 11691.356975366096, 11715.648530544097, 11835.940820295844, 11932.821007685065], "unit": "score", "name": "jquery.html", "value": 8878.063006872375}, {"lowerIsBetter": false, "replicates": [1361.2445092973396, 1585.714571377152, 1589.2848218301763, 1836.0819590204896, 1944.9708254376178, 8317.085120636733, 8532.786680332994, 8534.103919088491, 8540.35947303953, 8545.102764209754, 8381.664733410671, 8557.058723540405, 8559.48643081414, 8563.65745370186, 8564.3148548116, 2103.968440473394, 2398.59223931932, 2416.1543459789063, 2442.65802787609, 2468.0374653885, 2362.3857796972825, 2378.3816207785926, 2383.7020372453444, 2388.4028992751814, 2392.7487613800477, 2286.9542609147807, 2327.755585663498, 2341.730700969385, 2341.800946919514, 2342.3324352559525, 2387.3912152401113, 2404.350825277174, 2438.305083051322, 2440.0727723465147, 2463.531928933515, 2402.4114092047384, 2428.174420696954, 2428.210831479776, 2491.8504889706674, 2493.376655836041, 8639.52482613456, 8701.390902636818, 8711.564421778885, 8721.563921803885, 8733.956330218309, 5152.536271735525, 5303.098473259516, 5304.9655317213155, 5312.495312945264, 5313.07021271276, 3068.2329417645587, 3162.2884850908363, 3175.4601717708047, 3256.7394608431505, 3298.09302441828, 965.6089283839985, 976.7899901521207, 983.4050399508266, 984.1782111936542, 993.4138858073699, 12358.258504489759, 12362.44369003388, 12369.319687417188, 12409.0, 12412.069094817834, 4616.376789133491, 4757.0, 4795.544423279783, 4799.232122860326, 4816.783244753994, 9652.372595781251, 9683.612655493842, 9696.17582505495, 9715.659951901649, 9718.562664680107, 4687.460941991646, 5286.259923610698, 5293.682379057269, 5307.283516725192, 5311.681299122065, 4720.291956206596, 4791.161546729378, 4795.496472870368, 4802.255650374198, 4810.4467986182035, 3629.8003609801185, 3691.2986532559266, 3718.888433347004, 3734.4958430612064, 3752.1745216052423, 1070.2133931560452, 1091.2252300866314, 1101.9889801102047, 1104.4201794058183, 1110.5890820396505, 1459.6204986703533, 1482.8813694904597, 1496.678214183934, 1516.5753588995099, 1537.34662768323, 8397.286230670461, 8443.155684431631, 8493.617787199591, 8496.53269070207, 8503.872441913376, 495.38324785642106, 504.3393154967005, 507.1505228741916, 508.509288536564, 509.89292248627464, 6342.23893132827, 6352.36476352361, 6356.459700925473, 6402.967985160044, 6420.871582568322, 10567.735806604742, 10898.618548350929, 10914.617988370368, 11060.778784424267, 11075.224734268684, 10470.685879423629, 10823.783524329468, 10897.509612067475, 10906.236563440641, 10981.83527247076, 8356.832863342699, 8420.4947703138, 8466.365022623328, 8467.026291976501, 8505.277051450572, 8063.113057563781, 8080.959595201986, 8093.0, 8102.351811855156, 8180.631871565913, 9500.762480938032, 9643.614255429704, 9669.0, 9725.319227653996, 9736.123748862636, 9784.119429251401, 9870.062344077302, 9972.700818975442, 9993.550290236812, 10158.441285729356, 6340.207474065742, 6956.478264130109, 7177.641117944187, 7302.890456643261, 7377.594232317274, 8299.0, 8327.50034997902, 8363.581820909052, 8384.161583841567, 8384.41309108381, 7158.606276654834, 7337.0828646419195, 7491.3632341251605, 7532.811679708051, 7639.57982310956, 7266.491345605757, 7339.0, 7399.667014984231, 7438.256174382518, 7488.138864030706, 7304.379127774198, 7317.487775855639, 7337.1929087799235, 7346.375558077623, 7353.70585176587, 7046.295370462913, 7079.044329015723, 7164.749233776793, 7205.747798827016, 7217.530860494051, 7201.0, 7266.96366518164, 7293.635318233961, 7349.154847192642, 7370.299821516947], "unit": "score", "name": "mootools.html", "value": 4786.946988169434}, {"lowerIsBetter": false, "replicates": [346.4785497825772, 347.9060653623522, 349.67130896956843, 355.38873138202285, 355.9483874838148, 5987.880242395155, 5990.101484777286, 5998.0702991036405, 6009.699515024253, 6023.518118550516, 5956.791512297071, 5959.195508606337, 5962.0, 5962.940370596293, 5966.5823392362445, 4474.507804141542, 4510.052888893337, 4631.39791827062, 4637.65217608679, 4692.483826779052, 4659.301104834285, 4670.953290467103, 4682.367880336145, 4684.414448193976, 4691.695039822418, 4607.7004994675235, 4619.561141691551, 4637.976810115962, 4644.558766917137, 4656.092062047902, 4436.800343984529, 4506.864794056167, 4625.606823420013, 4637.513061128567, 4645.047765208158, 4087.9182416351805, 4100.753954762724, 4103.651189648884, 4107.835686572534, 4113.321301985169, 5708.4291570843, 5784.219130417382, 5791.855203619901, 5795.478406943354, 5801.883962320772, 5383.192521121863, 5390.245365648812, 5391.137418013138, 5392.487713667196, 5401.378841433247, 6319.3680631936895, 6323.114763933053, 6326.367363263636, 6326.620402775849, 6332.461740752042, 4162.188373267214, 4342.348647702838, 4379.693421460467, 4389.0, 4539.4098767160385, 6526.836829079263, 6559.6064236145985, 6569.244536878273, 6579.572327798678, 6582.959282622354, 4519.231730605805, 4525.411696479437, 4529.8641040768825, 4529.932051019237, 4537.682362234678, 4574.725516469022, 4590.104929538707, 4598.632109431237, 4606.631469482433, 4606.815727370935, 5302.2311764793885, 5321.175217841241, 5322.866928326823, 5329.067413202752, 5329.680219186861, 6126.846828829315, 6321.273053598895, 6357.459615932605, 6439.484841212786, 6442.6778661066755, 1592.235726851118, 1595.4814685227348, 1601.2554162314348, 1603.8235794062643, 1609.7182992976182, 996.4220751963844, 1052.9578816847393, 1064.2071656615872, 1072.785442911421, 1083.4799296337644, 6011.909821352683, 6017.0, 6019.398060194033, 6024.1265016573225, 6090.086487026982, 6476.125723027425, 6523.967380163163, 6531.869362612816, 6545.345465453416, 6553.672316384162, 6068.787592434243, 6070.0591408331775, 6074.271087469444, 6082.847928801727, 6084.452399284086, 3491.284286721216, 3530.435130379178, 3531.858725650945, 3531.876384326536, 3540.097275194809, 6687.063811066455, 6746.628935408599, 6763.222229443579, 6854.725810967605, 6856.965715171392, 6668.099806526056, 6685.966570167216, 6782.084418603426, 6810.182778066664, 6876.793696189123, 6828.385445309946, 6844.21291551468, 6847.281035491302, 6911.101556797584, 6931.0, 6556.672166391566, 6604.669766511559, 6609.272979972296, 6621.5364924454825, 6622.900656490253, 6266.0, 6522.902156467562, 6526.608403495806, 6538.607683539003, 6550.83622909412, 6832.248452670302, 6874.4844136690945, 6904.067950826775, 6915.308469153045, 6918.10064691607, 4661.254199328091, 4726.26742854858, 4742.66801323904, 4746.833860814855, 4747.2879068140055, 6587.703553340207, 6604.405603495708, 6604.669766511752, 6608.273089960197, 6611.07444957716, 6256.06159076124, 6346.873062538631, 6349.936500635119, 6402.647854368054, 6420.6468644225015, 6384.680765961776, 6390.712417941111, 6406.775762848278, 6411.743530258924, 6424.839379015562, 6274.968625156845, 6278.089676996901, 6282.623042617458, 6285.2457705075685, 6285.96857015712, 6409.903851442139, 6416.550841441054, 6427.775027874189, 6433.324500927522, 6444.8388790280615, 6058.12157237207, 6128.0, 6277.74889004453, 6293.527985401205, 6296.842578935563], "unit": "score", "name": "prototype.html", "value": 4820.9187025421}, {"lowerIsBetter": false, "replicates": [688.2566827825948, 779.9961000194999, 787.1380837982409, 796.1799346672929, 797.1868693932189, 12940.35298235088, 13047.869521304785, 13048.086633935629, 13080.084394092417, 13082.411291491882, 12306.200096993689, 12309.38453077347, 12311.815322770166, 12313.0, 12320.938395308034, 736.9963150184242, 917.6191880369655, 925.546482223709, 946.7869729310885, 947.1901524196816, 934.3319526538523, 935.6818681648239, 936.1901954809109, 940.3699521320732, 940.7507010642151, 984.0405604535592, 989.159214667534, 991.0931497679614, 991.8760154980628, 992.2558081438921, 783.8079670480712, 968.3173362779258, 984.4388698441891, 984.9704508864745, 985.0740304114146, 719.4747834081098, 724.90213821134, 725.1696807155777, 725.8004048886546, 726.9563826170447, 11872.168948173632, 11881.762364752656, 11916.225445346025, 11925.105617078667, 11930.642080737505, 13034.283114428703, 13341.39963701626, 13417.66455838602, 13438.932805336008, 14083.0, 10004.749881252954, 10454.111400530965, 10531.94734026325, 10696.465176741209, 10769.299995500267, 3720.5535335759882, 3874.6512813846607, 3889.1638297765835, 3908.394198899175, 3976.980115099435, 50845.74577127128, 51539.48460515384, 51569.74215128938, 51785.22322165208, 51871.221931671054, 9944.602215911282, 10223.335483193569, 10264.692059238234, 10331.793364132674, 10515.26393152472, 17858.374956876447, 18015.819841801414, 18019.0, 18055.819441805415, 18056.18747156381, 6762.154730658668, 6914.585124892523, 6919.065926100013, 6957.130358705162, 6997.545159564612, 4251.87244382669, 4254.255505286625, 4264.040590867092, 4328.805203765838, 4360.193364227564, 3142.7328677062706, 3154.495280755068, 3176.7617428692943, 3185.569948057029, 3221.0014895382506, 584.4885724990634, 587.5329113354893, 625.9405356491126, 629.6599836088461, 633.8415396150963, 483.12795404294883, 599.8980173370537, 604.6613896218132, 605.8212827215982, 642.1812189458478, 8309.916900830915, 8369.698114332903, 8457.619407126695, 8516.1058088901, 8635.654573817103, 527.7704198673589, 579.3250862744856, 608.5253502268238, 639.67376637915, 678.2098854834162, 3953.2686453006286, 4031.717779755389, 4070.4911886014247, 4116.279651061052, 4126.7523948563185, 56347.71826140843, 56612.0, 56721.71639141778, 56950.0, 57138.7143064282, 51220.48779512232, 52603.73698131561, 53165.468345316825, 53672.194917076275, 53781.73109134429, 46962.76518617385, 47717.761411192725, 47984.760076199396, 48039.87740796907, 48645.51354486481, 7676.923230767621, 8059.427094979053, 8118.2693557580105, 8177.836443271221, 8179.63191656365, 35725.64274357223, 36597.45103823498, 36679.81660091683, 36862.8156859214, 37031.444528332635, 41892.371614425196, 42002.78998604987, 45509.0, 45766.08467830558, 46719.532804671515, 9785.902140978498, 9845.0, 9853.359531630707, 9855.556499957376, 9891.505424728879, 10768.246222764332, 10804.24370294072, 10857.13142948578, 11019.724506887393, 11272.718182045515, 10757.784844303227, 10814.188935830001, 10852.45737713127, 10908.945455272673, 11031.889681103086, 10821.67534973952, 11394.601188958346, 11563.364014979257, 11771.411429428666, 11937.224080434744, 10574.735631609272, 10757.515911784145, 11106.111511078932, 11273.436328183721, 11673.12451566119, 9123.49820759838, 9147.679831205876, 9324.580393882427, 9354.345195836226, 9409.811803763749, 9945.850812237677, 10139.290249682452, 10182.592696292066, 10205.591776328863, 10227.386356818615], "unit": "score", "name": "yui.html", "value": 6353.9959779806}], "name": "dromaeo_css", "value": 7233.407950517829}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 103.0, 109.0, 109.0, 110.0, 98.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [152.0, 135.0, 159.0, 165.0, 135.0, 161.0, 153.0, 128.0, 175.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 161.0, 159.0, 162.0, 159.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 169.0, 75.0, 76.0, 76.0, 76.0, 172.0, 78.0], "unit": "score", "name": "audio-fft", "value": 94.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 137.0, 93.0, 93.0, 93.0, 149.0, 94.0, 95.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [53.0, 57.0, 54.0, 59.0, 55.0, 54.0, 54.0, 67.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [83.0, 79.0, 78.0, 77.0, 79.0, 78.0, 77.0, 78.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [116.0, 114.0, 111.0, 113.0, 110.0, 115.0, 110.0, 117.0, 117.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [142.0, 135.0, 145.0, 142.0, 142.0, 141.0, 141.0, 142.0, 142.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 66.0, 73.0, 65.0, 67.0, 70.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1501.0000000000002}]} 18:04:40 INFO - Return code: 0 18:04:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:40 INFO - # TBPL SUCCESS # 18:04:40 INFO - Running post-action listener: _resource_record_post_action 18:04:40 INFO - Running post-run listener: _resource_record_post_run 18:04:41 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 274432; Write bytes: 504221696; Read time: 28; Write time: 394660 18:04:41 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 251977728; Read time: 0; Write time: 253240 18:04:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 274432; Write bytes: 252243968; Read time: 28; Write time: 141420 18:04:41 INFO - Running post-run listener: _upload_blobber_files 18:04:41 INFO - Blob upload gear active. 18:04:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:41 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 18:04:41 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:41 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:43 INFO - (blobuploader) - INFO - Done attempting. 18:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:44 INFO - (blobuploader) - INFO - Done attempting. 18:04:44 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:44 INFO - Return code: 0 18:04:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d41d81c246e6631220f0ca31465af168711201b91767c3b0af23ed0885c7fb6de9ac6c8a54fdf357c977ce9d1056709c1772db5b15c551567acc299391b2389f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba06a248d267100db363c84b534e708c3ff6cb284903a9e8a49c6b6099d5c7862b8a961bbd66ff612a30b72b0db487d16e504ec456e0d6d021dba72e45bd331"} 18:04:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:44 INFO - Contents: 18:04:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d41d81c246e6631220f0ca31465af168711201b91767c3b0af23ed0885c7fb6de9ac6c8a54fdf357c977ce9d1056709c1772db5b15c551567acc299391b2389f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba06a248d267100db363c84b534e708c3ff6cb284903a9e8a49c6b6099d5c7862b8a961bbd66ff612a30b72b0db487d16e504ec456e0d6d021dba72e45bd331"} 18:04:44 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:44 INFO - Copying logs to upload dir... 18:04:44 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.642319 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-15 18:04:44.076416) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 18:04:44.080767) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 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-Aurora/sha512/d41d81c246e6631220f0ca31465af168711201b91767c3b0af23ed0885c7fb6de9ac6c8a54fdf357c977ce9d1056709c1772db5b15c551567acc299391b2389f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba06a248d267100db363c84b534e708c3ff6cb284903a9e8a49c6b6099d5c7862b8a961bbd66ff612a30b72b0db487d16e504ec456e0d6d021dba72e45bd331"} build_url:https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/NhL66YViTqyNzUnuRP4RjQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d41d81c246e6631220f0ca31465af168711201b91767c3b0af23ed0885c7fb6de9ac6c8a54fdf357c977ce9d1056709c1772db5b15c551567acc299391b2389f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eba06a248d267100db363c84b534e708c3ff6cb284903a9e8a49c6b6099d5c7862b8a961bbd66ff612a30b72b0db487d16e504ec456e0d6d021dba72e45bd331"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 18:04:44.111879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 18:04:44.112466) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460767378.995361-1889415238 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 18:04:44.195610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 18:04:44.196156) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 18:04:44.196637) ========= ========= Total master_lag: 0.19 =========