builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1470077643.77 results: success (0) buildid: 20160801085448 builduid: 8abb7db25ac34ae39552f7ca58ae99d2 revision: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.772801) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.773250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.773657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.788378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.788694) ========= 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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:54:04-- 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% 42.5M=0s 2016-08-01 11:54:04 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.942530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.942846) ========= 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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017858 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:03.993512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:54:03.993887) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 --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 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 --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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:54:05,026 truncating revision to first 12 chars 2016-08-01 11:54:05,026 Setting DEBUG logging. 2016-08-01 11:54:05,026 attempt 1/10 2016-08-01 11:54:05,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/70ee99f185b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:54:05,814 unpacking tar archive at: mozilla-aurora-70ee99f185b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.123640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 11:54:05.131913) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:05.132398) ========= script_repo_revision: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:05.132822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:05.133110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:54:05.144887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-01 11:54:05.145296) ========= /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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:54:06 INFO - MultiFileLogger online at 20160801 11:54:06 in /builds/slave/test 11:54:06 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 11:54:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:54:06 INFO - {'append_to_log': False, 11:54:06 INFO - 'base_work_dir': '/builds/slave/test', 11:54:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:54:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:54:06 INFO - 'branch': 'Mozilla-Aurora', 11:54:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:54:06 INFO - 'config_files': ('talos/linux_config.py',), 11:54:06 INFO - 'default_actions': ('clobber', 11:54:06 INFO - 'read-buildbot-config', 11:54:06 INFO - 'download-and-extract', 11:54:06 INFO - 'populate-webroot', 11:54:06 INFO - 'create-virtualenv', 11:54:06 INFO - 'install', 11:54:06 INFO - 'run-tests'), 11:54:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:54:06 INFO - 'download_minidump_stackwalk': True, 11:54:06 INFO - 'download_symbols': 'ondemand', 11:54:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:54:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:54:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:54:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:54:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:54:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:54:06 INFO - 'installer_path': 'installer.exe', 11:54:06 INFO - 'log_level': 'info', 11:54:06 INFO - 'log_name': 'talos', 11:54:06 INFO - 'log_to_console': True, 11:54:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:54:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:54:06 INFO - 'opt_config_files': (), 11:54:06 INFO - 'pip_index': False, 11:54:06 INFO - 'sps_profile': False, 11:54:06 INFO - 'sps_profile_interval': 0, 11:54:06 INFO - 'suite': 'dromaeojs', 11:54:06 INFO - 'system_bits': '32', 11:54:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:54:06 INFO - 'title': 'talos-linux64-ix-053', 11:54:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:54:06 INFO - 'use_talos_json': True, 11:54:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:54:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:54:06 INFO - 'work_dir': 'build'} 11:54:06 INFO - [mozharness: 2016-08-01 18:54:06.274277Z] Running clobber step. 11:54:06 INFO - Running pre-action listener: _resource_record_pre_action 11:54:06 INFO - Running main action method: clobber 11:54:06 INFO - rmtree: /builds/slave/test/build 11:54:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:54:07 INFO - Running post-action listener: _resource_record_post_action 11:54:07 INFO - [mozharness: 2016-08-01 18:54:07.232984Z] Finished clobber step (success) 11:54:07 INFO - [mozharness: 2016-08-01 18:54:07.233084Z] Running read-buildbot-config step. 11:54:07 INFO - Running pre-action listener: _resource_record_pre_action 11:54:07 INFO - Running main action method: read_buildbot_config 11:54:07 INFO - Using buildbot properties: 11:54:07 INFO - { 11:54:07 INFO - "project": "", 11:54:07 INFO - "product": "firefox", 11:54:07 INFO - "script_repo_revision": "production", 11:54:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:54:07 INFO - "repository": "", 11:54:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:54:07 INFO - "buildid": "20160801085448", 11:54:07 INFO - "pgo_build": "True", 11:54:07 INFO - "basedir": "/builds/slave/test", 11:54:07 INFO - "buildnumber": 649, 11:54:07 INFO - "slavename": "talos-linux64-ix-053", 11:54:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:54:07 INFO - "platform": "ubuntu64_hw", 11:54:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:54:07 INFO - "branch": "mozilla-aurora", 11:54:07 INFO - "repo_path": "releases/mozilla-aurora", 11:54:07 INFO - "revision": "70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3", 11:54:07 INFO - "stage_platform": "linux64-pgo", 11:54:07 INFO - "builduid": "8abb7db25ac34ae39552f7ca58ae99d2", 11:54:07 INFO - "slavebuilddir": "test" 11:54:07 INFO - } 11:54:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 11:54:07 INFO - Running post-action listener: _resource_record_post_action 11:54:07 INFO - [mozharness: 2016-08-01 18:54:07.235521Z] Finished read-buildbot-config step (success) 11:54:07 INFO - [mozharness: 2016-08-01 18:54:07.235610Z] Running download-and-extract step. 11:54:07 INFO - Running pre-action listener: _resource_record_pre_action 11:54:07 INFO - Running main action method: download_and_extract 11:54:07 INFO - mkdir: /builds/slave/test/build/tests 11:54: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')]} 11:54:07 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:54:07 INFO - Downloaded 1361 bytes. 11:54:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 11:54:07 INFO - Using the following test package requirements: 11:54:07 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:54:07 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:54:07 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:54:07 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'jsshell-linux-x86_64.zip'], 11:54:07 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:54:07 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 11:54:07 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:54:07 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:54:07 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:54:07 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 11:54:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:54:07 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:54: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')]} 11:54:07 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:08 INFO - Downloaded 21766180 bytes. 11:54:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:54:09 INFO - Return code: 0 11:54:09 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:09 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 11:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:54:10 INFO - Downloaded 21766180 bytes. 11:54:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:54:12 INFO - Return code: 0 11:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:12 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 11:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:54:13 INFO - Downloaded 14413723 bytes. 11:54:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:54:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:54:13 INFO - Return code: 0 11:54:13 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')]} 11:54:13 INFO - https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:54:14 INFO - Downloaded 63759413 bytes. 11:54:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:14 INFO - mkdir: /builds/slave/test/properties 11:54:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:54:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:54:14 INFO - Contents: 11:54:14 INFO - build_url:https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 11:54:15 INFO - Running post-action listener: _resource_record_post_action 11:54:15 INFO - Running post-action listener: set_extra_try_arguments 11:54:15 INFO - [mozharness: 2016-08-01 18:54:15.649230Z] Finished download-and-extract step (success) 11:54:15 INFO - [mozharness: 2016-08-01 18:54:15.649505Z] Running populate-webroot step. 11:54:15 INFO - Running pre-action listener: _resource_record_pre_action 11:54:15 INFO - Running main action method: populate_webroot 11:54:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:54:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:54:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:54:15 INFO - '--tppagecycles', 11:54:15 INFO - '7'], 11:54:15 INFO - 'tests': ['tsvgm']}}, 11:54:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:54:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:54:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:54:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:54:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:54:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['damp', 'tps']}, 11:54:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'tests': ['damp', 'tps']}, 11:54:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['dromaeo_dom']}, 11:54:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:54:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['basic_compositor_video']}, 11:54:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:54:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'other-e10s': {'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['a11yr', 11:54:15 INFO - 'ts_paint', 11:54:15 INFO - 'tpaint', 11:54:15 INFO - 'sessionrestore', 11:54:15 INFO - 'sessionrestore_no_auto_restore', 11:54:15 INFO - 'tabpaint']}, 11:54:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['tsvgx', 11:54:15 INFO - 'tsvgr_opacity', 11:54:15 INFO - 'tart', 11:54:15 INFO - 'tscrollx', 11:54:15 INFO - 'cart']}, 11:54:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:54:15 INFO - 'tsvgr_opacity', 11:54:15 INFO - 'tart', 11:54:15 INFO - 'tscrollx', 11:54:15 INFO - 'cart']}, 11:54:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'talos_options': ['--disable-e10s'], 11:54:15 INFO - 'tests': ['tp5o']}, 11:54:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'tests': ['tp5o']}, 11:54:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'talos_options': ['--disable-e10s', 11:54:15 INFO - '--xperf_path', 11:54:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:15 INFO - 'tests': ['tp5n']}, 11:54:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:54:15 INFO - 'talos_options': ['--xperf_path', 11:54:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:54:15 INFO - 'tests': ['tp5n']}}, 11:54:15 INFO - 'talos.zip': {'path': '', 11:54:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:54:15 INFO - Running post-action listener: _resource_record_post_action 11:54:15 INFO - [mozharness: 2016-08-01 18:54:15.667671Z] Finished populate-webroot step (success) 11:54:15 INFO - [mozharness: 2016-08-01 18:54:15.667761Z] Running create-virtualenv step. 11:54:15 INFO - Running pre-action listener: _resource_record_pre_action 11:54:15 INFO - Running main action method: create_virtualenv 11:54:15 INFO - Creating virtualenv /builds/slave/test/build/venv 11:54:15 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 11:54:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:54:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:54:15 INFO - Using real prefix '/usr' 11:54:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:54:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:54:18 INFO - Installing pip.................done. 11:54:18 INFO - Return code: 0 11:54:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:18 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:18 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 11:54:18 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 11:54:18 INFO - Using env: {'DISPLAY': ':0', 11:54:18 INFO - 'HOME': '/home/cltbld', 11:54:18 INFO - 'LANG': 'en_US.UTF-8', 11:54:18 INFO - 'LANGUAGE': 'en_US:en', 11:54:18 INFO - 'LOGNAME': 'cltbld', 11:54:18 INFO - 'MAIL': '/var/mail/cltbld', 11:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:18 INFO - 'MOZ_NO_REMOTE': '1', 11:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:18 INFO - 'NO_EM_RESTART': '1', 11:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:18 INFO - 'PWD': '/builds/slave/test', 11:54:18 INFO - 'SHELL': '/bin/bash', 11:54:18 INFO - 'SHLVL': '1', 11:54:18 INFO - 'TERM': 'linux', 11:54:18 INFO - 'TMOUT': '86400', 11:54:18 INFO - 'USER': 'cltbld', 11:54:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:18 INFO - '_': '/tools/buildbot/bin/python'} 11:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:18 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 11:54:18 INFO - Cleaning up... 11:54:18 INFO - Return code: 0 11:54:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:54:18 INFO - Using env: {'DISPLAY': ':0', 11:54:18 INFO - 'HOME': '/home/cltbld', 11:54:18 INFO - 'LANG': 'en_US.UTF-8', 11:54:18 INFO - 'LANGUAGE': 'en_US:en', 11:54:18 INFO - 'LOGNAME': 'cltbld', 11:54:18 INFO - 'MAIL': '/var/mail/cltbld', 11:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:18 INFO - 'MOZ_NO_REMOTE': '1', 11:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:18 INFO - 'NO_EM_RESTART': '1', 11:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:18 INFO - 'PWD': '/builds/slave/test', 11:54:18 INFO - 'SHELL': '/bin/bash', 11:54:18 INFO - 'SHLVL': '1', 11:54:18 INFO - 'TERM': 'linux', 11:54:18 INFO - 'TMOUT': '86400', 11:54:18 INFO - 'USER': 'cltbld', 11:54:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:18 INFO - '_': '/tools/buildbot/bin/python'} 11:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:18 INFO - Downloading/unpacking psutil>=3.1.1 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:18 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 11:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:20 INFO - Installing collected packages: psutil 11:54:20 INFO - Running setup.py install for psutil 11:54:20 INFO - building 'psutil._psutil_linux' extension 11:54:20 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 11:54:20 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 11:54:21 INFO - building 'psutil._psutil_posix' extension 11:54:21 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 11:54:21 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 11:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:54:21 INFO - Successfully installed psutil 11:54:21 INFO - Cleaning up... 11:54:21 INFO - Return code: 0 11:54:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:54:21 INFO - Using env: {'DISPLAY': ':0', 11:54:21 INFO - 'HOME': '/home/cltbld', 11:54:21 INFO - 'LANG': 'en_US.UTF-8', 11:54:21 INFO - 'LANGUAGE': 'en_US:en', 11:54:21 INFO - 'LOGNAME': 'cltbld', 11:54:21 INFO - 'MAIL': '/var/mail/cltbld', 11:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:21 INFO - 'MOZ_NO_REMOTE': '1', 11:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:21 INFO - 'NO_EM_RESTART': '1', 11:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:21 INFO - 'PWD': '/builds/slave/test', 11:54:21 INFO - 'SHELL': '/bin/bash', 11:54:21 INFO - 'SHLVL': '1', 11:54:21 INFO - 'TERM': 'linux', 11:54:21 INFO - 'TMOUT': '86400', 11:54:21 INFO - 'USER': 'cltbld', 11:54:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:21 INFO - '_': '/tools/buildbot/bin/python'} 11:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:54:21 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 11:54:21 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 11:54:21 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 11:54:21 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 11:54:21 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 11:54:21 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 11:54:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:54:23 INFO - Installing collected packages: mozsystemmonitor 11:54:23 INFO - Running setup.py install for mozsystemmonitor 11:54:23 INFO - Successfully installed mozsystemmonitor 11:54:23 INFO - Cleaning up... 11:54:23 INFO - Return code: 0 11:54:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:54:23 INFO - Using env: {'DISPLAY': ':0', 11:54:23 INFO - 'HOME': '/home/cltbld', 11:54:23 INFO - 'LANG': 'en_US.UTF-8', 11:54:23 INFO - 'LANGUAGE': 'en_US:en', 11:54:23 INFO - 'LOGNAME': 'cltbld', 11:54:23 INFO - 'MAIL': '/var/mail/cltbld', 11:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:23 INFO - 'MOZ_NO_REMOTE': '1', 11:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:23 INFO - 'NO_EM_RESTART': '1', 11:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:23 INFO - 'PWD': '/builds/slave/test', 11:54:23 INFO - 'SHELL': '/bin/bash', 11:54:23 INFO - 'SHLVL': '1', 11:54:23 INFO - 'TERM': 'linux', 11:54:23 INFO - 'TMOUT': '86400', 11:54:23 INFO - 'USER': 'cltbld', 11:54:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:23 INFO - '_': '/tools/buildbot/bin/python'} 11:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:23 INFO - Downloading/unpacking jsonschema==2.5.1 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:23 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 11:54:23 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 11:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:25 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:25 INFO - warning: no files found matching '*.txt' 11:54:25 INFO - no previously-included directories found matching 'build' 11:54:25 INFO - no previously-included directories found matching 'dist' 11:54:25 INFO - no previously-included directories found matching '.git*' 11:54:25 INFO - Installing collected packages: jsonschema, functools32 11:54:25 INFO - Running setup.py install for functools32 11:54:26 INFO - warning: no files found matching '*.txt' 11:54:26 INFO - no previously-included directories found matching 'build' 11:54:26 INFO - no previously-included directories found matching 'dist' 11:54:26 INFO - no previously-included directories found matching '.git*' 11:54:26 INFO - Successfully installed jsonschema functools32 11:54:26 INFO - Cleaning up... 11:54:26 INFO - Return code: 0 11:54:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:54:26 INFO - Using env: {'DISPLAY': ':0', 11:54:26 INFO - 'HOME': '/home/cltbld', 11:54:26 INFO - 'LANG': 'en_US.UTF-8', 11:54:26 INFO - 'LANGUAGE': 'en_US:en', 11:54:26 INFO - 'LOGNAME': 'cltbld', 11:54:26 INFO - 'MAIL': '/var/mail/cltbld', 11:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:26 INFO - 'MOZ_NO_REMOTE': '1', 11:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:26 INFO - 'NO_EM_RESTART': '1', 11:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:26 INFO - 'PWD': '/builds/slave/test', 11:54:26 INFO - 'SHELL': '/bin/bash', 11:54:26 INFO - 'SHLVL': '1', 11:54:26 INFO - 'TERM': 'linux', 11:54:26 INFO - 'TMOUT': '86400', 11:54:26 INFO - 'USER': 'cltbld', 11:54:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:26 INFO - '_': '/tools/buildbot/bin/python'} 11:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:54:26 INFO - Cleaning up... 11:54:26 INFO - Return code: 0 11:54:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:54:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:54:26 INFO - Using env: {'DISPLAY': ':0', 11:54:26 INFO - 'HOME': '/home/cltbld', 11:54:26 INFO - 'LANG': 'en_US.UTF-8', 11:54:26 INFO - 'LANGUAGE': 'en_US:en', 11:54:26 INFO - 'LOGNAME': 'cltbld', 11:54:26 INFO - 'MAIL': '/var/mail/cltbld', 11:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:26 INFO - 'MOZ_NO_REMOTE': '1', 11:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:26 INFO - 'NO_EM_RESTART': '1', 11:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:26 INFO - 'PWD': '/builds/slave/test', 11:54:26 INFO - 'SHELL': '/bin/bash', 11:54:26 INFO - 'SHLVL': '1', 11:54:26 INFO - 'TERM': 'linux', 11:54:26 INFO - 'TMOUT': '86400', 11:54:26 INFO - 'USER': 'cltbld', 11:54:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:26 INFO - '_': '/tools/buildbot/bin/python'} 11:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:28 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 11:54:29 INFO - Downloading docopt-0.6.1.tar.gz 11:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:29 INFO - Running setup.py install for blobuploader 11:54:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:29 INFO - Running setup.py install for requests 11:54:29 INFO - Running setup.py install for docopt 11:54:29 INFO - Successfully installed blobuploader requests docopt 11:54:29 INFO - Cleaning up... 11:54:29 INFO - Return code: 0 11:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:29 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:29 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 11:54:29 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 11:54:29 INFO - Using env: {'DISPLAY': ':0', 11:54:29 INFO - 'HOME': '/home/cltbld', 11:54:29 INFO - 'LANG': 'en_US.UTF-8', 11:54:29 INFO - 'LANGUAGE': 'en_US:en', 11:54:29 INFO - 'LOGNAME': 'cltbld', 11:54:29 INFO - 'MAIL': '/var/mail/cltbld', 11:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:29 INFO - 'MOZ_NO_REMOTE': '1', 11:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:29 INFO - 'NO_EM_RESTART': '1', 11:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:29 INFO - 'PWD': '/builds/slave/test', 11:54:29 INFO - 'SHELL': '/bin/bash', 11:54:29 INFO - 'SHLVL': '1', 11:54:29 INFO - 'TERM': 'linux', 11:54:29 INFO - 'TMOUT': '86400', 11:54:29 INFO - 'USER': 'cltbld', 11:54:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:29 INFO - '_': '/tools/buildbot/bin/python'} 11:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:29 INFO - Running setup.py (path:/tmp/pip-FJD6D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:30 INFO - Running setup.py (path:/tmp/pip-jaIj_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:30 INFO - Running setup.py (path:/tmp/pip-wRmE80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:30 INFO - Running setup.py (path:/tmp/pip-4LqukG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:30 INFO - Running setup.py (path:/tmp/pip-b0oYl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:30 INFO - Running setup.py (path:/tmp/pip-ql4RKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:30 INFO - Running setup.py (path:/tmp/pip-Tryujf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:30 INFO - Running setup.py (path:/tmp/pip-Colfd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:30 INFO - Running setup.py (path:/tmp/pip-k0V9Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:30 INFO - Running setup.py (path:/tmp/pip-_11Hbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:30 INFO - Running setup.py (path:/tmp/pip-pkHrIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:30 INFO - Running setup.py (path:/tmp/pip-Jpbu0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:30 INFO - Running setup.py (path:/tmp/pip-4ZTm6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:30 INFO - Running setup.py (path:/tmp/pip-sKalZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:30 INFO - Running setup.py (path:/tmp/pip-jJvvg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:31 INFO - Running setup.py (path:/tmp/pip-kNFk5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:31 INFO - Running setup.py (path:/tmp/pip-ycIkE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:31 INFO - Running setup.py install for manifestparser 11:54:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:31 INFO - Running setup.py install for mozcrash 11:54:31 INFO - Running setup.py install for mozdebug 11:54:31 INFO - Running setup.py install for mozdevice 11:54:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:31 INFO - Running setup.py install for mozfile 11:54:31 INFO - Running setup.py install for mozhttpd 11:54:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:31 INFO - Running setup.py install for mozinfo 11:54:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:31 INFO - Running setup.py install for mozInstall 11:54:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Running setup.py install for mozleak 11:54:32 INFO - Running setup.py install for mozlog 11:54:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Running setup.py install for moznetwork 11:54:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Running setup.py install for mozprocess 11:54:32 INFO - Running setup.py install for mozprofile 11:54:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Running setup.py install for mozrunner 11:54:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Running setup.py install for mozscreenshot 11:54:32 INFO - Running setup.py install for moztest 11:54:32 INFO - Running setup.py install for mozversion 11:54:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:32 INFO - Cleaning up... 11:54:33 INFO - Return code: 0 11:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:33 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:33 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 11:54:33 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 11:54:33 INFO - Using env: {'DISPLAY': ':0', 11:54:33 INFO - 'HOME': '/home/cltbld', 11:54:33 INFO - 'LANG': 'en_US.UTF-8', 11:54:33 INFO - 'LANGUAGE': 'en_US:en', 11:54:33 INFO - 'LOGNAME': 'cltbld', 11:54:33 INFO - 'MAIL': '/var/mail/cltbld', 11:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:33 INFO - 'MOZ_NO_REMOTE': '1', 11:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:33 INFO - 'NO_EM_RESTART': '1', 11:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:33 INFO - 'PWD': '/builds/slave/test', 11:54:33 INFO - 'SHELL': '/bin/bash', 11:54:33 INFO - 'SHLVL': '1', 11:54:33 INFO - 'TERM': 'linux', 11:54:33 INFO - 'TMOUT': '86400', 11:54:33 INFO - 'USER': 'cltbld', 11:54:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:33 INFO - '_': '/tools/buildbot/bin/python'} 11:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:33 INFO - Running setup.py (path:/tmp/pip-ZFYwJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:33 INFO - Running setup.py (path:/tmp/pip-ONS1Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:33 INFO - Running setup.py (path:/tmp/pip-a3KoLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:33 INFO - Running setup.py (path:/tmp/pip-qLwnA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:33 INFO - Running setup.py (path:/tmp/pip-EE6DmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:33 INFO - Running setup.py (path:/tmp/pip-Wvz8rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:33 INFO - Running setup.py (path:/tmp/pip-3LCRey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:33 INFO - Running setup.py (path:/tmp/pip-E59xo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:33 INFO - Running setup.py (path:/tmp/pip-ouX2i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:33 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:33 INFO - Running setup.py (path:/tmp/pip-F8_cHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:33 INFO - Running setup.py (path:/tmp/pip-LQTVhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:34 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)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:34 INFO - Running setup.py (path:/tmp/pip-LfVavy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:34 INFO - Running setup.py (path:/tmp/pip-5VLvNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:34 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)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:34 INFO - Running setup.py (path:/tmp/pip-3spEF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:34 INFO - Running setup.py (path:/tmp/pip-S1qo54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:34 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)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:34 INFO - Running setup.py (path:/tmp/pip-yDbMgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:34 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)) 11:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:34 INFO - Running setup.py (path:/tmp/pip-0SMvGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:34 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)) 11:54:34 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)) 11:54:34 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)) 11:54:34 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)) 11:54:34 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)) 11:54:34 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)) 11:54:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:34 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 11:54:34 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 11:54:34 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 11:54:34 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 11:54:34 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 11:54:34 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 11:54:36 INFO - Downloading blessings-1.6.tar.gz 11:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:36 INFO - Installing collected packages: blessings 11:54:36 INFO - Running setup.py install for blessings 11:54:36 INFO - Successfully installed blessings 11:54:36 INFO - Cleaning up... 11:54:36 INFO - Return code: 0 11:54:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:36 INFO - Reading from file tmpfile_stdout 11:54:36 INFO - Current package versions: 11:54:36 INFO - argparse == 1.2.1 11:54:36 INFO - blessings == 1.6 11:54:36 INFO - blobuploader == 1.2.4 11:54:36 INFO - docopt == 0.6.1 11:54:36 INFO - functools32 == 3.2.3-2 11:54:36 INFO - jsonschema == 2.5.1 11:54:36 INFO - manifestparser == 1.1 11:54:36 INFO - mozInstall == 1.12 11:54:36 INFO - mozcrash == 0.17 11:54:36 INFO - mozdebug == 0.1 11:54:36 INFO - mozdevice == 0.48 11:54:36 INFO - mozfile == 1.2 11:54:36 INFO - mozhttpd == 0.7 11:54:36 INFO - mozinfo == 0.9 11:54:36 INFO - mozleak == 0.1 11:54:36 INFO - mozlog == 3.3 11:54:36 INFO - moznetwork == 0.27 11:54:36 INFO - mozprocess == 0.23 11:54:36 INFO - mozprofile == 0.28 11:54:36 INFO - mozrunner == 6.12 11:54:36 INFO - mozscreenshot == 0.1 11:54:36 INFO - mozsystemmonitor == 0.3 11:54:36 INFO - moztest == 0.7 11:54:36 INFO - mozversion == 1.4 11:54:36 INFO - psutil == 3.1.1 11:54:36 INFO - requests == 1.2.3 11:54:36 INFO - wsgiref == 0.1.2 11:54:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:36 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')]} 11:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:36 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')]} 11:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:36 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:36 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 11:54:36 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 11:54:36 INFO - Using env: {'DISPLAY': ':0', 11:54:36 INFO - 'HOME': '/home/cltbld', 11:54:36 INFO - 'LANG': 'en_US.UTF-8', 11:54:36 INFO - 'LANGUAGE': 'en_US:en', 11:54:36 INFO - 'LOGNAME': 'cltbld', 11:54:36 INFO - 'MAIL': '/var/mail/cltbld', 11:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:36 INFO - 'MOZ_NO_REMOTE': '1', 11:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:36 INFO - 'NO_EM_RESTART': '1', 11:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:36 INFO - 'PWD': '/builds/slave/test', 11:54:36 INFO - 'SHELL': '/bin/bash', 11:54:36 INFO - 'SHLVL': '1', 11:54:36 INFO - 'TERM': 'linux', 11:54:36 INFO - 'TMOUT': '86400', 11:54:36 INFO - 'USER': 'cltbld', 11:54:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:36 INFO - '_': '/tools/buildbot/bin/python'} 11:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 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)) 11:54:37 INFO - Cleaning up... 11:54:37 INFO - Return code: 0 11:54:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:37 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 0x155e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, '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': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', '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 11:54:37 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 11:54:37 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 11:54:37 INFO - Using env: {'DISPLAY': ':0', 11:54:37 INFO - 'HOME': '/home/cltbld', 11:54:37 INFO - 'LANG': 'en_US.UTF-8', 11:54:37 INFO - 'LANGUAGE': 'en_US:en', 11:54:37 INFO - 'LOGNAME': 'cltbld', 11:54:37 INFO - 'MAIL': '/var/mail/cltbld', 11:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:37 INFO - 'MOZ_NO_REMOTE': '1', 11:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:37 INFO - 'NO_EM_RESTART': '1', 11:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:37 INFO - 'PWD': '/builds/slave/test', 11:54:37 INFO - 'SHELL': '/bin/bash', 11:54:37 INFO - 'SHLVL': '1', 11:54:37 INFO - 'TERM': 'linux', 11:54:37 INFO - 'TMOUT': '86400', 11:54:37 INFO - 'USER': 'cltbld', 11:54:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:37 INFO - '_': '/tools/buildbot/bin/python'} 11:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:54:37 INFO - Cleaning up... 11:54:37 INFO - Return code: 0 11:54:37 INFO - Running post-action listener: _resource_record_post_action 11:54:37 INFO - Running post-action listener: _start_resource_monitoring 11:54:37 INFO - Starting resource monitoring. 11:54:37 INFO - [mozharness: 2016-08-01 18:54:37.300801Z] Finished create-virtualenv step (success) 11:54:37 INFO - [mozharness: 2016-08-01 18:54:37.301349Z] Running install step. 11:54:37 INFO - Running pre-action listener: _resource_record_pre_action 11:54:37 INFO - Running main action method: install 11:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:37 INFO - Reading from file tmpfile_stdout 11:54:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:37 INFO - Reading from file tmpfile_stdout 11:54:37 INFO - Output received: 11:54:37 INFO - Usage: mozinstall [options] installer 11:54:37 INFO - Options: 11:54:37 INFO - -h, --help show this help message and exit 11:54:37 INFO - -d DEST, --destination=DEST 11:54:37 INFO - Directory to install application into. [default: 11:54:37 INFO - "/builds/slave/test"] 11:54:37 INFO - --app=APP Application being installed. [default: firefox] 11:54:37 INFO - mkdir: /builds/slave/test/build/application 11:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:54:53 INFO - Reading from file tmpfile_stdout 11:54:53 INFO - Output received: 11:54:53 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:53 INFO - Running post-action listener: _resource_record_post_action 11:54:53 INFO - [mozharness: 2016-08-01 18:54:53.569969Z] Finished install step (success) 11:54:53 INFO - [mozharness: 2016-08-01 18:54:53.570249Z] Running run-tests step. 11:54:53 INFO - Running pre-action listener: _resource_record_pre_action 11:54:53 INFO - Running main action method: run_tests 11:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:53 INFO - Python 2.7.3 11:54:53 INFO - Return code: 0 11:54:53 INFO - grabbing minidump binary from tooltool 11:54:53 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')]} 11:54:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181d3b0>, '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 0x181e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:53 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 11:54:53 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 11:54:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:54:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:53 INFO - Return code: 0 11:54:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:53 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:54:53 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 11:54:53 INFO - Using env: {'DISPLAY': ':0', 11:54:53 INFO - 'HOME': '/home/cltbld', 11:54:53 INFO - 'LANG': 'en_US.UTF-8', 11:54:53 INFO - 'LANGUAGE': 'en_US:en', 11:54:53 INFO - 'LOGNAME': 'cltbld', 11:54:53 INFO - 'MAIL': '/var/mail/cltbld', 11:54:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:53 INFO - 'MOZ_NO_REMOTE': '1', 11:54:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:53 INFO - 'NO_EM_RESTART': '1', 11:54:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:53 INFO - 'PWD': '/builds/slave/test', 11:54:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:53 INFO - 'SHELL': '/bin/bash', 11:54:53 INFO - 'SHLVL': '1', 11:54:53 INFO - 'TERM': 'linux', 11:54:53 INFO - 'TMOUT': '86400', 11:54:53 INFO - 'USER': 'cltbld', 11:54:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136', 11:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:53 INFO - '_': '/tools/buildbot/bin/python'} 11:54:53 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/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:54:53 INFO - mozversion application_buildid: 20160801085448 11:54:53 INFO - mozversion application_changeset: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 11:54:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:54:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:53 INFO - mozversion application_name: Firefox 11:54:53 INFO - mozversion application_remotingname: firefox-dev 11:54:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:54:53 INFO - mozversion application_vendor: Mozilla 11:54:53 INFO - mozversion application_version: 50.0a2 11:54:53 INFO - mozversion platform_buildid: 20160801085448 11:54:53 INFO - mozversion platform_changeset: 70ee99f185b48cb59a4ec701282bf6a3fd6ce3e3 11:54:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:54:53 INFO - mozversion platform_version: 50.0a2 11:54:53 INFO - using testdate: 1470077693 11:54:53 INFO - actual date: 1470077693 11:54:53 INFO - starting webserver on 'localhost:41792' 11:54:53 INFO - SUITE-START | Running 2 tests 11:54:53 INFO - TEST-START | dromaeo_css 11:54:53 INFO - operating with platform_type : linux_ 11:54:53 INFO - Initialising browser for dromaeo_css test... 11:54:53 INFO - TEST-INFO | started process 10908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWrjY9/profile http://localhost:41792/getInfo.html) 11:54:57 INFO - PROCESS | 10908 | __metrics Screen width/height:1600/1200 11:54:57 INFO - PROCESS | 10908 | colorDepth:24 11:54:57 INFO - PROCESS | 10908 | Browser inner width/height: 1024/697 11:54:57 INFO - PROCESS | 10908 | __metrics 11:54:58 INFO - PROCESS | 10908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:54:58 INFO - PROCESS | 10908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:54:59 INFO - TEST-INFO | 10908: exit 0 11:54:59 INFO - Browser initialized. 11:54:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:59 INFO - TEST-INFO | started process 10997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWrjY9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:11 INFO - PROCESS | 10997 | RSS: Main: 145326080 11:55:11 INFO - PROCESS | 10997 | 11:56:02 INFO - PROCESS | 10997 | 1470077762254 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] 11:58:11 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41792/tests/dromaeo/cssquery-ext.html) 11:58:12 INFO - PROCESS | 10997 | RSS: Main: 273731584 11:58:12 INFO - PROCESS | 10997 | 12:01:15 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-ext.html (next: http://localhost:41792/tests/dromaeo/cssquery-jquery.html) 12:01:15 INFO - PROCESS | 10997 | RSS: Main: 230858752 12:01:15 INFO - PROCESS | 10997 | 12:04:17 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41792/tests/dromaeo/cssquery-mootools.html) 12:04:18 INFO - PROCESS | 10997 | RSS: Main: 175116288 12:04:18 INFO - PROCESS | 10997 | 12:07:20 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41792/tests/dromaeo/cssquery-prototype.html) 12:07:20 INFO - PROCESS | 10997 | RSS: Main: 174231552 12:07:20 INFO - PROCESS | 10997 | 12:10:23 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41792/tests/dromaeo/cssquery-yui.html) 12:10:24 INFO - PROCESS | 10997 | RSS: Main: 175996928 12:10:24 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | Cycle 1(1): loaded http://localhost:41792/tests/dromaeo/cssquery-yui.html (next: http://localhost:41792/tests/dromaeo/cssquery-dojo.html) 12:13:26 INFO - PROCESS | 10997 | RSS: Main: 261586944 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | __start_tp_report 12:13:26 INFO - PROCESS | 10997 | _x_x_mozilla_page_load 12:13:26 INFO - PROCESS | 10997 | _x_x_mozilla_page_load_details 12:13:26 INFO - PROCESS | 10997 | |i|pagename|runs| 12:13:26 INFO - PROCESS | 10997 | |0;dojo.html;3279.360524697684;3300.5874265716784;3308.8345582720867;3322.8172450515212;3337.46600543913;5591.608587398884;5705.857353566163;5710.714464276785;5717.342505611856;5742.9999999999945;5602.943970560304;5646;5646.322441307038;5661.631993920402;5665.518430933365;4955.256711493269;5020.874478138039;5110.667806592578;5117.923231151536;5157.174852023677;5095.439501654815;5103.234514822788;5109.591232701375;5141.717205553693;5147.433782283946;5133.153029750087;5145;5168.508991645806;5172.40517340505;5201.141811601081;5237.8952420951555;5253.763580638881;5258.526732594066;5260.500252476008;5276.393214780311;4954.405471343462;5015.14742493777;5070.746462676888;5136.512031357015;5138.2806407103035;5580.637258578179;5606.523445507137;5611.494965453129;5614.129809879475;5650.491455768959;6076.709105592199;6077.331553306192;6086.8782624347705;6101.999550662781;6106.542009349272;5859.648421094748;5991.580589358747;5995.640261584275;6056.545759068087;6104.3590423005835;5693.886122277573;5706.115552089392;5712.65724056558;5717.142428635738;5720.828375148793;6225.937740622627;6226.875462490725;6228.564000520011;6232.065190221412;6240.095186198067;5733.483986441157;5893.086571581412;5941;5966.433188847052;6016.037434010537;6070.1125385917385;6097.756089756449;6099;6102.389761023951;6103.23709536308;6040;6045.304789949212;6048.939510604926;6049.576529642883;6049.606775559574;5817.272840894888;5949.762009519571;5959.582829201914;5968.4926781224085;6030.879382412327;4609.723416595015;4637.559431853969;4644.326572646947;4663.417072865892;4677.555632214934;4155.085881106152;4168.895777605523;4171.290880550314;4178.498580170399;4189.6438802701505;5560;5737.454941780524;5797.159411885337;5804.564657650609;5815.214945982323;6143.389059649631;6155.415235552616;6166.568340216231;6170.691465426711;6173.166622505994;5829.737661805144;5837;5839.416058394127;5840.737166827503;5859.150423188614;5042.899142017139;5166.974165129151;5191.8182863599595;5295.708736019479;5310.495502927216;6316.115743795872;6319.936800631935;6323.620582765049;6324.968375158002;6331.620102793847;6034.668093254913;6092.939070609237;6099.451049405575;6101.450869421773;6103.969480152571;6004.969975150271;6196.535259855439;6237.28271248794;6323.936760632335;6336.746530138743;5973.641581505123;5988.431099045583;5989.341172470938;6004.639721616717;6028.1861948638125;6070.7875224366935;6091.329953705001;6092.299385570716;6093.116498107661;6098.603590766586;5742.971285143548;5841.532677385884;5850.561207909339;5921.851953701192;5998.1002849572915;5849.064149736022;5906.527477801851;5908.379620139824;5937.435943585352;5946.316173640087;5856.736446859987;5859.033259512304;5864.120381942572;5864.208331875313;5865.178874957424;5823.7670493181495;5863.618864773946;5888.411158884077;5940.16837642739;5969.462748352669;5776.971115144397;5777.191193232867;5782.85542861415;5798.94201057984;5800.216970708901 12:13:26 INFO - PROCESS | 10997 | |1;ext.html;604.320139842677;624.5628060357749;638.5019684645974;648.8215740671312;665.9101021362114;34630.480542791876;37375.81312093439;37417.62582374176;37468.250634987286;45840;44081.118377632425;48344.824482898264;48367;48369.75815120919;48373;9264.166225039728;9412.764680882965;9420.38767480115;9421.717348479557;9423.81152376952;8486.66053357865;9246.907530924705;9345.859812102824;10943.23397362185;11242.66272011841;11304.321740695543;11377.488013039392;11382.373969431677;11384.943075284613;11393.943030284838;11155.498002589862;11168.329900206014;11179.161562882817;11207.943960280147;11216.383098929555;11117.777644447147;11161.776764464665;11189.384583847885;11219.775604487946;11227;45696;45820;45825.08349832985;46000.30999534976;46062.07875842464;3733.4773131761576;3763.8870833875026;3807.0672685192303;4007.338789099795;4424.336349547561;34674.6532534674;34852.477212841826;35270;35583;36482.81758591217;4713.198756211452;4761.857144285642;4768;4807.903841923142;4845.854624361275;392872;393034;394759;396391;396625;38541;61553;61846;61923.6903815487;62064.44838879064;39054.41418378727;40794.592054079076;40855.59144408518;40926.18147637031;41004.79497602553;16738.16309184536;16772.748408773878;16824.83175168257;16837;16837.91581042087;14737.115773053436;14785.556433307018;14810.925945370203;14820.62948426298;14824.110553366832;8505.829883402297;8902.599383027778;9268.490233037113;9294.86057709135;9476.763080923032;3487;3489.7208223342072;3499.2476617527354;3530.4174811156386;3537.5047493350953;986.2603047714215;1050.1524654783418;1073.7154654016692;1103.911687065049;1154.988450115505;34575.30849383049;35060.649393506246;35141.472877906854;35150;35291.294174116374;1137.6587023892798;1151.7265987392313;1181.5864447443325;1259.703969567151;1259.966827201704;17488.65022699539;17683.469495915142;17884.9105754473;17894.731579026324;17983.550411239823;689155;694138;695318;695735;697442;65070;65477;65479.67260163669;65705.67147164329;65797.67101164463;1347.5485712286297;1443.1196969848384;1473.4400927647425;1474.86726194643;1478.6229511474721;33323.83338083294;35274.64725352714;35962.28075438529;36012.09969750777;36080.27839443249;54140.45859541354;54833;54905.72547137239;54910.17634735562;54946;463551;465117;465283;465503;466310;30350.48247587656;32075.037748867573;32134.678653214105;33215.169620759676;33367.33265334631;51034.489655102974;51062;51078.48921510737;51107.744461277456;52483;42269.154616906875;42948.35577466403;43057.138857223305;43893.341599876665;44352.55647443613;43004.56995430131;43441.78279108584;43921.78039109912;44648;44730;43112.78443607762;43466.34800477932;43671;44456.55543444524;45625;36525.63474365329;39653.80173099116;40024.1995160101;40130.59869401269;40260;29923.251918702208;30296.394072118874;30355.2411189722;30417.695823041486;30832.229194270323 12:13:26 INFO - PROCESS | 10997 | |2;jquery.html;388.81142645816794;409.4390684761877;421.53631005893516;428.75132423194543;438.62278440541127;15186.924065379671;19951.40145795625;20418.897905510472;20454.693179602316;21130.260440884573;20075.799242007575;20183.09176087076;20212.595748085067;20220.19119235229;20346.796532034674;5883.499902508292;5917.49701275391;6022.096685497167;6046.455818976291;6062.787802426916;5962.731677074542;6034.788782392618;6054.091886217058;6060.393960603927;6061.545384096188;5986.700664966756;6226;6264.874702505947;6342.6511541865175;6348.682565871711;6269.937300627003;6287.308396076428;6298.181236439256;6632.071509988606;6873.931260687379;6142.754289828402;6160.383961603849;6162.599431036968;6164.722587483574;6165.969170154165;14777.630559235997;17470.563235919202;20027.399178024538;24907.128250511327;25008.49983000348;2498.4003839078673;2525.532776436365;2527.734587868266;2540.6951165860214;2556.9360765980814;10356.412940531425;10834.512446939907;10941.56233750649;11308.434578271135;11404.828927566094;1975.1111999600237;2060.5825204041507;2095.067694875781;2140.818030467412;2153.1817909194406;62053.6897315515;64465.67767161134;75968.62015689997;85406.57296713477;86786.13213867844;11436.885631143748;11464.140189485823;11522;11562.710932226762;11781.293122412511;16470.75293870593;16485.752713709066;16508.587285317964;16512.33950641985;16537.173141342886;8691.652333906699;8749.825003499895;8839.806626105523;8889.111088891059;9103.590338434786;8754.51850148248;8786.824263514694;8805.647774089093;8892.777680558038;9035.864462033074;4944.876378090505;4954.801807927714;4991.650584459053;4999.375078115236;5086.160783470686;2025.1291944464022;2026.973026973027;2041.5508588110592;2069.513664288891;2095.779943105952;960.577345967772;973.8344481438172;976.1019861727228;987.5555999799975;1069.4759567811716;20221.39335819928;20548.178072877217;20620.381388558366;20656.27703030417;20677.17291308331;1024.6669832304383;1040.958361665525;1063.1760385701143;1102.2669924500278;1138.9943050284696;10599.735006624896;11603;11604.6518604442;11605.535778568932;11648.53405863773;592583;608585;609878;615513;621401;95844;97585;101897.49051254697;107605.46197268963;107660;1069.1446842525947;1085.451846817368;1116.6705821782593;1117.6870476266495;1140.6007897235902;17396.47810565685;18227.54431139232;18412.907935460236;18600.627987439904;18884.716729248797;45822.77088614536;46116.53883461257;46416.76791616021;47343.526564735286;47800;67711;68005.65997169983;68203.3179668197;69329;69882.65058674673;8924.821503570021;8941.239994600272;9066.727998160066;9116.772080698036;9185.862212066959;10234.283600148216;13636.79544806809;13742.93128534351;13795.931020344835;14236.288185590885;12218.938905305416;12335.259884406963;12373.876261237632;12385.263986214275;12634.178778379375;11211.55153793839;11517.136214784092;11866.821997670215;11910.166288359731;12555.372231388212;11334.829977550178;11474.713132171762;11675.182737208313;11699.707507312385;12356.196847204903;8893.333000024895;8960.283177345927;8963.507007114671;8967.417117887317;9089.639626160968;10575.312604680672;11709;11859.644210673694;11912.642620721392;12184 12:13:26 INFO - PROCESS | 10997 | |3;mootools.html;1390.2492653966856;1412.5832879300606;1495.8578935001176;1609.702205092058;1883.8492920566348;8883.60023798929;9316.347855650107;9363.6254549818;9640.325177237597;9655.27585431092;9497.952510237457;9599.232061435087;9600.42397456153;9611.95194024029;9627.37422067565;2481.689788776403;2504.0860086068637;2514.937126571832;2517.093846215361;2519.911803086892;2432.075811191745;2471.0733474946896;2472.184179220862;2474.0845887021737;2475;2411.0837881604966;2425.151197081025;2429.708434987804;2433.6227884677905;2444.3155916343453;2388.5581167483983;2412.601920683085;2421.806255499556;2423.8545687258734;2429.5505331513727;2390.605550084234;2401.1955994741784;2404.0864471500718;2406.121765555577;2417.903283868643;9402.62389504419;9485.33602647815;9488.95255523718;9552.522373881347;9554.665586704501;5622.690752008638;5863.032599621058;5872.530197584183;5883.735231914574;5888.116782482619;3576.195356044895;3626.4197728363333;3656.9634303657153;3691.1325838427947;3698.149425632093;1200.099925056208;1222.584321330752;1257.3210466348253;1291.9935400323031;1302.4269321498605;13337.73324533504;13346.866531334757;13385.129966552144;13408.932955335162;13419.932900335436;4794.161021821237;4794.904101917942;4851.690043688184;4889.144399730033;4967.726775027336;10648.78702425947;10660.200484963503;10664.093552048007;10670.35977841332;10673.946630266953;5634.32388113429;5634.7182640867795;5635.408282130399;5635.520980716685;5638.154276858422;4620.075984802986;4770.379850619467;5234.057869583511;5279.208118782137;5292.073887069748;3898.7270891037356;3946.8618598349494;3992.740471869319;4005.2790497710107;4038.172174704179;1215.1008253892232;1222.4682263215352;1235.5428491458038;1245.0413181849924;1254.6047994881583;940.520334629344;1023.2274632652449;1042.1454407386022;1064.2177999170603;1064.292245656645;6456.12842266288;6520.576162549419;6530.412262896362;6768.593884366954;6873;475.7716296177854;490.4090570862103;497.55220301728735;499.64774833742126;502.22406382139684;4577.382053422745;4639.2113340731485;4645.741071917774;4733.053389322149;4773.880652983703;11808.58669946565;12202.633920982385;12308.938455307667;12317.322547259808;12335.938320308342;11254.943725281484;12226.083043771752;12229.26624402521;12236.204646697935;12242.938785306194;8691.391602587884;9094.81810363789;9106.089391060974;9122.86315705265;9139.95430022859;6144.815655530341;6154.169187159855;6313.40022697843;6411.711472983634;6444.9033264502;11144;11268.042216411697;11286.322820630789;11400.087992960709;11422.828657569977;10239.43683097407;10418.739531511774;10724.088452481627;11500.884991149982;11607.535698571963;8251.174882511701;8255.793605159919;8696.130386961506;8702.390832641655;8709.608067637098;9224.446533208029;9374.109459601326;9416.435013899189;9424.670136545188;9429.292803039662;8287.337013038821;8474.322054235523;8476.49141051539;8510.063892971644;8636.524991125549;8354.540500272544;8377.916220837713;8404.663813447394;8417;8534.231919127309;7786.7663970080985;7802.609869506616;7804.609769511389;7804.609769511615;7905.960470197612;5124.897502050013;5706.372299047184;5804.332501762351;5839.445252700986;6072.180255665428;5483.862903427446;5579.302587176603;5755.942440575541;5825.097109947965;5954.7915822947725 12:13:26 INFO - PROCESS | 10997 | |4;prototype.html;352.7231123567999;359.5379936781236;361.2287765620403;361.97104231661467;364.75743630485726;5484.451554844519;5569.972150139249;5574.191742197384;5585.832425027245;5628.296462942132;5343;5453.863653408666;5515.503604675579;5524.447555244484;5531.585131115163;4324.875532361577;4370.235208838457;4374.562543745624;4386.605205531501;4402.7578483183415;4372.3878656988045;4373.890652733691;4375.643550499355;4379.496357918848;4398.340248962665;4310.82756689732;4314.525402205755;4315.266404711207;4344.391785150082;4345.261305578059;4202;4302.634276086536;4325.178216138924;4345.152695224432;4346.391505189276;3869.800361887824;3879.2349480986086;3881.573026967031;3883.8058097095313;3894.7078969077147;5276.1030624793875;5327.17428798533;5328.909232645056;5351.491608297206;5359.866003349908;4783.330333753277;4905.386826646669;4916.901661966776;4992.176290911995;5016.77424515894;5724.4561766632105;5747.798827041075;5756.194132821408;5757.798477053325;5821.79623713168;4228.386883901817;4232.873013809591;4240.936385954213;4296.355546667994;4305.160493703729;5649.293838270216;5659.179418984266;5703.287089113902;5977.701114944279;6051;4181.874543763692;4218.282891908383;4218.8312467500955;4248.299030659907;4265.829366825355;4318.438602981592;4327.134573085333;4330.488316776262;4339.284018137035;4346.304591265382;4633.606143477842;4771.594414474808;4855;4939.259111133287;4950.356453661073;5727.398623144593;5739.081746920473;5750.338711048199;5763.674354898397;5783.826485205451;1477.601047717132;1496.8428315026983;1505.9472918447802;1511.8790496760232;1513.0770230159594;972.2902281334665;980.8136454073846;983.7653744550544;1041.890601486848;1050.7635781949;5523.088690366045;5524.502794748492;5526.618345413646;5526.917096243479;5551.500364967173;5779.624324418899;5781.479666830005;5791.69686820462;5839.598496360843;5841.649501029951;5282.418933917266;5447.754851031713;5462.644928079662;5504.862378440571;5548.944510554843;3039.1794215561677;3070.646875609289;3071.447139514864;3072.738817200563;3082.9845850770603;5897.144913987534;5968.432998865101;5995.370486098984;6010;6027.126066720389;5819.73811178498;5847.871388806968;5886.470217680429;5893.6463812171405;5916.556258280646;5853.1220316952795;5874.1776151338845;5923.259592550931;5943.9790471239985;5982.132590774313;5552.390376523028;5762.538996880324;5831.620944638585;5895.41045895407;5896.292444906639;5842.415758424124;5850.864434481468;5856.707164641836;5858.736356863866;5862.149988251765;5885.646861188342;5950.642961422329;6067;6114.541409394402;6114.6636934969;4264.936025959551;4304.3543468479975;4309.870703878889;4341.6743744218675;4343.978280108579;5786.768529258782;5922.378150294157;6003.219581454383;6004.339522652417;6028.336882942785;5726;5748.655080695172;5750.453706897838;5750.712464376848;5786.247787787561;5746.166805813217;5752.539796816328;5798.884022319446;5809.564282678901;5830.766769329349;5449.291592093003;5666.829995100154;5686.014842207874;5688.914666280092;5780.814932938653;5752.33848107473;5776.534079552235;5822.3304320003745;5823.806119745357;5837.795677151279;5478.058848750118;5647.3787883333625;5664.433556644302;5686.260786097946;5717.171010203414 12:13:26 INFO - PROCESS | 10997 | |5;yui.html;821.7165078048073;834.1033389106711;871.8169184471261;898.2275243290773;918.5774543709894;16891.49325520235;17384;17479;17536.298548058094;17580.736288955675;15994.60013499663;16116.516504504883;16128.83871161288;16141.596460088504;16150.676986460263;733.6808488307577;835.995820020899;871.1462766488861;881.2509367037999;887.9600417981175;897.2149369301861;899.7660608241872;900.6847603338845;901.062894589626;901.1124042817819;951.5670369981642;953.1850268020846;953.7901661634429;954.0554850697794;954.308126608207;777.0713996773829;903.259327351572;922.0687106022965;922.5064590444114;933.0576118120679;682.4267615203204;682.7269092363044;683.1665368250776;683.3576438148175;683.4976292425064;15529.068255904682;15544.455944042018;15552.377904883791;15565.37738490459;15579.922100389425;15614.45349412765;15649.530514084596;15727.68544629101;15938.920305398398;16143.919280403523;13891.02762806604;14454.566363009126;14461.855381446261;14468;14596.489122880648;4637.234856248715;4708.0819240248165;4759.428868535763;4761.119192949281;4800.879978000543;84967.57516212441;85737;86606;87198.12801871964;87498.56250718706;12522.123451358317;12661.36693165338;12672.683182920317;12924.03069769771;12948.935255323662;24084.39789005289;24256.636150457758;24286.87856560741;24292.878535607208;24314.513709725707;9018.594163262538;9219.400738951947;9291.535423228812;9409.379416420716;9597;5193.532582067632;5255.369355677343;5291.3385826771655;5375.569954403638;5481.588880833874;3711.3505136601525;3887.047673319998;3897.707671924617;3904;3904.6290602393296;684.3430306905426;689.9793006209821;698.2668198391668;700.7757517594423;706.1420374245214;617.9721912513947;621.5183232994466;622.4335854372499;629.3674856768918;649.233903993283;9575.425474471554;10135.442550659636;10415.791684166274;10436;10655.200859935536;637.8086574027773;644.3878315600105;682.494953734243;723.2044750774106;742.6435311050726;4546.909061818811;4702.224133018014;4759.833405830779;4766.094442055998;4782.5456581625385;102595;104637.87800103943;106950.46524767482;118609;119395;95930.52034739782;96022;96383;98737.50631246797;99870.5006474963;64897.67551162214;86114.56942715247;90921;90980.5450972741;91467.08532914719;10367.9782442423;10691.663542057242;10935.398553079656;10968.725781855517;11011.72470688207;54257.72871135777;54742.178867317816;54785.45214547803;54950;57007.42992570187;80544;81754.59122704586;82422;83901;84717.1528284734;13996.090254133449;14127.434902604193;14147.02771735905;14246.572602821932;14510.492132775724;9950.55222514974;14881.255937203314;14951;15141.470048548248;15353.155576443403;12868.420921058761;12986.155899866479;13153.408096635483;13776.862231377558;13836.169829810244;13033.47866085346;13119;13215.207087574776;13287.06990510655;13305.467781289028;13252.602421927357;13520.6619834501;13561.728765424834;13588.116772409761;13718.108322958975;10451.843222351823;11000;11042.33745975244;11163.497642606264;11164.944175279072;11473.942630287129;11667.533298667959;11685.591004314809;11793.193263579222;11928.701782455508 12:13:26 INFO - PROCESS | 10997 | __end_tp_report 12:13:26 INFO - PROCESS | 10997 | __start_cc_report 12:13:26 INFO - PROCESS | 10997 | _x_x_mozilla_cycle_collect,1123 12:13:26 INFO - PROCESS | 10997 | __end_cc_report 12:13:26 INFO - PROCESS | 10997 | __startTimestamp1470078806730__endTimestamp 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | ------- Summary: start ------- 12:13:26 INFO - PROCESS | 10997 | Number of tests: 6 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#0] dojo.html Cycles:165 Average:5629.54 Median:5840.74 stddev:636.48 (10.9%) stddev-sans-first:611.14 12:13:26 INFO - PROCESS | 10997 | Values: 3279.4 3300.6 3308.8 3322.8 3337.5 5591.6 5705.9 5710.7 5717.3 5743.0 5602.9 5646.0 5646.3 5661.6 5665.5 4955.3 5020.9 5110.7 5117.9 5157.2 5095.4 5103.2 5109.6 5141.7 5147.4 5133.2 5145.0 5168.5 5172.4 5201.1 5237.9 5253.8 5258.5 5260.5 5276.4 4954.4 5015.1 5070.7 5136.5 5138.3 5580.6 5606.5 5611.5 5614.1 5650.5 6076.7 6077.3 6086.9 6102.0 6106.5 5859.6 5991.6 5995.6 6056.5 6104.4 5693.9 5706.1 5712.7 5717.1 5720.8 6225.9 6226.9 6228.6 6232.1 6240.1 5733.5 5893.1 5941.0 5966.4 6016.0 6070.1 6097.8 6099.0 6102.4 6103.2 6040.0 6045.3 6048.9 6049.6 6049.6 5817.3 5949.8 5959.6 5968.5 6030.9 4609.7 4637.6 4644.3 4663.4 4677.6 4155.1 4168.9 4171.3 4178.5 4189.6 5560.0 5737.5 5797.2 5804.6 5815.2 6143.4 6155.4 6166.6 6170.7 6173.2 5829.7 5837.0 5839.4 5840.7 5859.2 5042.9 5167.0 5191.8 5295.7 5310.5 6316.1 6319.9 6323.6 6325.0 6331.6 6034.7 6092.9 6099.5 6101.5 6104.0 6005.0 6196.5 6237.3 6323.9 6336.7 5973.6 5988.4 5989.3 6004.6 6028.2 6070.8 6091.3 6092.3 6093.1 6098.6 5743.0 5841.5 5850.6 5921.9 5998.1 5849.1 5906.5 5908.4 5937.4 5946.3 5856.7 5859.0 5864.1 5864.2 5865.2 5823.8 5863.6 5888.4 5940.2 5969.5 5777.0 5777.2 5782.9 5798.9 5800.2 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#1] ext.html Cycles:180 Average:67292.21 Median:218139.40 stddev:142465.67 (65.3%) stddev-sans-first:142777.34 12:13:26 INFO - PROCESS | 10997 | Values: 604.3 624.6 638.5 648.8 665.9 34630.5 37375.8 37417.6 37468.3 45840.0 44081.1 48344.8 48367.0 48369.8 48373.0 9264.2 9412.8 9420.4 9421.7 9423.8 8486.7 9246.9 9345.9 10943.2 11242.7 11304.3 11377.5 11382.4 11384.9 11393.9 11155.5 11168.3 11179.2 11207.9 11216.4 11117.8 11161.8 11189.4 11219.8 11227.0 45696.0 45820.0 45825.1 46000.3 46062.1 3733.5 3763.9 3807.1 4007.3 4424.3 34674.7 34852.5 35270.0 35583.0 36482.8 4713.2 4761.9 4768.0 4807.9 4845.9 392872.0 393034.0 394759.0 396391.0 396625.0 38541.0 61553.0 61846.0 61923.7 62064.4 39054.4 40794.6 40855.6 40926.2 41004.8 16738.2 16772.7 16824.8 16837.0 16837.9 14737.1 14785.6 14810.9 14820.6 14824.1 8505.8 8902.6 9268.5 9294.9 9476.8 3487.0 3489.7 3499.2 3530.4 3537.5 986.3 1050.2 1073.7 1103.9 1155.0 34575.3 35060.6 35141.5 35150.0 35291.3 1137.7 1151.7 1181.6 1259.7 1260.0 17488.7 17683.5 17884.9 17894.7 17983.6 689155.0 694138.0 695318.0 695735.0 697442.0 65070.0 65477.0 65479.7 65705.7 65797.7 1347.5 1443.1 1473.4 1474.9 1478.6 33323.8 35274.6 35962.3 36012.1 36080.3 54140.5 54833.0 54905.7 54910.2 54946.0 463551.0 465117.0 465283.0 465503.0 466310.0 30350.5 32075.0 32134.7 33215.2 33367.3 51034.5 51062.0 51078.5 51107.7 52483.0 42269.2 42948.4 43057.1 43893.3 44352.6 43004.6 43441.8 43921.8 44648.0 44730.0 43112.8 43466.3 43671.0 44456.6 45625.0 36525.6 39653.8 40024.2 40130.6 40260.0 29923.3 30296.4 30355.2 30417.7 30832.2 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#2] jquery.html Cycles:180 Average:33163.68 Median:2147.00 stddev:100153.47 (4664.8%) stddev-sans-first:100404.19 12:13:26 INFO - PROCESS | 10997 | Values: 388.8 409.4 421.5 428.8 438.6 15186.9 19951.4 20418.9 20454.7 21130.3 20075.8 20183.1 20212.6 20220.2 20346.8 5883.5 5917.5 6022.1 6046.5 6062.8 5962.7 6034.8 6054.1 6060.4 6061.5 5986.7 6226.0 6264.9 6342.7 6348.7 6269.9 6287.3 6298.2 6632.1 6873.9 6142.8 6160.4 6162.6 6164.7 6166.0 14777.6 17470.6 20027.4 24907.1 25008.5 2498.4 2525.5 2527.7 2540.7 2556.9 10356.4 10834.5 10941.6 11308.4 11404.8 1975.1 2060.6 2095.1 2140.8 2153.2 62053.7 64465.7 75968.6 85406.6 86786.1 11436.9 11464.1 11522.0 11562.7 11781.3 16470.8 16485.8 16508.6 16512.3 16537.2 8691.7 8749.8 8839.8 8889.1 9103.6 8754.5 8786.8 8805.6 8892.8 9035.9 4944.9 4954.8 4991.7 4999.4 5086.2 2025.1 2027.0 2041.6 2069.5 2095.8 960.6 973.8 976.1 987.6 1069.5 20221.4 20548.2 20620.4 20656.3 20677.2 1024.7 1041.0 1063.2 1102.3 1139.0 10599.7 11603.0 11604.7 11605.5 11648.5 592583.0 608585.0 609878.0 615513.0 621401.0 95844.0 97585.0 101897.5 107605.5 107660.0 1069.1 1085.5 1116.7 1117.7 1140.6 17396.5 18227.5 18412.9 18600.6 18884.7 45822.8 46116.5 46416.8 47343.5 47800.0 67711.0 68005.7 68203.3 69329.0 69882.7 8924.8 8941.2 9066.7 9116.8 9185.9 10234.3 13636.8 13742.9 13795.9 14236.3 12218.9 12335.3 12373.9 12385.3 12634.2 11211.6 11517.1 11866.8 11910.2 12555.4 11334.8 11474.7 11675.2 11699.7 12356.2 8893.3 8960.3 8963.5 8967.4 9089.6 10575.3 11709.0 11859.6 11912.6 12184.0 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#3] mootools.html Cycles:180 Average:6288.31 Median:4772.13 stddev:3652.26 (76.5%) stddev-sans-first:3643.95 12:13:26 INFO - PROCESS | 10997 | Values: 1390.2 1412.6 1495.9 1609.7 1883.8 8883.6 9316.3 9363.6 9640.3 9655.3 9498.0 9599.2 9600.4 9612.0 9627.4 2481.7 2504.1 2514.9 2517.1 2519.9 2432.1 2471.1 2472.2 2474.1 2475.0 2411.1 2425.2 2429.7 2433.6 2444.3 2388.6 2412.6 2421.8 2423.9 2429.6 2390.6 2401.2 2404.1 2406.1 2417.9 9402.6 9485.3 9489.0 9552.5 9554.7 5622.7 5863.0 5872.5 5883.7 5888.1 3576.2 3626.4 3657.0 3691.1 3698.1 1200.1 1222.6 1257.3 1292.0 1302.4 13337.7 13346.9 13385.1 13408.9 13419.9 4794.2 4794.9 4851.7 4889.1 4967.7 10648.8 10660.2 10664.1 10670.4 10673.9 5634.3 5634.7 5635.4 5635.5 5638.2 4620.1 4770.4 5234.1 5279.2 5292.1 3898.7 3946.9 3992.7 4005.3 4038.2 1215.1 1222.5 1235.5 1245.0 1254.6 940.5 1023.2 1042.1 1064.2 1064.3 6456.1 6520.6 6530.4 6768.6 6873.0 475.8 490.4 497.6 499.6 502.2 4577.4 4639.2 4645.7 4733.1 4773.9 11808.6 12202.6 12308.9 12317.3 12335.9 11254.9 12226.1 12229.3 12236.2 12242.9 8691.4 9094.8 9106.1 9122.9 9140.0 6144.8 6154.2 6313.4 6411.7 6444.9 11144.0 11268.0 11286.3 11400.1 11422.8 10239.4 10418.7 10724.1 11500.9 11607.5 8251.2 8255.8 8696.1 8702.4 8709.6 9224.4 9374.1 9416.4 9424.7 9429.3 8287.3 8474.3 8476.5 8510.1 8636.5 8354.5 8377.9 8404.7 8417.0 8534.2 7786.8 7802.6 7804.6 7804.6 7906.0 5124.9 5706.4 5804.3 5839.4 6072.2 5483.9 5579.3 5755.9 5825.1 5954.8 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#4] prototype.html Cycles:180 Average:4849.58 Median:5526.77 stddev:1397.99 (25.3%) stddev-sans-first:1360.55 12:13:26 INFO - PROCESS | 10997 | Values: 352.7 359.5 361.2 362.0 364.8 5484.5 5570.0 5574.2 5585.8 5628.3 5343.0 5453.9 5515.5 5524.4 5531.6 4324.9 4370.2 4374.6 4386.6 4402.8 4372.4 4373.9 4375.6 4379.5 4398.3 4310.8 4314.5 4315.3 4344.4 4345.3 4202.0 4302.6 4325.2 4345.2 4346.4 3869.8 3879.2 3881.6 3883.8 3894.7 5276.1 5327.2 5328.9 5351.5 5359.9 4783.3 4905.4 4916.9 4992.2 5016.8 5724.5 5747.8 5756.2 5757.8 5821.8 4228.4 4232.9 4240.9 4296.4 4305.2 5649.3 5659.2 5703.3 5977.7 6051.0 4181.9 4218.3 4218.8 4248.3 4265.8 4318.4 4327.1 4330.5 4339.3 4346.3 4633.6 4771.6 4855.0 4939.3 4950.4 5727.4 5739.1 5750.3 5763.7 5783.8 1477.6 1496.8 1505.9 1511.9 1513.1 972.3 980.8 983.8 1041.9 1050.8 5523.1 5524.5 5526.6 5526.9 5551.5 5779.6 5781.5 5791.7 5839.6 5841.6 5282.4 5447.8 5462.6 5504.9 5548.9 3039.2 3070.6 3071.4 3072.7 3083.0 5897.1 5968.4 5995.4 6010.0 6027.1 5819.7 5847.9 5886.5 5893.6 5916.6 5853.1 5874.2 5923.3 5944.0 5982.1 5552.4 5762.5 5831.6 5895.4 5896.3 5842.4 5850.9 5856.7 5858.7 5862.1 5885.6 5950.6 6067.0 6114.5 6114.7 4264.9 4304.4 4309.9 4341.7 4344.0 5786.8 5922.4 6003.2 6004.3 6028.3 5726.0 5748.7 5750.5 5750.7 5786.2 5746.2 5752.5 5798.9 5809.6 5830.8 5449.3 5666.8 5686.0 5688.9 5780.8 5752.3 5776.5 5822.3 5823.8 5837.8 5478.1 5647.4 5664.4 5686.3 5717.2 12:13:26 INFO - PROCESS | 10997 | 12:13:26 INFO - PROCESS | 10997 | [#5] yui.html Cycles:180 Average:21673.26 Median:4705.15 stddev:30399.84 (646.1%) stddev-sans-first:30444.80 12:13:26 INFO - PROCESS | 10997 | Values: 821.7 834.1 871.8 898.2 918.6 16891.5 17384.0 17479.0 17536.3 17580.7 15994.6 16116.5 16128.8 16141.6 16150.7 733.7 836.0 871.1 881.3 888.0 897.2 899.8 900.7 901.1 901.1 951.6 953.2 953.8 954.1 954.3 777.1 903.3 922.1 922.5 933.1 682.4 682.7 683.2 683.4 683.5 15529.1 15544.5 15552.4 15565.4 15579.9 15614.5 15649.5 15727.7 15938.9 16143.9 13891.0 14454.6 14461.9 14468.0 14596.5 4637.2 4708.1 4759.4 4761.1 4800.9 84967.6 85737.0 86606.0 87198.1 87498.6 12522.1 12661.4 12672.7 12924.0 12948.9 24084.4 24256.6 24286.9 24292.9 24314.5 9018.6 9219.4 9291.5 9409.4 9597.0 5193.5 5255.4 5291.3 5375.6 5481.6 3711.4 3887.0 3897.7 3904.0 3904.6 684.3 690.0 698.3 700.8 706.1 618.0 621.5 622.4 629.4 649.2 9575.4 10135.4 10415.8 10436.0 10655.2 637.8 644.4 682.5 723.2 742.6 4546.9 4702.2 4759.8 4766.1 4782.5 102595.0 104637.9 106950.5 118609.0 119395.0 95930.5 96022.0 96383.0 98737.5 99870.5 64897.7 86114.6 90921.0 90980.5 91467.1 10368.0 10691.7 10935.4 10968.7 11011.7 54257.7 54742.2 54785.5 54950.0 57007.4 80544.0 81754.6 82422.0 83901.0 84717.2 13996.1 14127.4 14147.0 14246.6 14510.5 9950.6 14881.3 14951.0 15141.5 15353.2 12868.4 12986.2 13153.4 13776.9 13836.2 13033.5 13119.0 13215.2 13287.1 13305.5 13252.6 13520.7 13561.7 13588.1 13718.1 10451.8 11000.0 11042.3 11163.5 11164.9 11473.9 11667.5 11685.6 11793.2 11928.7 12:13:26 INFO - PROCESS | 10997 | -------- Summary: end -------- 12:13:26 INFO - PROCESS | 10997 | 12:13:27 INFO - TEST-INFO | 10997: exit 0 12:13:27 INFO - TEST-OK | dromaeo_css | took 1113672ms 12:13:27 INFO - TEST-START | kraken 12:13:27 INFO - operating with platform_type : linux_ 12:13:27 INFO - Initialising browser for kraken test... 12:13:27 INFO - TEST-INFO | started process 11205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAhS0w/profile http://localhost:41792/getInfo.html) 12:13:31 INFO - PROCESS | 11205 | __metrics Screen width/height:1600/1200 12:13:31 INFO - PROCESS | 11205 | colorDepth:24 12:13:31 INFO - PROCESS | 11205 | Browser inner width/height: 1024/697 12:13:31 INFO - PROCESS | 11205 | __metrics 12:13:32 INFO - PROCESS | 11205 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:13:32 INFO - PROCESS | 11205 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:13:33 INFO - TEST-INFO | 11205: exit 0 12:13:33 INFO - Browser initialized. 12:13:33 INFO - Running cycle 1/1 for kraken test... 12:13:33 INFO - TEST-INFO | started process 11293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnAhS0w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:45 INFO - PROCESS | 11293 | RSS: Main: 145342464 12:13:45 INFO - PROCESS | 11293 | 12:13:47 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:48 INFO - PROCESS | 11293 | RSS: Main: 192311296 12:13:48 INFO - PROCESS | 11293 | 12:13:51 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-dft) 12:13:51 INFO - PROCESS | 11293 | RSS: Main: 181231616 12:13:51 INFO - PROCESS | 11293 | 12:13:54 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-fft) 12:13:55 INFO - PROCESS | 11293 | RSS: Main: 269062144 12:13:55 INFO - PROCESS | 11293 | 12:13:57 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41792/tests/kraken/driver.html?testName=audio-oscillator) 12:13:57 INFO - PROCESS | 11293 | RSS: Main: 176066560 12:13:57 INFO - PROCESS | 11293 | 12:13:59 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:14:00 INFO - PROCESS | 11293 | RSS: Main: 177557504 12:14:00 INFO - PROCESS | 11293 | 12:14:03 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-darkroom) 12:14:04 INFO - PROCESS | 11293 | RSS: Main: 213184512 12:14:04 INFO - PROCESS | 11293 | 12:14:07 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41792/tests/kraken/driver.html?testName=imaging-desaturate) 12:14:08 INFO - PROCESS | 11293 | RSS: Main: 211693568 12:14:08 INFO - PROCESS | 11293 | 12:14:10 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41792/tests/kraken/driver.html?testName=json-parse-financial) 12:14:11 INFO - PROCESS | 11293 | RSS: Main: 212144128 12:14:11 INFO - PROCESS | 11293 | 12:14:13 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:14:13 INFO - PROCESS | 11293 | RSS: Main: 176238592 12:14:13 INFO - PROCESS | 11293 | 12:14:15 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:14:16 INFO - PROCESS | 11293 | RSS: Main: 181268480 12:14:16 INFO - PROCESS | 11293 | 12:14:17 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:14:18 INFO - PROCESS | 11293 | RSS: Main: 186105856 12:14:18 INFO - PROCESS | 11293 | 12:14:21 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:21 INFO - PROCESS | 11293 | RSS: Main: 180256768 12:14:21 INFO - PROCESS | 11293 | 12:14:24 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:25 INFO - PROCESS | 11293 | RSS: Main: 184422400 12:14:25 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | Cycle 1(1): loaded http://localhost:41792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41792/tests/kraken/driver.html?testName=ai-astar) 12:14:26 INFO - PROCESS | 11293 | RSS: Main: 235868160 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | __start_tp_report 12:14:26 INFO - PROCESS | 11293 | _x_x_mozilla_page_load 12:14:26 INFO - PROCESS | 11293 | _x_x_mozilla_page_load_details 12:14:26 INFO - PROCESS | 11293 | |i|pagename|runs| 12:14:26 INFO - PROCESS | 11293 | |0;ai-astar;102;108;109;108;109;109;109;109;108;108 12:14:26 INFO - PROCESS | 11293 | |1;audio-beat-detection;145;116;116;190;116;118;141;115;148;115 12:14:26 INFO - PROCESS | 11293 | |2;audio-dft;161;161;161;160;161;162;159;161;159;161 12:14:26 INFO - PROCESS | 11293 | |3;audio-fft;74;75;75;128;75;75;76;76;108;74 12:14:26 INFO - PROCESS | 11293 | |4;audio-oscillator;83;84;114;84;83;84;119;83;83;126 12:14:26 INFO - PROCESS | 11293 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;117;116 12:14:26 INFO - PROCESS | 11293 | |6;imaging-darkroom;146;145;146;145;146;146;145;146;146;145 12:14:26 INFO - PROCESS | 11293 | |7;imaging-desaturate;95;95;94;95;96;95;95;94;95;95 12:14:26 INFO - PROCESS | 11293 | |8;json-parse-financial;50;49;49;49;50;50;49;50;50;49 12:14:26 INFO - PROCESS | 11293 | |9;json-stringify-tinderbox;59;60;59;59;59;59;59;60;59;60 12:14:26 INFO - PROCESS | 11293 | |10;stanford-crypto-aes;71;72;72;72;78;72;71;72;72;73 12:14:26 INFO - PROCESS | 11293 | |11;stanford-crypto-ccm;120;126;117;119;117;115;116;115;186;118 12:14:26 INFO - PROCESS | 11293 | |12;stanford-crypto-pbkdf2;155;152;154;152;158;154;150;155;152;152 12:14:26 INFO - PROCESS | 11293 | |13;stanford-crypto-sha256-iterative;65;62;62;63;60;62;62;61;60;61 12:14:26 INFO - PROCESS | 11293 | __end_tp_report 12:14:26 INFO - PROCESS | 11293 | __start_cc_report 12:14:26 INFO - PROCESS | 11293 | _x_x_mozilla_cycle_collect,1646 12:14:26 INFO - PROCESS | 11293 | __end_cc_report 12:14:26 INFO - PROCESS | 11293 | __startTimestamp1470078866857__endTimestamp 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | ------- Summary: start ------- 12:14:26 INFO - PROCESS | 11293 | Number of tests: 14 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:2.13 (2.0%) stddev-sans-first:0.53 12:14:26 INFO - PROCESS | 11293 | Values: 102.0 108.0 109.0 108.0 109.0 109.0 109.0 109.0 108.0 108.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:129.50 stddev:24.52 (18.9%) stddev-sans-first:25.55 12:14:26 INFO - PROCESS | 11293 | Values: 145.0 116.0 116.0 190.0 116.0 118.0 141.0 115.0 148.0 115.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 12:14:26 INFO - PROCESS | 11293 | Values: 161.0 161.0 161.0 160.0 161.0 162.0 159.0 161.0 159.0 161.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:18.75 (25.0%) stddev-sans-first:19.56 12:14:26 INFO - PROCESS | 11293 | Values: 74.0 75.0 75.0 128.0 75.0 75.0 76.0 76.0 108.0 74.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:83.00 stddev:17.74 (21.4%) stddev-sans-first:18.34 12:14:26 INFO - PROCESS | 11293 | Values: 83.0 84.0 114.0 84.0 83.0 84.0 119.0 83.0 83.0 126.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:14:26 INFO - PROCESS | 11293 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:14:26 INFO - PROCESS | 11293 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:14:26 INFO - PROCESS | 11293 | Values: 95.0 95.0 94.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:0.53 (1.1%) stddev-sans-first:0.53 12:14:26 INFO - PROCESS | 11293 | Values: 50.0 49.0 49.0 49.0 50.0 50.0 49.0 50.0 50.0 49.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 12:14:26 INFO - PROCESS | 11293 | Values: 59.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 60.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:72.00 stddev:2.01 (2.8%) stddev-sans-first:2.06 12:14:26 INFO - PROCESS | 11293 | Values: 71.0 72.0 72.0 72.0 78.0 72.0 71.0 72.0 72.0 73.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:118.50 stddev:21.71 (18.3%) stddev-sans-first:22.95 12:14:26 INFO - PROCESS | 11293 | Values: 120.0 126.0 117.0 119.0 117.0 115.0 116.0 115.0 186.0 118.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.00 stddev:2.27 (1.5%) stddev-sans-first:2.33 12:14:26 INFO - PROCESS | 11293 | Values: 155.0 152.0 154.0 152.0 158.0 154.0 150.0 155.0 152.0 152.0 12:14:26 INFO - PROCESS | 11293 | 12:14:26 INFO - PROCESS | 11293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.01 12:14:26 INFO - PROCESS | 11293 | Values: 65.0 62.0 62.0 63.0 60.0 62.0 62.0 61.0 60.0 61.0 12:14:26 INFO - PROCESS | 11293 | -------- Summary: end -------- 12:14:26 INFO - PROCESS | 11293 | 12:14:27 INFO - TEST-INFO | 11293: exit 0 12:14:27 INFO - TEST-OK | kraken | took 60348ms 12:14:27 INFO - SUITE-END | took 1174s 12:14:28 INFO - Completed test suite (00:19:34) 12:14:28 INFO - javascript benchmark 12:14:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.360524697684, 3300.5874265716784, 3308.8345582720867, 3322.8172450515212, 3337.46600543913, 5591.608587398884, 5705.857353566163, 5710.714464276785, 5717.342505611856, 5742.9999999999945, 5602.943970560304, 5646.0, 5646.322441307038, 5661.631993920402, 5665.518430933365, 4955.256711493269, 5020.874478138039, 5110.667806592578, 5117.923231151536, 5157.174852023677, 5095.439501654815, 5103.234514822788, 5109.591232701375, 5141.717205553693, 5147.433782283946, 5133.153029750087, 5145.0, 5168.508991645806, 5172.40517340505, 5201.141811601081, 5237.8952420951555, 5253.763580638881, 5258.526732594066, 5260.500252476008, 5276.393214780311, 4954.405471343462, 5015.14742493777, 5070.746462676888, 5136.512031357015, 5138.2806407103035, 5580.637258578179, 5606.523445507137, 5611.494965453129, 5614.129809879475, 5650.491455768959, 6076.709105592199, 6077.331553306192, 6086.8782624347705, 6101.999550662781, 6106.542009349272, 5859.648421094748, 5991.580589358747, 5995.640261584275, 6056.545759068087, 6104.3590423005835, 5693.886122277573, 5706.115552089392, 5712.65724056558, 5717.142428635738, 5720.828375148793, 6225.937740622627, 6226.875462490725, 6228.564000520011, 6232.065190221412, 6240.095186198067, 5733.483986441157, 5893.086571581412, 5941.0, 5966.433188847052, 6016.037434010537, 6070.1125385917385, 6097.756089756449, 6099.0, 6102.389761023951, 6103.23709536308, 6040.0, 6045.304789949212, 6048.939510604926, 6049.576529642883, 6049.606775559574, 5817.272840894888, 5949.762009519571, 5959.582829201914, 5968.4926781224085, 6030.879382412327, 4609.723416595015, 4637.559431853969, 4644.326572646947, 4663.417072865892, 4677.555632214934, 4155.085881106152, 4168.895777605523, 4171.290880550314, 4178.498580170399, 4189.6438802701505, 5560.0, 5737.454941780524, 5797.159411885337, 5804.564657650609, 5815.214945982323, 6143.389059649631, 6155.415235552616, 6166.568340216231, 6170.691465426711, 6173.166622505994, 5829.737661805144, 5837.0, 5839.416058394127, 5840.737166827503, 5859.150423188614, 5042.899142017139, 5166.974165129151, 5191.8182863599595, 5295.708736019479, 5310.495502927216, 6316.115743795872, 6319.936800631935, 6323.620582765049, 6324.968375158002, 6331.620102793847, 6034.668093254913, 6092.939070609237, 6099.451049405575, 6101.450869421773, 6103.969480152571, 6004.969975150271, 6196.535259855439, 6237.28271248794, 6323.936760632335, 6336.746530138743, 5973.641581505123, 5988.431099045583, 5989.341172470938, 6004.639721616717, 6028.1861948638125, 6070.7875224366935, 6091.329953705001, 6092.299385570716, 6093.116498107661, 6098.603590766586, 5742.971285143548, 5841.532677385884, 5850.561207909339, 5921.851953701192, 5998.1002849572915, 5849.064149736022, 5906.527477801851, 5908.379620139824, 5937.435943585352, 5946.316173640087, 5856.736446859987, 5859.033259512304, 5864.120381942572, 5864.208331875313, 5865.178874957424, 5823.7670493181495, 5863.618864773946, 5888.411158884077, 5940.16837642739, 5969.462748352669, 5776.971115144397, 5777.191193232867, 5782.85542861415, 5798.94201057984, 5800.216970708901], "value": 5587.000706664272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.320139842677, 624.5628060357749, 638.5019684645974, 648.8215740671312, 665.9101021362114, 34630.480542791876, 37375.81312093439, 37417.62582374176, 37468.250634987286, 45840.0, 44081.118377632425, 48344.824482898264, 48367.0, 48369.75815120919, 48373.0, 9264.166225039728, 9412.764680882965, 9420.38767480115, 9421.717348479557, 9423.81152376952, 8486.66053357865, 9246.907530924705, 9345.859812102824, 10943.23397362185, 11242.66272011841, 11304.321740695543, 11377.488013039392, 11382.373969431677, 11384.943075284613, 11393.943030284838, 11155.498002589862, 11168.329900206014, 11179.161562882817, 11207.943960280147, 11216.383098929555, 11117.777644447147, 11161.776764464665, 11189.384583847885, 11219.775604487946, 11227.0, 45696.0, 45820.0, 45825.08349832985, 46000.30999534976, 46062.07875842464, 3733.4773131761576, 3763.8870833875026, 3807.0672685192303, 4007.338789099795, 4424.336349547561, 34674.6532534674, 34852.477212841826, 35270.0, 35583.0, 36482.81758591217, 4713.198756211452, 4761.857144285642, 4768.0, 4807.903841923142, 4845.854624361275, 392872.0, 393034.0, 394759.0, 396391.0, 396625.0, 38541.0, 61553.0, 61846.0, 61923.6903815487, 62064.44838879064, 39054.41418378727, 40794.592054079076, 40855.59144408518, 40926.18147637031, 41004.79497602553, 16738.16309184536, 16772.748408773878, 16824.83175168257, 16837.0, 16837.91581042087, 14737.115773053436, 14785.556433307018, 14810.925945370203, 14820.62948426298, 14824.110553366832, 8505.829883402297, 8902.599383027778, 9268.490233037113, 9294.86057709135, 9476.763080923032, 3487.0, 3489.7208223342072, 3499.2476617527354, 3530.4174811156386, 3537.5047493350953, 986.2603047714215, 1050.1524654783418, 1073.7154654016692, 1103.911687065049, 1154.988450115505, 34575.30849383049, 35060.649393506246, 35141.472877906854, 35150.0, 35291.294174116374, 1137.6587023892798, 1151.7265987392313, 1181.5864447443325, 1259.703969567151, 1259.966827201704, 17488.65022699539, 17683.469495915142, 17884.9105754473, 17894.731579026324, 17983.550411239823, 689155.0, 694138.0, 695318.0, 695735.0, 697442.0, 65070.0, 65477.0, 65479.67260163669, 65705.67147164329, 65797.67101164463, 1347.5485712286297, 1443.1196969848384, 1473.4400927647425, 1474.86726194643, 1478.6229511474721, 33323.83338083294, 35274.64725352714, 35962.28075438529, 36012.09969750777, 36080.27839443249, 54140.45859541354, 54833.0, 54905.72547137239, 54910.17634735562, 54946.0, 463551.0, 465117.0, 465283.0, 465503.0, 466310.0, 30350.48247587656, 32075.037748867573, 32134.678653214105, 33215.169620759676, 33367.33265334631, 51034.489655102974, 51062.0, 51078.48921510737, 51107.744461277456, 52483.0, 42269.154616906875, 42948.35577466403, 43057.138857223305, 43893.341599876665, 44352.55647443613, 43004.56995430131, 43441.78279108584, 43921.78039109912, 44648.0, 44730.0, 43112.78443607762, 43466.34800477932, 43671.0, 44456.55543444524, 45625.0, 36525.63474365329, 39653.80173099116, 40024.1995160101, 40130.59869401269, 40260.0, 29923.251918702208, 30296.394072118874, 30355.2411189722, 30417.695823041486, 30832.229194270323], "value": 20771.481985466227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.81142645816794, 409.4390684761877, 421.53631005893516, 428.75132423194543, 438.62278440541127, 15186.924065379671, 19951.40145795625, 20418.897905510472, 20454.693179602316, 21130.260440884573, 20075.799242007575, 20183.09176087076, 20212.595748085067, 20220.19119235229, 20346.796532034674, 5883.499902508292, 5917.49701275391, 6022.096685497167, 6046.455818976291, 6062.787802426916, 5962.731677074542, 6034.788782392618, 6054.091886217058, 6060.393960603927, 6061.545384096188, 5986.700664966756, 6226.0, 6264.874702505947, 6342.6511541865175, 6348.682565871711, 6269.937300627003, 6287.308396076428, 6298.181236439256, 6632.071509988606, 6873.931260687379, 6142.754289828402, 6160.383961603849, 6162.599431036968, 6164.722587483574, 6165.969170154165, 14777.630559235997, 17470.563235919202, 20027.399178024538, 24907.128250511327, 25008.49983000348, 2498.4003839078673, 2525.532776436365, 2527.734587868266, 2540.6951165860214, 2556.9360765980814, 10356.412940531425, 10834.512446939907, 10941.56233750649, 11308.434578271135, 11404.828927566094, 1975.1111999600237, 2060.5825204041507, 2095.067694875781, 2140.818030467412, 2153.1817909194406, 62053.6897315515, 64465.67767161134, 75968.62015689997, 85406.57296713477, 86786.13213867844, 11436.885631143748, 11464.140189485823, 11522.0, 11562.710932226762, 11781.293122412511, 16470.75293870593, 16485.752713709066, 16508.587285317964, 16512.33950641985, 16537.173141342886, 8691.652333906699, 8749.825003499895, 8839.806626105523, 8889.111088891059, 9103.590338434786, 8754.51850148248, 8786.824263514694, 8805.647774089093, 8892.777680558038, 9035.864462033074, 4944.876378090505, 4954.801807927714, 4991.650584459053, 4999.375078115236, 5086.160783470686, 2025.1291944464022, 2026.973026973027, 2041.5508588110592, 2069.513664288891, 2095.779943105952, 960.577345967772, 973.8344481438172, 976.1019861727228, 987.5555999799975, 1069.4759567811716, 20221.39335819928, 20548.178072877217, 20620.381388558366, 20656.27703030417, 20677.17291308331, 1024.6669832304383, 1040.958361665525, 1063.1760385701143, 1102.2669924500278, 1138.9943050284696, 10599.735006624896, 11603.0, 11604.6518604442, 11605.535778568932, 11648.53405863773, 592583.0, 608585.0, 609878.0, 615513.0, 621401.0, 95844.0, 97585.0, 101897.49051254697, 107605.46197268963, 107660.0, 1069.1446842525947, 1085.451846817368, 1116.6705821782593, 1117.6870476266495, 1140.6007897235902, 17396.47810565685, 18227.54431139232, 18412.907935460236, 18600.627987439904, 18884.716729248797, 45822.77088614536, 46116.53883461257, 46416.76791616021, 47343.526564735286, 47800.0, 67711.0, 68005.65997169983, 68203.3179668197, 69329.0, 69882.65058674673, 8924.821503570021, 8941.239994600272, 9066.727998160066, 9116.772080698036, 9185.862212066959, 10234.283600148216, 13636.79544806809, 13742.93128534351, 13795.931020344835, 14236.288185590885, 12218.938905305416, 12335.259884406963, 12373.876261237632, 12385.263986214275, 12634.178778379375, 11211.55153793839, 11517.136214784092, 11866.821997670215, 11910.166288359731, 12555.372231388212, 11334.829977550178, 11474.713132171762, 11675.182737208313, 11699.707507312385, 12356.196847204903, 8893.333000024895, 8960.283177345927, 8963.507007114671, 8967.417117887317, 9089.639626160968, 10575.312604680672, 11709.0, 11859.644210673694, 11912.642620721392, 12184.0], "value": 9769.429104268462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.2492653966856, 1412.5832879300606, 1495.8578935001176, 1609.702205092058, 1883.8492920566348, 8883.60023798929, 9316.347855650107, 9363.6254549818, 9640.325177237597, 9655.27585431092, 9497.952510237457, 9599.232061435087, 9600.42397456153, 9611.95194024029, 9627.37422067565, 2481.689788776403, 2504.0860086068637, 2514.937126571832, 2517.093846215361, 2519.911803086892, 2432.075811191745, 2471.0733474946896, 2472.184179220862, 2474.0845887021737, 2475.0, 2411.0837881604966, 2425.151197081025, 2429.708434987804, 2433.6227884677905, 2444.3155916343453, 2388.5581167483983, 2412.601920683085, 2421.806255499556, 2423.8545687258734, 2429.5505331513727, 2390.605550084234, 2401.1955994741784, 2404.0864471500718, 2406.121765555577, 2417.903283868643, 9402.62389504419, 9485.33602647815, 9488.95255523718, 9552.522373881347, 9554.665586704501, 5622.690752008638, 5863.032599621058, 5872.530197584183, 5883.735231914574, 5888.116782482619, 3576.195356044895, 3626.4197728363333, 3656.9634303657153, 3691.1325838427947, 3698.149425632093, 1200.099925056208, 1222.584321330752, 1257.3210466348253, 1291.9935400323031, 1302.4269321498605, 13337.73324533504, 13346.866531334757, 13385.129966552144, 13408.932955335162, 13419.932900335436, 4794.161021821237, 4794.904101917942, 4851.690043688184, 4889.144399730033, 4967.726775027336, 10648.78702425947, 10660.200484963503, 10664.093552048007, 10670.35977841332, 10673.946630266953, 5634.32388113429, 5634.7182640867795, 5635.408282130399, 5635.520980716685, 5638.154276858422, 4620.075984802986, 4770.379850619467, 5234.057869583511, 5279.208118782137, 5292.073887069748, 3898.7270891037356, 3946.8618598349494, 3992.740471869319, 4005.2790497710107, 4038.172174704179, 1215.1008253892232, 1222.4682263215352, 1235.5428491458038, 1245.0413181849924, 1254.6047994881583, 940.520334629344, 1023.2274632652449, 1042.1454407386022, 1064.2177999170603, 1064.292245656645, 6456.12842266288, 6520.576162549419, 6530.412262896362, 6768.593884366954, 6873.0, 475.7716296177854, 490.4090570862103, 497.55220301728735, 499.64774833742126, 502.22406382139684, 4577.382053422745, 4639.2113340731485, 4645.741071917774, 4733.053389322149, 4773.880652983703, 11808.58669946565, 12202.633920982385, 12308.938455307667, 12317.322547259808, 12335.938320308342, 11254.943725281484, 12226.083043771752, 12229.26624402521, 12236.204646697935, 12242.938785306194, 8691.391602587884, 9094.81810363789, 9106.089391060974, 9122.86315705265, 9139.95430022859, 6144.815655530341, 6154.169187159855, 6313.40022697843, 6411.711472983634, 6444.9033264502, 11144.0, 11268.042216411697, 11286.322820630789, 11400.087992960709, 11422.828657569977, 10239.43683097407, 10418.739531511774, 10724.088452481627, 11500.884991149982, 11607.535698571963, 8251.174882511701, 8255.793605159919, 8696.130386961506, 8702.390832641655, 8709.608067637098, 9224.446533208029, 9374.109459601326, 9416.435013899189, 9424.670136545188, 9429.292803039662, 8287.337013038821, 8474.322054235523, 8476.49141051539, 8510.063892971644, 8636.524991125549, 8354.540500272544, 8377.916220837713, 8404.663813447394, 8417.0, 8534.231919127309, 7786.7663970080985, 7802.609869506616, 7804.609769511389, 7804.609769511615, 7905.960470197612, 5124.897502050013, 5706.372299047184, 5804.332501762351, 5839.445252700986, 6072.180255665428, 5483.862903427446, 5579.302587176603, 5755.942440575541, 5825.097109947965, 5954.7915822947725], "value": 4900.282490067314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7231123567999, 359.5379936781236, 361.2287765620403, 361.97104231661467, 364.75743630485726, 5484.451554844519, 5569.972150139249, 5574.191742197384, 5585.832425027245, 5628.296462942132, 5343.0, 5453.863653408666, 5515.503604675579, 5524.447555244484, 5531.585131115163, 4324.875532361577, 4370.235208838457, 4374.562543745624, 4386.605205531501, 4402.7578483183415, 4372.3878656988045, 4373.890652733691, 4375.643550499355, 4379.496357918848, 4398.340248962665, 4310.82756689732, 4314.525402205755, 4315.266404711207, 4344.391785150082, 4345.261305578059, 4202.0, 4302.634276086536, 4325.178216138924, 4345.152695224432, 4346.391505189276, 3869.800361887824, 3879.2349480986086, 3881.573026967031, 3883.8058097095313, 3894.7078969077147, 5276.1030624793875, 5327.17428798533, 5328.909232645056, 5351.491608297206, 5359.866003349908, 4783.330333753277, 4905.386826646669, 4916.901661966776, 4992.176290911995, 5016.77424515894, 5724.4561766632105, 5747.798827041075, 5756.194132821408, 5757.798477053325, 5821.79623713168, 4228.386883901817, 4232.873013809591, 4240.936385954213, 4296.355546667994, 4305.160493703729, 5649.293838270216, 5659.179418984266, 5703.287089113902, 5977.701114944279, 6051.0, 4181.874543763692, 4218.282891908383, 4218.8312467500955, 4248.299030659907, 4265.829366825355, 4318.438602981592, 4327.134573085333, 4330.488316776262, 4339.284018137035, 4346.304591265382, 4633.606143477842, 4771.594414474808, 4855.0, 4939.259111133287, 4950.356453661073, 5727.398623144593, 5739.081746920473, 5750.338711048199, 5763.674354898397, 5783.826485205451, 1477.601047717132, 1496.8428315026983, 1505.9472918447802, 1511.8790496760232, 1513.0770230159594, 972.2902281334665, 980.8136454073846, 983.7653744550544, 1041.890601486848, 1050.7635781949, 5523.088690366045, 5524.502794748492, 5526.618345413646, 5526.917096243479, 5551.500364967173, 5779.624324418899, 5781.479666830005, 5791.69686820462, 5839.598496360843, 5841.649501029951, 5282.418933917266, 5447.754851031713, 5462.644928079662, 5504.862378440571, 5548.944510554843, 3039.1794215561677, 3070.646875609289, 3071.447139514864, 3072.738817200563, 3082.9845850770603, 5897.144913987534, 5968.432998865101, 5995.370486098984, 6010.0, 6027.126066720389, 5819.73811178498, 5847.871388806968, 5886.470217680429, 5893.6463812171405, 5916.556258280646, 5853.1220316952795, 5874.1776151338845, 5923.259592550931, 5943.9790471239985, 5982.132590774313, 5552.390376523028, 5762.538996880324, 5831.620944638585, 5895.41045895407, 5896.292444906639, 5842.415758424124, 5850.864434481468, 5856.707164641836, 5858.736356863866, 5862.149988251765, 5885.646861188342, 5950.642961422329, 6067.0, 6114.541409394402, 6114.6636934969, 4264.936025959551, 4304.3543468479975, 4309.870703878889, 4341.6743744218675, 4343.978280108579, 5786.768529258782, 5922.378150294157, 6003.219581454383, 6004.339522652417, 6028.336882942785, 5726.0, 5748.655080695172, 5750.453706897838, 5750.712464376848, 5786.247787787561, 5746.166805813217, 5752.539796816328, 5798.884022319446, 5809.564282678901, 5830.766769329349, 5449.291592093003, 5666.829995100154, 5686.014842207874, 5688.914666280092, 5780.814932938653, 5752.33848107473, 5776.534079552235, 5822.3304320003745, 5823.806119745357, 5837.795677151279, 5478.058848750118, 5647.3787883333625, 5664.433556644302, 5686.260786097946, 5717.171010203414], "value": 4409.28364811218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.7165078048073, 834.1033389106711, 871.8169184471261, 898.2275243290773, 918.5774543709894, 16891.49325520235, 17384.0, 17479.0, 17536.298548058094, 17580.736288955675, 15994.60013499663, 16116.516504504883, 16128.83871161288, 16141.596460088504, 16150.676986460263, 733.6808488307577, 835.995820020899, 871.1462766488861, 881.2509367037999, 887.9600417981175, 897.2149369301861, 899.7660608241872, 900.6847603338845, 901.062894589626, 901.1124042817819, 951.5670369981642, 953.1850268020846, 953.7901661634429, 954.0554850697794, 954.308126608207, 777.0713996773829, 903.259327351572, 922.0687106022965, 922.5064590444114, 933.0576118120679, 682.4267615203204, 682.7269092363044, 683.1665368250776, 683.3576438148175, 683.4976292425064, 15529.068255904682, 15544.455944042018, 15552.377904883791, 15565.37738490459, 15579.922100389425, 15614.45349412765, 15649.530514084596, 15727.68544629101, 15938.920305398398, 16143.919280403523, 13891.02762806604, 14454.566363009126, 14461.855381446261, 14468.0, 14596.489122880648, 4637.234856248715, 4708.0819240248165, 4759.428868535763, 4761.119192949281, 4800.879978000543, 84967.57516212441, 85737.0, 86606.0, 87198.12801871964, 87498.56250718706, 12522.123451358317, 12661.36693165338, 12672.683182920317, 12924.03069769771, 12948.935255323662, 24084.39789005289, 24256.636150457758, 24286.87856560741, 24292.878535607208, 24314.513709725707, 9018.594163262538, 9219.400738951947, 9291.535423228812, 9409.379416420716, 9597.0, 5193.532582067632, 5255.369355677343, 5291.3385826771655, 5375.569954403638, 5481.588880833874, 3711.3505136601525, 3887.047673319998, 3897.707671924617, 3904.0, 3904.6290602393296, 684.3430306905426, 689.9793006209821, 698.2668198391668, 700.7757517594423, 706.1420374245214, 617.9721912513947, 621.5183232994466, 622.4335854372499, 629.3674856768918, 649.233903993283, 9575.425474471554, 10135.442550659636, 10415.791684166274, 10436.0, 10655.200859935536, 637.8086574027773, 644.3878315600105, 682.494953734243, 723.2044750774106, 742.6435311050726, 4546.909061818811, 4702.224133018014, 4759.833405830779, 4766.094442055998, 4782.5456581625385, 102595.0, 104637.87800103943, 106950.46524767482, 118609.0, 119395.0, 95930.52034739782, 96022.0, 96383.0, 98737.50631246797, 99870.5006474963, 64897.67551162214, 86114.56942715247, 90921.0, 90980.5450972741, 91467.08532914719, 10367.9782442423, 10691.663542057242, 10935.398553079656, 10968.725781855517, 11011.72470688207, 54257.72871135777, 54742.178867317816, 54785.45214547803, 54950.0, 57007.42992570187, 80544.0, 81754.59122704586, 82422.0, 83901.0, 84717.1528284734, 13996.090254133449, 14127.434902604193, 14147.02771735905, 14246.572602821932, 14510.492132775724, 9950.55222514974, 14881.255937203314, 14951.0, 15141.470048548248, 15353.155576443403, 12868.420921058761, 12986.155899866479, 13153.408096635483, 13776.862231377558, 13836.169829810244, 13033.47866085346, 13119.0, 13215.207087574776, 13287.06990510655, 13305.467781289028, 13252.602421927357, 13520.6619834501, 13561.728765424834, 13588.116772409761, 13718.108322958975, 10451.843222351823, 11000.0, 11042.33745975244, 11163.497642606264, 11164.944175279072, 11473.942630287129, 11667.533298667959, 11685.591004314809, 11793.193263579222, 11928.701782455508], "value": 8026.560092430541, "unit": "score"}], "name": "dromaeo_css", "value": 7625.695087257449, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 116.0, 190.0, 116.0, 118.0, 141.0, 115.0, 148.0, 115.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 159.0, 161.0, 159.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 128.0, 75.0, 75.0, 76.0, 76.0, 108.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 83.0, 84.0, 119.0, 83.0, 83.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 50.0, 50.0, 49.0, 50.0, 50.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 72.0, 78.0, 72.0, 71.0, 72.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 117.0, 119.0, 117.0, 115.0, 116.0, 115.0, 186.0, 118.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 152.0, 154.0, 152.0, 158.0, 154.0, 150.0, 155.0, 152.0, 152.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 60.0, 62.0, 62.0, 61.0, 60.0, 61.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1457.0000000000002, "alertThreshold": 2.0}]} 12:14:28 INFO - Return code: 0 12:14:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:14:28 INFO - # TBPL SUCCESS # 12:14:28 INFO - Running post-action listener: _resource_record_post_action 12:14:28 INFO - [mozharness: 2016-08-01 19:14:28.138670Z] Finished run-tests step (success) 12:14:28 INFO - Running post-run listener: _resource_record_post_run 12:14:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511057920; Read time: 20; Write time: 475612 12:14:28 INFO - TinderboxPrint: CPU usage
12.9% 12:14:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 12:14:28 INFO - TinderboxPrint: I/O write bytes / time
511,057,920 / 475,612 12:14:28 INFO - TinderboxPrint: CPU idle
8,268.2 (87.0%) 12:14:28 INFO - TinderboxPrint: CPU user
1,183.6 (12.5%) 12:14:28 INFO - TinderboxPrint: Swap in / out
0 / 0 12:14:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259014656; Read time: 0; Write time: 296140 12:14:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 251678720; Read time: 0; Write time: 179468 12:14:28 INFO - Running post-run listener: _upload_blobber_files 12:14:28 INFO - Blob upload gear active. 12:14:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:28 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 12:14:28 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'] 12:14:28 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 12:14:29 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:30 INFO - (blobuploader) - INFO - Done attempting. 12:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:42 INFO - (blobuploader) - INFO - Done attempting. 12:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:14:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:43 INFO - (blobuploader) - INFO - Done attempting. 12:14:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:43 INFO - Return code: 0 12:14:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6e5040ec047eba0c5d223cb8741530d325af22fc5568bbeeaacd232933a8ca9bffaaca20b406c2ad01545ed7cc2665cec5581fe938dcb87863f4931f9db2adf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13d1cac193906ec7906a15f07921b45c789ecccf548667f151402e69b55d95f7f65b08223cef8928a771e62502e928bd7fbe83e8193646e52033b6a84e765d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/299014dbc6d8699b88b8027af9fdc0b0a2f0a7cff9b31a8364c6ab7cc7e9d6d8eae62efc064ab0fdfbbfabbc7e2a684795906129399a2929c25b9357a9dadf50"} 12:14:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:43 INFO - Contents: 12:14:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6e5040ec047eba0c5d223cb8741530d325af22fc5568bbeeaacd232933a8ca9bffaaca20b406c2ad01545ed7cc2665cec5581fe938dcb87863f4931f9db2adf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13d1cac193906ec7906a15f07921b45c789ecccf548667f151402e69b55d95f7f65b08223cef8928a771e62502e928bd7fbe83e8193646e52033b6a84e765d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/299014dbc6d8699b88b8027af9fdc0b0a2f0a7cff9b31a8364c6ab7cc7e9d6d8eae62efc064ab0fdfbbfabbc7e2a684795906129399a2929c25b9357a9dadf50"} 12:14:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:43 INFO - Copying logs to upload dir... 12:14:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.986477 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-01 12:14:42.155255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:42.159038) ========= 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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 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/f6e5040ec047eba0c5d223cb8741530d325af22fc5568bbeeaacd232933a8ca9bffaaca20b406c2ad01545ed7cc2665cec5581fe938dcb87863f4931f9db2adf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13d1cac193906ec7906a15f07921b45c789ecccf548667f151402e69b55d95f7f65b08223cef8928a771e62502e928bd7fbe83e8193646e52033b6a84e765d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/299014dbc6d8699b88b8027af9fdc0b0a2f0a7cff9b31a8364c6ab7cc7e9d6d8eae62efc064ab0fdfbbfabbc7e2a684795906129399a2929c25b9357a9dadf50"} build_url:https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/cDWXk9AqRZ2flFrIcugxKA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6e5040ec047eba0c5d223cb8741530d325af22fc5568bbeeaacd232933a8ca9bffaaca20b406c2ad01545ed7cc2665cec5581fe938dcb87863f4931f9db2adf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13d1cac193906ec7906a15f07921b45c789ecccf548667f151402e69b55d95f7f65b08223cef8928a771e62502e928bd7fbe83e8193646e52033b6a84e765d88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/299014dbc6d8699b88b8027af9fdc0b0a2f0a7cff9b31a8364c6ab7cc7e9d6d8eae62efc064ab0fdfbbfabbc7e2a684795906129399a2929c25b9357a9dadf50"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:42.187495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:42.188027) ========= 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=920470bf432669ad7e3a5387000001ca-1470077644.36605-1876394136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 12:14:42.270807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 12:14:42.271378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 12:14:42.271882) ========= ========= Total master_lag: 0.18 =========