builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1470393487.83 results: success (0) buildid: 20160805004022 builduid: 66307eaece3d4318979c4abb621cbce6 revision: 89b4dd71d6a204852532d9bb2d52b744615d74bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.830966) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.831813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.832126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.848657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.849006) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 03:38:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-08-05 03:38:08 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079244 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.942765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.943111) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.994234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:07.994623) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 89b4dd71d6a204852532d9bb2d52b744615d74bb --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 89b4dd71d6a204852532d9bb2d52b744615d74bb --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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 03:38:08,864 truncating revision to first 12 chars 2016-08-05 03:38:08,865 Setting DEBUG logging. 2016-08-05 03:38:08,865 attempt 1/10 2016-08-05 03:38:08,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/89b4dd71d6a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 03:38:09,183 unpacking tar archive at: mozilla-aurora-89b4dd71d6a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:08.664465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:08.664800) ========= script_repo_revision: 89b4dd71d6a204852532d9bb2d52b744615d74bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:08.665270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:08.665556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 03:38:08.675406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-05 03:38:08.675920) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:38:09 INFO - MultiFileLogger online at 20160805 03:38:09 in /builds/slave/test 03:38:09 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 03:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:09 INFO - {'append_to_log': False, 03:38:09 INFO - 'base_work_dir': '/builds/slave/test', 03:38:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:09 INFO - 'branch': 'Mozilla-Aurora', 03:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:09 INFO - 'config_files': ('talos/linux_config.py',), 03:38:09 INFO - 'default_actions': ('clobber', 03:38:09 INFO - 'read-buildbot-config', 03:38:09 INFO - 'download-and-extract', 03:38:09 INFO - 'populate-webroot', 03:38:09 INFO - 'create-virtualenv', 03:38:09 INFO - 'install', 03:38:09 INFO - 'run-tests'), 03:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:09 INFO - 'download_minidump_stackwalk': True, 03:38:09 INFO - 'download_symbols': 'ondemand', 03:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:09 INFO - 'installer_path': 'installer.exe', 03:38:09 INFO - 'log_level': 'info', 03:38:09 INFO - 'log_name': 'talos', 03:38:09 INFO - 'log_to_console': True, 03:38:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:38:09 INFO - 'opt_config_files': (), 03:38:09 INFO - 'pip_index': False, 03:38:09 INFO - 'sps_profile': False, 03:38:09 INFO - 'sps_profile_interval': 0, 03:38:09 INFO - 'suite': 'dromaeojs', 03:38:09 INFO - 'system_bits': '32', 03:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:09 INFO - 'title': 'talos-linux64-ix-034', 03:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:09 INFO - 'use_talos_json': True, 03:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:09 INFO - 'work_dir': 'build'} 03:38:09 INFO - [mozharness: 2016-08-05 10:38:09.640683Z] Running clobber step. 03:38:09 INFO - Running pre-action listener: _resource_record_pre_action 03:38:09 INFO - Running main action method: clobber 03:38:09 INFO - rmtree: /builds/slave/test/build 03:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:10 INFO - Running post-action listener: _resource_record_post_action 03:38:10 INFO - [mozharness: 2016-08-05 10:38:10.100841Z] Finished clobber step (success) 03:38:10 INFO - [mozharness: 2016-08-05 10:38:10.100944Z] Running read-buildbot-config step. 03:38:10 INFO - Running pre-action listener: _resource_record_pre_action 03:38:10 INFO - Running main action method: read_buildbot_config 03:38:10 INFO - Using buildbot properties: 03:38:10 INFO - { 03:38:10 INFO - "project": "", 03:38:10 INFO - "product": "firefox", 03:38:10 INFO - "script_repo_revision": "production", 03:38:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:38:10 INFO - "repository": "", 03:38:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:38:10 INFO - "buildid": "20160805004022", 03:38:10 INFO - "stage_platform": "linux64-pgo", 03:38:10 INFO - "basedir": "/builds/slave/test", 03:38:10 INFO - "nightly_build": "True", 03:38:10 INFO - "buildnumber": 448, 03:38:10 INFO - "slavename": "talos-linux64-ix-034", 03:38:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:38:10 INFO - "platform": "ubuntu64_hw", 03:38:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:38:10 INFO - "branch": "mozilla-aurora", 03:38:10 INFO - "repo_path": "releases/mozilla-aurora", 03:38:10 INFO - "revision": "89b4dd71d6a204852532d9bb2d52b744615d74bb", 03:38:10 INFO - "pgo_build": "True", 03:38:10 INFO - "builduid": "66307eaece3d4318979c4abb621cbce6", 03:38:10 INFO - "slavebuilddir": "test" 03:38:10 INFO - } 03:38:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:38:10 INFO - Running post-action listener: _resource_record_post_action 03:38:10 INFO - [mozharness: 2016-08-05 10:38:10.103478Z] Finished read-buildbot-config step (success) 03:38:10 INFO - [mozharness: 2016-08-05 10:38:10.103568Z] Running download-and-extract step. 03:38:10 INFO - Running pre-action listener: _resource_record_pre_action 03:38:10 INFO - Running main action method: download_and_extract 03:38:10 INFO - mkdir: /builds/slave/test/build/tests 03:38:10 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')]} 03:38:10 INFO - https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:10 INFO - Downloaded 1361 bytes. 03:38:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:38:10 INFO - Using the following test package requirements: 03:38:10 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:38:10 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:38:10 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:38:10 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'jsshell-linux-x86_64.zip'], 03:38:10 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:38:10 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:38:10 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:38:10 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:38:10 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:38:10 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:38:10 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:38:10 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:38:10 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')]} 03:38:10 INFO - https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:38:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:38:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:11 INFO - Downloaded 21766090 bytes. 03:38:11 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'] 03:38:11 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 03:38:12 INFO - Return code: 0 03:38:12 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 03:38: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')]} 03:38:12 INFO - https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:14 INFO - Downloaded 21766090 bytes. 03:38:14 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'] 03:38:14 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 03:38:15 INFO - Return code: 0 03:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:15 INFO - https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:16 INFO - Downloaded 14413723 bytes. 03:38:16 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'] 03:38:16 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 03:38:16 INFO - Return code: 0 03:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:16 INFO - https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyqgAhJnSNWyZpli1E4vgw/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 03:38:17 INFO - Downloaded 63756655 bytes. 03:38:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:17 INFO - mkdir: /builds/slave/test/properties 03:38:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:17 INFO - Contents: 03:38:17 INFO - build_url:https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:18 INFO - Running post-action listener: _resource_record_post_action 03:38:18 INFO - Running post-action listener: set_extra_try_arguments 03:38:18 INFO - [mozharness: 2016-08-05 10:38:18.519217Z] Finished download-and-extract step (success) 03:38:18 INFO - [mozharness: 2016-08-05 10:38:18.519449Z] Running populate-webroot step. 03:38:18 INFO - Running pre-action listener: _resource_record_pre_action 03:38:18 INFO - Running main action method: populate_webroot 03:38:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:18 INFO - '--tppagecycles', 03:38:18 INFO - '7'], 03:38:18 INFO - 'tests': ['tsvgm']}}, 03:38:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['damp', 'tps']}, 03:38:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'tests': ['damp', 'tps']}, 03:38:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['dromaeo_dom']}, 03:38:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['basic_compositor_video']}, 03:38:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:38:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['a11yr', 03:38:18 INFO - 'ts_paint', 03:38:18 INFO - 'tpaint', 03:38:18 INFO - 'sessionrestore', 03:38:18 INFO - 'sessionrestore_no_auto_restore', 03:38:18 INFO - 'tabpaint']}, 03:38:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['tsvgx', 03:38:18 INFO - 'tsvgr_opacity', 03:38:18 INFO - 'tart', 03:38:18 INFO - 'tscrollx', 03:38:18 INFO - 'cart']}, 03:38:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:18 INFO - 'tsvgr_opacity', 03:38:18 INFO - 'tart', 03:38:18 INFO - 'tscrollx', 03:38:18 INFO - 'cart']}, 03:38:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'talos_options': ['--disable-e10s'], 03:38:18 INFO - 'tests': ['tp5o']}, 03:38:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'tests': ['tp5o']}, 03:38:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'talos_options': ['--disable-e10s', 03:38:18 INFO - '--xperf_path', 03:38:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:18 INFO - 'tests': ['tp5n']}, 03:38:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:18 INFO - 'talos_options': ['--xperf_path', 03:38:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:18 INFO - 'tests': ['tp5n']}}, 03:38:18 INFO - 'talos.zip': {'path': '', 03:38:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:18 INFO - Running post-action listener: _resource_record_post_action 03:38:18 INFO - [mozharness: 2016-08-05 10:38:18.536594Z] Finished populate-webroot step (success) 03:38:18 INFO - [mozharness: 2016-08-05 10:38:18.536683Z] Running create-virtualenv step. 03:38:18 INFO - Running pre-action listener: _resource_record_pre_action 03:38:18 INFO - Running main action method: create_virtualenv 03:38:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:18 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 03:38:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:18 INFO - Using real prefix '/usr' 03:38:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:21 INFO - Installing pip.................done. 03:38:21 INFO - Return code: 0 03:38:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38: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', 'pip>=1.5'] in /builds/slave/test/build 03:38: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 pip>=1.5 03:38:21 INFO - Using env: {'DISPLAY': ':0', 03:38:21 INFO - 'HOME': '/home/cltbld', 03:38:21 INFO - 'LANG': 'en_US.UTF-8', 03:38:21 INFO - 'LANGUAGE': 'en_US:en', 03:38:21 INFO - 'LOGNAME': 'cltbld', 03:38:21 INFO - 'MAIL': '/var/mail/cltbld', 03:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:21 INFO - 'MOZ_NO_REMOTE': '1', 03:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:21 INFO - 'NO_EM_RESTART': '1', 03:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:21 INFO - 'PWD': '/builds/slave/test', 03:38:21 INFO - 'SHELL': '/bin/bash', 03:38:21 INFO - 'SHLVL': '1', 03:38:21 INFO - 'TERM': 'linux', 03:38:21 INFO - 'TMOUT': '86400', 03:38:21 INFO - 'USER': 'cltbld', 03:38:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:21 INFO - '_': '/tools/buildbot/bin/python'} 03:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:21 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 03:38:21 INFO - Cleaning up... 03:38:21 INFO - Return code: 0 03:38:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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', '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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:38: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 psutil>=3.1.1 03:38:21 INFO - Using env: {'DISPLAY': ':0', 03:38:21 INFO - 'HOME': '/home/cltbld', 03:38:21 INFO - 'LANG': 'en_US.UTF-8', 03:38:21 INFO - 'LANGUAGE': 'en_US:en', 03:38:21 INFO - 'LOGNAME': 'cltbld', 03:38:21 INFO - 'MAIL': '/var/mail/cltbld', 03:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:21 INFO - 'MOZ_NO_REMOTE': '1', 03:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:21 INFO - 'NO_EM_RESTART': '1', 03:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:21 INFO - 'PWD': '/builds/slave/test', 03:38:21 INFO - 'SHELL': '/bin/bash', 03:38:21 INFO - 'SHLVL': '1', 03:38:21 INFO - 'TERM': 'linux', 03:38:21 INFO - 'TMOUT': '86400', 03:38:21 INFO - 'USER': 'cltbld', 03:38:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:21 INFO - '_': '/tools/buildbot/bin/python'} 03:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:21 INFO - Downloading/unpacking psutil>=3.1.1 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:23 INFO - Installing collected packages: psutil 03:38:23 INFO - Running setup.py install for psutil 03:38:23 INFO - building 'psutil._psutil_linux' extension 03:38:23 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 03:38:23 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 03:38:23 INFO - building 'psutil._psutil_posix' extension 03:38:23 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 03:38:24 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 03:38:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:24 INFO - Successfully installed psutil 03:38:24 INFO - Cleaning up... 03:38:24 INFO - Return code: 0 03:38:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:24 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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:24 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 03:38:24 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 03:38:24 INFO - Using env: {'DISPLAY': ':0', 03:38:24 INFO - 'HOME': '/home/cltbld', 03:38:24 INFO - 'LANG': 'en_US.UTF-8', 03:38:24 INFO - 'LANGUAGE': 'en_US:en', 03:38:24 INFO - 'LOGNAME': 'cltbld', 03:38:24 INFO - 'MAIL': '/var/mail/cltbld', 03:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:24 INFO - 'MOZ_NO_REMOTE': '1', 03:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:24 INFO - 'NO_EM_RESTART': '1', 03:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:24 INFO - 'PWD': '/builds/slave/test', 03:38:24 INFO - 'SHELL': '/bin/bash', 03:38:24 INFO - 'SHLVL': '1', 03:38:24 INFO - 'TERM': 'linux', 03:38:24 INFO - 'TMOUT': '86400', 03:38:24 INFO - 'USER': 'cltbld', 03:38:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:24 INFO - '_': '/tools/buildbot/bin/python'} 03:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:38:24 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 03:38:24 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 03:38:24 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 03:38:24 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 03:38:24 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 03:38:24 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 03:38:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:38:26 INFO - Installing collected packages: mozsystemmonitor 03:38:26 INFO - Running setup.py install for mozsystemmonitor 03:38:26 INFO - Successfully installed mozsystemmonitor 03:38:26 INFO - Cleaning up... 03:38:26 INFO - Return code: 0 03:38:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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', '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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:38: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 jsonschema==2.5.1 03:38:26 INFO - Using env: {'DISPLAY': ':0', 03:38:26 INFO - 'HOME': '/home/cltbld', 03:38:26 INFO - 'LANG': 'en_US.UTF-8', 03:38:26 INFO - 'LANGUAGE': 'en_US:en', 03:38:26 INFO - 'LOGNAME': 'cltbld', 03:38:26 INFO - 'MAIL': '/var/mail/cltbld', 03:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:26 INFO - 'MOZ_NO_REMOTE': '1', 03:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:26 INFO - 'NO_EM_RESTART': '1', 03:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:26 INFO - 'PWD': '/builds/slave/test', 03:38:26 INFO - 'SHELL': '/bin/bash', 03:38:26 INFO - 'SHLVL': '1', 03:38:26 INFO - 'TERM': 'linux', 03:38:26 INFO - 'TMOUT': '86400', 03:38:26 INFO - 'USER': 'cltbld', 03:38:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:26 INFO - '_': '/tools/buildbot/bin/python'} 03:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:26 INFO - Downloading/unpacking jsonschema==2.5.1 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:28 INFO - warning: no files found matching '*.txt' 03:38:28 INFO - no previously-included directories found matching 'build' 03:38:28 INFO - no previously-included directories found matching 'dist' 03:38:28 INFO - no previously-included directories found matching '.git*' 03:38:28 INFO - Installing collected packages: jsonschema, functools32 03:38:28 INFO - Running setup.py install for functools32 03:38:29 INFO - warning: no files found matching '*.txt' 03:38:29 INFO - no previously-included directories found matching 'build' 03:38:29 INFO - no previously-included directories found matching 'dist' 03:38:29 INFO - no previously-included directories found matching '.git*' 03:38:29 INFO - Successfully installed jsonschema functools32 03:38:29 INFO - Cleaning up... 03:38:29 INFO - Return code: 0 03:38:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:38:29 INFO - Using env: {'DISPLAY': ':0', 03:38:29 INFO - 'HOME': '/home/cltbld', 03:38:29 INFO - 'LANG': 'en_US.UTF-8', 03:38:29 INFO - 'LANGUAGE': 'en_US:en', 03:38:29 INFO - 'LOGNAME': 'cltbld', 03:38:29 INFO - 'MAIL': '/var/mail/cltbld', 03:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:29 INFO - 'MOZ_NO_REMOTE': '1', 03:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:29 INFO - 'NO_EM_RESTART': '1', 03:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:29 INFO - 'PWD': '/builds/slave/test', 03:38:29 INFO - 'SHELL': '/bin/bash', 03:38:29 INFO - 'SHLVL': '1', 03:38:29 INFO - 'TERM': 'linux', 03:38:29 INFO - 'TMOUT': '86400', 03:38:29 INFO - 'USER': 'cltbld', 03:38:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:29 INFO - '_': '/tools/buildbot/bin/python'} 03:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:38:29 INFO - Cleaning up... 03:38:29 INFO - Return code: 0 03:38:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:38:29 INFO - Using env: {'DISPLAY': ':0', 03:38:29 INFO - 'HOME': '/home/cltbld', 03:38:29 INFO - 'LANG': 'en_US.UTF-8', 03:38:29 INFO - 'LANGUAGE': 'en_US:en', 03:38:29 INFO - 'LOGNAME': 'cltbld', 03:38:29 INFO - 'MAIL': '/var/mail/cltbld', 03:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:29 INFO - 'MOZ_NO_REMOTE': '1', 03:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:29 INFO - 'NO_EM_RESTART': '1', 03:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:29 INFO - 'PWD': '/builds/slave/test', 03:38:29 INFO - 'SHELL': '/bin/bash', 03:38:29 INFO - 'SHLVL': '1', 03:38:29 INFO - 'TERM': 'linux', 03:38:29 INFO - 'TMOUT': '86400', 03:38:29 INFO - 'USER': 'cltbld', 03:38:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:29 INFO - '_': '/tools/buildbot/bin/python'} 03:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:32 INFO - Downloading docopt-0.6.1.tar.gz 03:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:32 INFO - Running setup.py install for blobuploader 03:38:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:32 INFO - Running setup.py install for requests 03:38:32 INFO - Running setup.py install for docopt 03:38:32 INFO - Successfully installed blobuploader requests docopt 03:38:32 INFO - Cleaning up... 03:38:32 INFO - Return code: 0 03:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:32 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')]} 03:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:32 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')]} 03:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:32 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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:32 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 03:38:32 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 03:38:32 INFO - Using env: {'DISPLAY': ':0', 03:38:32 INFO - 'HOME': '/home/cltbld', 03:38:32 INFO - 'LANG': 'en_US.UTF-8', 03:38:32 INFO - 'LANGUAGE': 'en_US:en', 03:38:32 INFO - 'LOGNAME': 'cltbld', 03:38:32 INFO - 'MAIL': '/var/mail/cltbld', 03:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:32 INFO - 'MOZ_NO_REMOTE': '1', 03:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:32 INFO - 'NO_EM_RESTART': '1', 03:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:32 INFO - 'PWD': '/builds/slave/test', 03:38:32 INFO - 'SHELL': '/bin/bash', 03:38:32 INFO - 'SHLVL': '1', 03:38:32 INFO - 'TERM': 'linux', 03:38:32 INFO - 'TMOUT': '86400', 03:38:32 INFO - 'USER': 'cltbld', 03:38:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:32 INFO - '_': '/tools/buildbot/bin/python'} 03:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:32 INFO - Running setup.py (path:/tmp/pip-nVFU2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:33 INFO - Running setup.py (path:/tmp/pip-LknFKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:33 INFO - Running setup.py (path:/tmp/pip-emyE2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:33 INFO - Running setup.py (path:/tmp/pip-v8eOj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:33 INFO - Running setup.py (path:/tmp/pip-k3iPgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:33 INFO - Running setup.py (path:/tmp/pip-ncC_nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:33 INFO - Running setup.py (path:/tmp/pip-X1q3Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:33 INFO - Running setup.py (path:/tmp/pip-HG0egU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:33 INFO - Running setup.py (path:/tmp/pip-J3VXoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:33 INFO - Running setup.py (path:/tmp/pip-huQdOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:33 INFO - Running setup.py (path:/tmp/pip-LCsQUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:33 INFO - Running setup.py (path:/tmp/pip-cKtad0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:33 INFO - Running setup.py (path:/tmp/pip-EPMHIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:33 INFO - Running setup.py (path:/tmp/pip-grER_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:33 INFO - Running setup.py (path:/tmp/pip-obIJws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:34 INFO - Running setup.py (path:/tmp/pip-QQ0JHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:34 INFO - Running setup.py (path:/tmp/pip-SRD1W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:34 INFO - Running setup.py install for manifestparser 03:38:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:34 INFO - Running setup.py install for mozcrash 03:38:34 INFO - Running setup.py install for mozdebug 03:38:34 INFO - Running setup.py install for mozdevice 03:38:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:34 INFO - Running setup.py install for mozfile 03:38:34 INFO - Running setup.py install for mozhttpd 03:38:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:34 INFO - Running setup.py install for mozinfo 03:38:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:34 INFO - Running setup.py install for mozInstall 03:38:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Running setup.py install for mozleak 03:38:35 INFO - Running setup.py install for mozlog 03:38:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Running setup.py install for moznetwork 03:38:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Running setup.py install for mozprocess 03:38:35 INFO - Running setup.py install for mozprofile 03:38:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Running setup.py install for mozrunner 03:38:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:35 INFO - Running setup.py install for mozscreenshot 03:38:35 INFO - Running setup.py install for moztest 03:38:35 INFO - Running setup.py install for mozversion 03:38:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:36 INFO - Cleaning up... 03:38:36 INFO - Return code: 0 03:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:36 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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:36 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 03:38:36 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 03:38:36 INFO - Using env: {'DISPLAY': ':0', 03:38:36 INFO - 'HOME': '/home/cltbld', 03:38:36 INFO - 'LANG': 'en_US.UTF-8', 03:38:36 INFO - 'LANGUAGE': 'en_US:en', 03:38:36 INFO - 'LOGNAME': 'cltbld', 03:38:36 INFO - 'MAIL': '/var/mail/cltbld', 03:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:36 INFO - 'MOZ_NO_REMOTE': '1', 03:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:36 INFO - 'NO_EM_RESTART': '1', 03:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:36 INFO - 'PWD': '/builds/slave/test', 03:38:36 INFO - 'SHELL': '/bin/bash', 03:38:36 INFO - 'SHLVL': '1', 03:38:36 INFO - 'TERM': 'linux', 03:38:36 INFO - 'TMOUT': '86400', 03:38:36 INFO - 'USER': 'cltbld', 03:38:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:36 INFO - '_': '/tools/buildbot/bin/python'} 03:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:36 INFO - Running setup.py (path:/tmp/pip-DM_5ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:36 INFO - Running setup.py (path:/tmp/pip-IH2yAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:36 INFO - Running setup.py (path:/tmp/pip-u4zBEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:36 INFO - Running setup.py (path:/tmp/pip-UUgVT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:36 INFO - Running setup.py (path:/tmp/pip-zpp1j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:36 INFO - Running setup.py (path:/tmp/pip-Wp3745-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:36 INFO - Running setup.py (path:/tmp/pip-KGYSzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:36 INFO - Running setup.py (path:/tmp/pip-dnDMPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:36 INFO - Running setup.py (path:/tmp/pip-TFpnD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:36 INFO - Running setup.py (path:/tmp/pip-De2anX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:36 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)) 03:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:36 INFO - Running setup.py (path:/tmp/pip-CP4nKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:37 INFO - Running setup.py (path:/tmp/pip-Hq26JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:37 INFO - Running setup.py (path:/tmp/pip-6h3zfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:37 INFO - Running setup.py (path:/tmp/pip-INbWUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:37 INFO - Running setup.py (path:/tmp/pip-SZFGb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:37 INFO - Running setup.py (path:/tmp/pip-f5meRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:37 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)) 03:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:37 INFO - Running setup.py (path:/tmp/pip-oQxsd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:37 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)) 03:38:37 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)) 03:38:37 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)) 03:38:37 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)) 03:38:37 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)) 03:38:37 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)) 03:38:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:39 INFO - Downloading blessings-1.6.tar.gz 03:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:39 INFO - Installing collected packages: blessings 03:38:39 INFO - Running setup.py install for blessings 03:38:39 INFO - Successfully installed blessings 03:38:39 INFO - Cleaning up... 03:38:39 INFO - Return code: 0 03:38:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:39 INFO - Reading from file tmpfile_stdout 03:38:39 INFO - Current package versions: 03:38:39 INFO - argparse == 1.2.1 03:38:39 INFO - blessings == 1.6 03:38:39 INFO - blobuploader == 1.2.4 03:38:39 INFO - docopt == 0.6.1 03:38:39 INFO - functools32 == 3.2.3-2 03:38:39 INFO - jsonschema == 2.5.1 03:38:39 INFO - manifestparser == 1.1 03:38:39 INFO - mozInstall == 1.12 03:38:39 INFO - mozcrash == 0.17 03:38:39 INFO - mozdebug == 0.1 03:38:39 INFO - mozdevice == 0.48 03:38:39 INFO - mozfile == 1.2 03:38:39 INFO - mozhttpd == 0.7 03:38:39 INFO - mozinfo == 0.9 03:38:39 INFO - mozleak == 0.1 03:38:39 INFO - mozlog == 3.3 03:38:39 INFO - moznetwork == 0.27 03:38:39 INFO - mozprocess == 0.23 03:38:39 INFO - mozprofile == 0.28 03:38:39 INFO - mozrunner == 6.12 03:38:39 INFO - mozscreenshot == 0.1 03:38:39 INFO - mozsystemmonitor == 0.3 03:38:39 INFO - moztest == 0.7 03:38:39 INFO - mozversion == 1.4 03:38:39 INFO - psutil == 3.1.1 03:38:39 INFO - requests == 1.2.3 03:38:39 INFO - wsgiref == 0.1.2 03:38:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:39 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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:39 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 03:38:39 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 03:38:39 INFO - Using env: {'DISPLAY': ':0', 03:38:39 INFO - 'HOME': '/home/cltbld', 03:38:39 INFO - 'LANG': 'en_US.UTF-8', 03:38:39 INFO - 'LANGUAGE': 'en_US:en', 03:38:39 INFO - 'LOGNAME': 'cltbld', 03:38:39 INFO - 'MAIL': '/var/mail/cltbld', 03:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:39 INFO - 'MOZ_NO_REMOTE': '1', 03:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:39 INFO - 'NO_EM_RESTART': '1', 03:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:39 INFO - 'PWD': '/builds/slave/test', 03:38:39 INFO - 'SHELL': '/bin/bash', 03:38:39 INFO - 'SHLVL': '1', 03:38:39 INFO - 'TERM': 'linux', 03:38:39 INFO - 'TMOUT': '86400', 03:38:39 INFO - 'USER': 'cltbld', 03:38:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:39 INFO - '_': '/tools/buildbot/bin/python'} 03:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 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)) 03:38:40 INFO - Cleaning up... 03:38:40 INFO - Return code: 0 03:38:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:40 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')]} 03:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:40 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')]} 03:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:40 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 0x1871030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', '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 03:38:40 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 03:38:40 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 03:38:40 INFO - Using env: {'DISPLAY': ':0', 03:38:40 INFO - 'HOME': '/home/cltbld', 03:38:40 INFO - 'LANG': 'en_US.UTF-8', 03:38:40 INFO - 'LANGUAGE': 'en_US:en', 03:38:40 INFO - 'LOGNAME': 'cltbld', 03:38:40 INFO - 'MAIL': '/var/mail/cltbld', 03:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:40 INFO - 'MOZ_NO_REMOTE': '1', 03:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:40 INFO - 'NO_EM_RESTART': '1', 03:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:40 INFO - 'PWD': '/builds/slave/test', 03:38:40 INFO - 'SHELL': '/bin/bash', 03:38:40 INFO - 'SHLVL': '1', 03:38:40 INFO - 'TERM': 'linux', 03:38:40 INFO - 'TMOUT': '86400', 03:38:40 INFO - 'USER': 'cltbld', 03:38:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:40 INFO - '_': '/tools/buildbot/bin/python'} 03:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:38:40 INFO - Cleaning up... 03:38:40 INFO - Return code: 0 03:38:40 INFO - Running post-action listener: _resource_record_post_action 03:38:40 INFO - Running post-action listener: _start_resource_monitoring 03:38:40 INFO - Starting resource monitoring. 03:38:40 INFO - [mozharness: 2016-08-05 10:38:40.285273Z] Finished create-virtualenv step (success) 03:38:40 INFO - [mozharness: 2016-08-05 10:38:40.285875Z] Running install step. 03:38:40 INFO - Running pre-action listener: _resource_record_pre_action 03:38:40 INFO - Running main action method: install 03:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:40 INFO - Reading from file tmpfile_stdout 03:38:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:38:40 INFO - Reading from file tmpfile_stdout 03:38:40 INFO - Output received: 03:38:40 INFO - Usage: mozinstall [options] installer 03:38:40 INFO - Options: 03:38:40 INFO - -h, --help show this help message and exit 03:38:40 INFO - -d DEST, --destination=DEST 03:38:40 INFO - Directory to install application into. [default: 03:38:40 INFO - "/builds/slave/test"] 03:38:40 INFO - --app=APP Application being installed. [default: firefox] 03:38:40 INFO - mkdir: /builds/slave/test/build/application 03:38:40 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'] 03:38:40 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 03:38:56 INFO - Reading from file tmpfile_stdout 03:38:56 INFO - Output received: 03:38:56 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:56 INFO - Running post-action listener: _resource_record_post_action 03:38:56 INFO - [mozharness: 2016-08-05 10:38:56.649096Z] Finished install step (success) 03:38:56 INFO - [mozharness: 2016-08-05 10:38:56.649368Z] Running run-tests step. 03:38:56 INFO - Running pre-action listener: _resource_record_pre_action 03:38:56 INFO - Running main action method: run_tests 03:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:56 INFO - Python 2.7.3 03:38:56 INFO - Return code: 0 03:38:56 INFO - grabbing minidump binary from tooltool 03:38:56 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')]} 03:38:56 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 0x1b303b0>, '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 0x1b312b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b31740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:56 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 03:38:56 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 03:38:56 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 03:38:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:56 INFO - Return code: 0 03:38:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:56 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/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 03:38:56 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/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 03:38:56 INFO - Using env: {'DISPLAY': ':0', 03:38:56 INFO - 'HOME': '/home/cltbld', 03:38:56 INFO - 'LANG': 'en_US.UTF-8', 03:38:56 INFO - 'LANGUAGE': 'en_US:en', 03:38:56 INFO - 'LOGNAME': 'cltbld', 03:38:56 INFO - 'MAIL': '/var/mail/cltbld', 03:38:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:56 INFO - 'MOZ_NO_REMOTE': '1', 03:38:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:56 INFO - 'NO_EM_RESTART': '1', 03:38:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:56 INFO - 'PWD': '/builds/slave/test', 03:38:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:56 INFO - 'SHELL': '/bin/bash', 03:38:56 INFO - 'SHLVL': '1', 03:38:56 INFO - 'TERM': 'linux', 03:38:56 INFO - 'TMOUT': '86400', 03:38:56 INFO - 'USER': 'cltbld', 03:38:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041', 03:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:56 INFO - '_': '/tools/buildbot/bin/python'} 03:38:56 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/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 03:38:56 INFO - mozversion application_buildid: 20160805004022 03:38:56 INFO - mozversion application_changeset: 89b4dd71d6a204852532d9bb2d52b744615d74bb 03:38:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:56 INFO - mozversion application_name: Firefox 03:38:56 INFO - mozversion application_remotingname: firefox-dev 03:38:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:56 INFO - mozversion application_vendor: Mozilla 03:38:56 INFO - mozversion application_version: 50.0a2 03:38:56 INFO - mozversion platform_buildid: 20160805004022 03:38:56 INFO - mozversion platform_changeset: 89b4dd71d6a204852532d9bb2d52b744615d74bb 03:38:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:56 INFO - mozversion platform_version: 50.0a2 03:38:56 INFO - using testdate: 1470393536 03:38:56 INFO - actual date: 1470393536 03:38:56 INFO - starting webserver on 'localhost:44648' 03:38:56 INFO - SUITE-START | Running 2 tests 03:38:56 INFO - TEST-START | dromaeo_css 03:38:56 INFO - operating with platform_type : linux_ 03:38:56 INFO - Initialising browser for dromaeo_css test... 03:38:56 INFO - TEST-INFO | started process 9566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavBVjV/profile http://localhost:44648/getInfo.html) 03:39:00 INFO - PROCESS | 9566 | __metrics Screen width/height:1600/1200 03:39:00 INFO - PROCESS | 9566 | colorDepth:24 03:39:00 INFO - PROCESS | 9566 | Browser inner width/height: 1024/697 03:39:00 INFO - PROCESS | 9566 | __metrics 03:39:01 INFO - PROCESS | 9566 | 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" 03:39:01 INFO - PROCESS | 9566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:02 INFO - TEST-INFO | 9566: exit 0 03:39:02 INFO - Browser initialized. 03:39:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:02 INFO - TEST-INFO | started process 9651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavBVjV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:14 INFO - PROCESS | 9651 | RSS: Main: 145162240 03:39:14 INFO - PROCESS | 9651 | 03:40:05 INFO - PROCESS | 9651 | 1470393605155 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] 03:42:14 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44648/tests/dromaeo/cssquery-ext.html) 03:42:15 INFO - PROCESS | 9651 | RSS: Main: 221184000 03:42:15 INFO - PROCESS | 9651 | 03:45:17 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-ext.html (next: http://localhost:44648/tests/dromaeo/cssquery-jquery.html) 03:45:18 INFO - PROCESS | 9651 | RSS: Main: 230092800 03:45:18 INFO - PROCESS | 9651 | 03:48:20 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44648/tests/dromaeo/cssquery-mootools.html) 03:48:20 INFO - PROCESS | 9651 | RSS: Main: 205402112 03:48:20 INFO - PROCESS | 9651 | 03:51:22 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44648/tests/dromaeo/cssquery-prototype.html) 03:51:23 INFO - PROCESS | 9651 | RSS: Main: 221294592 03:51:23 INFO - PROCESS | 9651 | 03:54:25 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44648/tests/dromaeo/cssquery-yui.html) 03:54:26 INFO - PROCESS | 9651 | RSS: Main: 177016832 03:54:26 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | Cycle 1(1): loaded http://localhost:44648/tests/dromaeo/cssquery-yui.html (next: http://localhost:44648/tests/dromaeo/cssquery-dojo.html) 03:57:28 INFO - PROCESS | 9651 | RSS: Main: 260374528 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | __start_tp_report 03:57:28 INFO - PROCESS | 9651 | _x_x_mozilla_page_load 03:57:28 INFO - PROCESS | 9651 | _x_x_mozilla_page_load_details 03:57:28 INFO - PROCESS | 9651 | |i|pagename|runs| 03:57:28 INFO - PROCESS | 9651 | |0;dojo.html;3286.5727455430797;3308.2060305526675;3312.3540909522653;3341.766076374655;3345.5818022747158;5610.102383618617;5730.512906402955;5740.138979153118;5746.0806270996645;5761.279840019997;5677.261955945722;5719.914201286984;5736.4550367715;5742.339630942432;5776.133579963008;4991.625628077891;5102.0306141833025;5124.8975020499565;5183.067047931371;5205.531502164805;5017.774200161001;5122.92315615266;5157.174852023677;5177;5181.481851814826;5063.696178229299;5112.335396398463;5122.897542049157;5139.383274007106;5146.74266286686;5197.948020519803;5211.895762084737;5218.139007063849;5225.451327610622;5251.6061295403;4945.554900059012;4954.975225123887;4997.250412438127;5091.930694554148;5102.821401250939;5476.67139971603;5491.588130890199;5504.614676972614;5520.447955204488;5544.279243698334;6032.095185722133;6065.8180254592435;6078.787242446493;6080.635161890256;6081.726322315506;5844.1818145459665;5941.168236446901;6045.486133678643;6058.575899687024;6086.969565152191;5741.827745167651;5751.338596061465;5758.193852860602;5761.596688231867;5761.971190144022;6254.2807577129215;6261.530385221035;6263.874722505616;6266;6271.184745982993;5793.420657934257;5896.616719913192;5940.732667029994;5948.7323070461935;6043.395660434009;6114.4190257321325;6115.357887421846;6115.785947491817;6119.663418512025;6140.232470941132;6089.117078023662;6091.2081429414775;6093.2078829751845;6093.786717464867;6113.724882380304;5854.121881717776;5967.671778052162;6005.849853753691;6020.397960203944;6133.0800379942475;4624.838130665478;4657.1617108920045;4658.0218154188;4661;4693.272542755878;4156.750594964312;4168.7290326128705;4178.331466965271;4189.162167566499;4191.601797829201;5605.887882242332;5719.971400143056;5777.277840269966;5782.277215348082;5873.295204575478;6167.259928808482;6173.783917562864;6177.938220617826;6180.81457556274;6185.072239164071;5825.650460972355;5827.504662103769;5830.212921255661;5831.504322132581;5841.912371314434;5139.794408223704;5174.301469301671;5220.738963051908;5260.658057226268;5351.143816989263;6340.809775706736;6381.553291269659;6383.776567820104;6384.457321127663;6393.392627700361;6095.817125486243;6106.175666285172;6159.137720719193;6168.907466388097;6178.227721534809;6190.783322583688;6211.192544969125;6228.719707613078;6236.75052997875;6306.400891915261;5994.700264986646;6001.879962400641;6005.069214271794;6009.90985135232;6041.335453100243;6082.635041897501;6099.603525770811;6101.38986101404;6102.4507794298725;6103.572749907464;5758;5848.064309710426;5897.321807992136;5909.468147866713;6027.457528822427;5938.4061593842;5970.343262241063;5974.2830860297045;5979.312379076462;5982.4316689914385;5898.970505147447;5955.583109182489;5966.403359663999;5969.611975221596;5975.073863551156;5902;5933.851653708692;6006.429389208019;6008.03871380577;6113.144159817718;5874.676892770939;5896.204012458435;5921.792737254175;5924.940750592611;5931.733072011856 03:57:28 INFO - PROCESS | 9651 | |1;ext.html;600.9308929473109;615.6706162203222;616.9228846394203;638.9552731308809;652.1359199061245;36994.815025924865;48000.519994800045;48955.51044489554;48994.26508602374;49123.75438122814;51605.74197129009;52027.479725202735;52041.73979130109;52109;52129;8684.001339845903;9390.436573805559;9556.713298601053;9556.80886382272;11245.943770281137;11014.724631884186;11441.485133169028;11475.426228688531;11490.942545287262;11493.310401375902;11519.078473722082;11556.90209430107;11578.478968446398;11581.710457238552;11582.362970036645;11447.141464390163;11488.483018264198;11504.597339093176;11517.13621478384;11517.942410287978;11293.71765705864;11374;11390.316581005167;11397.316161030365;11400.258983166068;47424;47720;47795.761021194674;47854.28218576689;47858.28212576814;4103.97948010261;4188.308929026707;4332.588404101605;4480.260756975095;4718.716876987358;35804.28391432157;36189.45715814265;36230.818845905604;36526.45210321847;38236.617633823866;4703.2474804031535;4761.714297142183;4785.545373189541;4789.3294938708605;4829.951700482985;403418;409905;410571;411567;411940;68473;68973;69018.65490672615;69038.65480672666;69052.65473672599;40387.59612403897;40864.591354086675;41200;71070.64464677643;71316.64341678258;16446.83553164477;16648.75026874598;16659.41692040797;16661.916690416714;16670.58323541897;12651.873481265253;12755.872441275655;12862.935685321514;12971;13177.868221317856;21574.24490142869;21605.703657780585;21771.238006670006;21788.782112178993;21801.345959621238;7609.467337286337;7629.427792915553;7702.767557190822;7788.104367997639;7945.443818932619;1030.835066389374;1071.651090342679;1076.1283360478037;1208.2086233517061;1222.6759908624222;35591.28817423637;36443.45334819927;36549;36607;36666.45000324997;1142.257532603814;1145.9713507162387;1204.8433703618473;1209.5101483899034;1271.205496564647;18740.344087957128;18861.81138188628;18862.43412697621;18952.62094758097;19021.524461888286;580113;632512;643922;645800;979789;68198.65900670465;68877;69036.6548167256;69157.65421172862;69389.65305173442;1359.632899117233;1426.5862899759368;1463.6706740983193;1484.9925750371178;1522.4519173097676;32783.83608081944;36946.261074777816;37106.25787484181;37177.81411092927;37602.811985939894;57721;58313.4168658308;58416.78707671119;58442;58491.4150858503;423960;426828;426960;427848.7215127809;428302;28974.27564310825;30588.388232235677;30642.233944151576;30727.078187654406;32826;54346.72826635841;55479.44520554904;55634;56402.71798640981;56676.43323566877;46479;47598.52401476079;47978;48318;48443.5155648439;46251.53748462472;47275;47523.28715069208;47843.28235076407;48425.757871210415;44912.32631510595;45442.31836522389;46006.07987840292;46249.76875115603;46340.768296158305;39941.80029099836;41139;41548.3767743478;41995.37006944837;42033.57966420297;27930.86034569814;27965;28148.577771333858;28172.71827281701;28189.718102818708 03:57:28 INFO - PROCESS | 9651 | |2;jquery.html;409.4860949508367;411.36649559678096;427.8759159843645;429.80873511287473;441.7967734841973;19599.902000489994;20557.794422055777;21181.788182118195;21706.89146554269;21904.780952190475;18136.727949080774;19820.60358792823;20443.284485043027;20573.074211660474;20749.17003319869;5779.508741756956;6050.939490605104;6053.303870054956;6055.303640081381;6056.757729690807;5728.255326807509;5877.6473411595225;5903.11453282009;5926.229590153274;5959.16571679963;5873.972054890399;5877.52979761618;5877.764889404419;5886.175935369051;5937.940620593804;5762.078067509199;5893.351731309574;5957.553183511254;5965.850853728648;5971.283445986466;5268.841934741964;5325.440828713007;5356.517913387775;5360.088784906575;5361.865953351197;24191.153309634254;24330.635040474408;24534.263972080866;24678.876605617035;24760.876195619087;2634.538955682767;2645.7751091157274;2664.5736682130764;2734.7265273472494;2939.1917222763695;14873.553793386216;15602.687946241012;15638.13990230537;15647.139407332592;16367.59081022984;1874.6438176746374;1982.3656429942423;2029.1173339597322;2049.405672355015;2106.368089573122;73704;79957.20042799556;80294.19705802925;81319.5934020332;82281;11120.110391168688;11268.605598804166;11419.371934543513;11451.141164412702;11553;16339.101349425895;16340.673186536204;16352.100634464981;16366.427175049053;16366.754498682529;8549.957250213834;8622.31021518277;8944.01615822259;8973.237274831581;9123.452592844318;8625.69810056645;8665.2634526066;8696.695615653422;8883.37816352849;8889.511076890703;7098.3256590623805;7181.245969173162;7211.206767255598;7236.286392602774;7270.913875763502;2078.864873783199;2131.531063166101;2138.155428605723;2139.229877244191;2139.6362618354915;1061.787642471509;1063.1441689440076;1070.9250352475408;1099.2854644481151;1104.1994553948323;20446;21422.464438389165;21476;21746.782532174475;21779.346619601438;1058.7564860082225;1060.9337615696177;1065.4566171252718;1072.5924148823397;1142.0863309352485;11224.719382015352;12282.877171228174;12317.8298061684;12472.314022728837;12497.500099995897;468130;468795;484984;549095;549944;78223;79973;82449.17550824535;83754;87235;1071.7695695425366;1081.8377243413393;1088.2327958789035;1102.2449622008949;1128.5767837061103;18381;18758.624827503645;19092.33176838804;19333.419997400102;19347;41880.79059604683;42298.01760795446;42530.5746942539;42851.357229640955;43183;56400.15399769089;56929;57080;57134;59202.11196832137;8256.628451719567;8334.416590838584;8374.790630234293;8442.197991191073;8662.133786621287;12842.871571284168;13353.399097040463;14281.64295892611;14435.566932992027;14488.855111449173;12273.938630307148;12554.43505042257;12628.43172057278;12892.935535322264;13049.804252936403;11844;12057.457414416196;12061.457234424297;12161.574344897886;12789.296588687712;11882.524699011943;12313.815292770436;12493.125481216592;12551;13099.476020959437;9144.268458523435;9154;9261.583228754587;9599.976245032467;9715.951420243136;10418.479076046016;12039.518419263131;12310.384480776105;12429.689257768629;12554.157671406167 03:57:28 INFO - PROCESS | 9651 | |3;mootools.html;1391.1653008195078;1527.7250094982903;1587.9995602770252;1764.3383731100837;1916.4538106639611;8721.651133954641;9031.142041506055;9067.682631107913;9287.814243715138;9303.11620396063;9071.365004449692;9215.354925155241;9277.25781937445;9295.535223238845;9295.814083718322;2441.877906104692;2464.2484042367073;2464.544059349026;2464.6426268191103;2466.7903228225623;2389.283215035491;2435.0990133650575;2441.389652586853;2443.328084776692;2444.0590372706547;2107.283523601975;2109.9789002109937;2117.227212067592;2120.3532922458644;2131.2540610786177;2310.653401989698;2372.5729368713623;2379.7263314718857;2381.214199314231;2405.9639105413435;2360.409897525619;2363.515479326734;2364.1843563970574;2368.798652114572;2368.881555922197;9166.954165229132;9178.082191780835;9255.305852061123;9276.304277179172;9296.349255552046;5236.7119808410525;5441.782328706847;5449.264349312872;5450.836474905759;5451.509364157245;3517.7009954153928;3529.100079479742;3535.6641119093647;3582.3193593217206;3603.8017909014993;1227.3924407418297;1230.1819290172025;1231.6612931443835;1249.7562975219835;1259.6913756129716;13465.528706495325;13594.32028398586;13605.659858503517;13624.250666213355;13627.863721362759;4593.26507758757;4633.374494443275;4733.077049975291;4735.739534325577;4905.2151655734915;10506.737331566772;10538.57845686164;10594.311369761095;10614.893851061544;10622.256442048982;5593.580481463825;5600.85997850057;5607.635503692247;5629.943700563023;5635.154726790932;4651.279051746985;4698.506656801055;5190.896182076337;5210.036143313499;5234.42421333653;3993.4409182714444;3996.9600303997167;4046.826420338069;4075.184963007351;4105.261053010487;1150.775598758251;1151.5048529132387;1152.6714886257375;1174.4790496307303;1197.4970512384818;908.881845360099;1018.5467466977124;1021.5760459409411;1026.9229807764448;1037.9481025948671;6371.617702937839;6511.739530418825;6625.668716564152;6702.497312701469;6723.462123030145;979.7942432089341;980.294188184506;1002.1982414068716;1012.8480727890875;1034.0848349211003;3974.18529201513;4322.416473776063;4424.601785839225;4456.68803183774;4468.754218517947;11710.70723231926;12126.575569855013;12158.270503769802;12162.209456385306;12193.817092743617;11911.404429778477;12037.759244815055;12066.879331206575;12303.384830758427;12328;8605.354598405145;8627.95686021566;8647.740567782977;8672.913270867211;8761.912380876238;6234.35202479838;6374.107624932606;6417.454516366161;6528.771492997722;6574.276829548841;10822.458877056273;10870.130389568974;10901.149082967138;10952.452377381258;11133;11151.72120696989;11230;11303.660890173307;11331.603393881504;11380.658580242605;8140.592970351578;8159.143289954469;8220.6846904495;8327.833443331221;8539.444936079135;9373.625054997723;9387.953060234655;9443.055694430503;9444.338896277195;9469.810603788024;8237.876431853647;8249.587520624065;8353.791155221168;8496.192861678377;8544.829103417773;8129.187081291823;8149.633266502903;8158.3065439438315;8245.299149572114;8297.709580164665;7421.888671670037;7529.247075292427;7590;7720.3437707795465;7741.7677469676;5396.244525766318;5486.890262194814;5519.972400137974;5658.17956396312;5689.288838895138;5600.35595906476;5607.467290607386;5718;5723;5817.360090390139 03:57:28 INFO - PROCESS | 9651 | |4;prototype.html;337.6050021474874;358.5500197252448;358.64253799369385;359.84166966534707;366.594912621553;5530.3363596368445;5562.970850392675;5604.551635869131;5605.859853503654;5613.578981576377;5221.869453263661;5270.209468579715;5392.406835248129;5471.50756431921;5552.500274975251;4302.376155457457;4324.502682191541;4324.783760811963;4337.633645401696;4339.522652508222;4333;4352.607165706975;4364.214441400547;4367.825286988516;4373.469285749994;4137.193247316774;4285.357196420547;4308.159908817782;4310.030243195288;4331.43691320128;4262.850800221977;4296.839853239608;4300.913981720348;4311.935320970172;4314.331278651814;3813.904652383685;3819;3828.712846536521;3833.8083095845377;3834.731568790186;5235.3717553893775;5327.413984461706;5365.141577347606;5429.131338985743;5431.886463275019;4924.039812236615;4927.915858511157;4932.260160975847;4934.950650493521;4935.988122434892;5716.742746576372;5720.313562372542;5731.570132240098;5733.770649174028;5744.22452968848;4087.2847251731127;4113.732607380541;4139.958600413987;4172.207280616673;4177.373393990895;5897.410258974069;5913.704314784287;5921.134842524591;5924;5949.732262048175;4265.762928750628;4269.914601707948;4270.29540125882;4274.829006839692;4280.6789490788315;4186.330187170038;4349.391085248068;4354.695171337976;4355.867474456664;4381.605655490957;4896.2655601660035;4898.951010489921;4901.436334821541;4905.190643543775;4919.237518184687;5787.594868359174;5805.216295800013;5809.24479817621;5820.854478637983;5835.941640583625;1457.7813328000673;1461.152531531709;1499.2054211268046;1511.586666466857;1515.772634104871;940.5062342270226;963.2631037256505;967.7580604848788;968.4431451915177;972.8103019911049;5013.949860501421;5025.4974502550185;5028.823991160292;5034.697918124924;5045.495450454925;5220.686758794484;5259.684418934876;5259.895421961431;5261.973690131601;5277.445868183862;4680.648951328664;5020.146575082244;5024.537976391542;5042.016806722727;5043;2793.4133831895124;2793.846338451405;2801.3836955869674;2805.5130780685863;2817.225263052677;5428.728563571805;5436.401995780461;5454.972725136349;5459.372172200168;5474.644148130359;5180.948190518046;5204.739763011834;5224.529792318634;5295.973520132375;5383.838484845461;5351.545118664879;5371.495981125291;5373.865653358619;5388.407275199725;5481.588880833874;5210.609204309616;5215.1056163829435;5266.394364647961;5284.26020357158;5306.708131052675;4923.458419573915;5131.743412829269;5152.805260738366;5163.3545806774155;5170.793168273227;5345.625806193529;5375;5385.703786291791;5388.865278368072;5482.5613950883035;3932.6067393260446;3954.3079961007284;3959.4852669152824;3979.164375481181;4008.9198216034933;5327.600429967691;5893.116032595145;5903.852403689943;5910.763569457174;5927.347991720993;5777.162311464898;5792.3917988612275;5801.883962320646;5804.593678442468;5823.621464604787;5656.3132512056445;5659.858503537444;5774.307083150049;5807.128930660435;5829;5788.392218817132;5795.884082318415;5818.563607729353;5828.329742079715;5841.831633673198;5864.736086876186;5864.765409383577;5870.823875283749;5881.353051164454;5881.823545293648;5519.641223320471;5644.604877658525;5696.1455781633085;5719.370869204467;5724.685142317213 03:57:28 INFO - PROCESS | 9651 | |5;yui.html;823.7816978500698;835.9289460395865;842.7850898021005;852.279823549101;896.4486840593037;16475.423360182394;17570.736438953427;17751.911240443813;17817.10914454277;17826.376076837296;16260.268287927041;16302.592435189126;16395.4261600844;16485.01089934605;16570;886.0165216609558;905.3888625178012;908.6229214875818;908.727381785465;908.7728067983004;733.2264460993649;886.76500727307;891.5765011619461;901.711452335253;908.9636414543444;939.9624015039391;947.4646824544111;948.2129832239225;948.506776476232;949.9382540134903;940.3276657190141;941.6610020392619;942.7878727286375;942.985855212169;944.6552008516842;568.1761445903456;661.2527843536773;674.6356967237685;676.347324831535;696.8954656801469;16178.676426471522;17005.319787208497;17010.744838827304;17057.2324245408;17059.40292089783;15238.695226095528;16140.435084771976;16314.265858036417;16491.422800202054;16831.242594083295;13731.24478153701;14256.572302830931;14655;14680;14812.555623331318;4553.294239392866;4621.537846215351;4639.350490931272;4671.649626278008;4674.111918735463;86898;86956;87012.5649371749;87442.56278718566;87609;11753.764924701458;11763.823542646867;11837.351636642927;12039;12132.968697660797;21532.354029379145;21603.56792864134;21668.566628667337;21763.12947482083;21782.346529604136;9046.140616641409;9087.68193113251;9213.90786092144;9274;9364.90635093654;4932.778024988884;5062.797488100435;5129.153689641242;5197.922031169535;5201.557867581222;3771.8868433947027;3873.4770805941403;3875.5349358076646;3877.1664092219744;3879.6702280305926;514.8738559053056;594.560025581067;594.9434803693642;595.9851003724855;600.3246347858659;625.2778041362234;641.0640464921267;745.273358475482;773.9303462688385;789.5933594198992;10049.447280399649;10100.898991010143;10164.136048435967;10256.538455769509;10472.476376181161;683.2586643491768;698.420875354165;770.1989930472246;818.9713360032371;862.3187681731362;4837.6613637045775;4853.514648535118;4912.38595175603;5082.872928176826;5324.760385782649;66444;119854;120840;123199.76800232062;125066.3746681279;100867;100895;101342;101442.49278753706;105668.94331056591;82606.58696706599;92209;92448.07551924529;93022.53488732649;93355;10054.54754536033;10701.732456688645;10795.514201861091;11080.889191108308;11357.432128393713;54540;54742.45257547373;55403;55972.440275596724;56541.71729141328;69205.65397172981;78675.21324786908;79355.20644793478;81295.59352203438;81784;12998;13411.061225714106;13826.65433364174;14185.432582696989;14197.787033194303;15231.238438078273;15355.923220383827;15418.768718469457;15839.445619403266;16129.67740645204;14647.70704585881;14836.247536853743;15145.924270379019;15236.060073494133;15966.840331597;13013.869861301266;13144.934275328562;13203.339833008504;14249.928750356183;14735.2632368379;13184;13193.80209296842;13214.867851321364;13218.272994985367;13238.801417978932;9519.904800951901;9583.904160958302;9640.42157470554;9819.85270220933;10014.449205293779;10323.277370583986;10524.473776311;10612.151027917902;10683.786324273626;10763.461826908466 03:57:28 INFO - PROCESS | 9651 | __end_tp_report 03:57:28 INFO - PROCESS | 9651 | __start_cc_report 03:57:28 INFO - PROCESS | 9651 | _x_x_mozilla_cycle_collect,1026 03:57:28 INFO - PROCESS | 9651 | __end_cc_report 03:57:28 INFO - PROCESS | 9651 | __startTimestamp1470394648709__endTimestamp 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | ------- Summary: start ------- 03:57:28 INFO - PROCESS | 9651 | Number of tests: 6 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#0] dojo.html Cycles:165 Average:5651.60 Median:5896.62 stddev:648.19 (11.0%) stddev-sans-first:623.06 03:57:28 INFO - PROCESS | 9651 | Values: 3286.6 3308.2 3312.4 3341.8 3345.6 5610.1 5730.5 5740.1 5746.1 5761.3 5677.3 5719.9 5736.5 5742.3 5776.1 4991.6 5102.0 5124.9 5183.1 5205.5 5017.8 5122.9 5157.2 5177.0 5181.5 5063.7 5112.3 5122.9 5139.4 5146.7 5197.9 5211.9 5218.1 5225.5 5251.6 4945.6 4955.0 4997.3 5091.9 5102.8 5476.7 5491.6 5504.6 5520.4 5544.3 6032.1 6065.8 6078.8 6080.6 6081.7 5844.2 5941.2 6045.5 6058.6 6087.0 5741.8 5751.3 5758.2 5761.6 5762.0 6254.3 6261.5 6263.9 6266.0 6271.2 5793.4 5896.6 5940.7 5948.7 6043.4 6114.4 6115.4 6115.8 6119.7 6140.2 6089.1 6091.2 6093.2 6093.8 6113.7 5854.1 5967.7 6005.8 6020.4 6133.1 4624.8 4657.2 4658.0 4661.0 4693.3 4156.8 4168.7 4178.3 4189.2 4191.6 5605.9 5720.0 5777.3 5782.3 5873.3 6167.3 6173.8 6177.9 6180.8 6185.1 5825.7 5827.5 5830.2 5831.5 5841.9 5139.8 5174.3 5220.7 5260.7 5351.1 6340.8 6381.6 6383.8 6384.5 6393.4 6095.8 6106.2 6159.1 6168.9 6178.2 6190.8 6211.2 6228.7 6236.8 6306.4 5994.7 6001.9 6005.1 6009.9 6041.3 6082.6 6099.6 6101.4 6102.5 6103.6 5758.0 5848.1 5897.3 5909.5 6027.5 5938.4 5970.3 5974.3 5979.3 5982.4 5899.0 5955.6 5966.4 5969.6 5975.1 5902.0 5933.9 6006.4 6008.0 6113.1 5874.7 5896.2 5921.8 5924.9 5931.7 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#1] ext.html Cycles:180 Average:68915.23 Median:411753.50 stddev:142479.28 (34.6%) stddev-sans-first:142786.65 03:57:28 INFO - PROCESS | 9651 | Values: 600.9 615.7 616.9 639.0 652.1 36994.8 48000.5 48955.5 48994.3 49123.8 51605.7 52027.5 52041.7 52109.0 52129.0 8684.0 9390.4 9556.7 9556.8 11245.9 11014.7 11441.5 11475.4 11490.9 11493.3 11519.1 11556.9 11578.5 11581.7 11582.4 11447.1 11488.5 11504.6 11517.1 11517.9 11293.7 11374.0 11390.3 11397.3 11400.3 47424.0 47720.0 47795.8 47854.3 47858.3 4104.0 4188.3 4332.6 4480.3 4718.7 35804.3 36189.5 36230.8 36526.5 38236.6 4703.2 4761.7 4785.5 4789.3 4830.0 403418.0 409905.0 410571.0 411567.0 411940.0 68473.0 68973.0 69018.7 69038.7 69052.7 40387.6 40864.6 41200.0 71070.6 71316.6 16446.8 16648.8 16659.4 16661.9 16670.6 12651.9 12755.9 12862.9 12971.0 13177.9 21574.2 21605.7 21771.2 21788.8 21801.3 7609.5 7629.4 7702.8 7788.1 7945.4 1030.8 1071.7 1076.1 1208.2 1222.7 35591.3 36443.5 36549.0 36607.0 36666.5 1142.3 1146.0 1204.8 1209.5 1271.2 18740.3 18861.8 18862.4 18952.6 19021.5 580113.0 632512.0 643922.0 645800.0 979789.0 68198.7 68877.0 69036.7 69157.7 69389.7 1359.6 1426.6 1463.7 1485.0 1522.5 32783.8 36946.3 37106.3 37177.8 37602.8 57721.0 58313.4 58416.8 58442.0 58491.4 423960.0 426828.0 426960.0 427848.7 428302.0 28974.3 30588.4 30642.2 30727.1 32826.0 54346.7 55479.4 55634.0 56402.7 56676.4 46479.0 47598.5 47978.0 48318.0 48443.5 46251.5 47275.0 47523.3 47843.3 48425.8 44912.3 45442.3 46006.1 46249.8 46340.8 39941.8 41139.0 41548.4 41995.4 42033.6 27930.9 27965.0 28148.6 28172.7 28189.7 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#2] jquery.html Cycles:180 Average:29791.96 Median:24260.89 stddev:82942.14 (341.9%) stddev-sans-first:83145.47 03:57:28 INFO - PROCESS | 9651 | Values: 409.5 411.4 427.9 429.8 441.8 19599.9 20557.8 21181.8 21706.9 21904.8 18136.7 19820.6 20443.3 20573.1 20749.2 5779.5 6050.9 6053.3 6055.3 6056.8 5728.3 5877.6 5903.1 5926.2 5959.2 5874.0 5877.5 5877.8 5886.2 5937.9 5762.1 5893.4 5957.6 5965.9 5971.3 5268.8 5325.4 5356.5 5360.1 5361.9 24191.2 24330.6 24534.3 24678.9 24760.9 2634.5 2645.8 2664.6 2734.7 2939.2 14873.6 15602.7 15638.1 15647.1 16367.6 1874.6 1982.4 2029.1 2049.4 2106.4 73704.0 79957.2 80294.2 81319.6 82281.0 11120.1 11268.6 11419.4 11451.1 11553.0 16339.1 16340.7 16352.1 16366.4 16366.8 8550.0 8622.3 8944.0 8973.2 9123.5 8625.7 8665.3 8696.7 8883.4 8889.5 7098.3 7181.2 7211.2 7236.3 7270.9 2078.9 2131.5 2138.2 2139.2 2139.6 1061.8 1063.1 1070.9 1099.3 1104.2 20446.0 21422.5 21476.0 21746.8 21779.3 1058.8 1060.9 1065.5 1072.6 1142.1 11224.7 12282.9 12317.8 12472.3 12497.5 468130.0 468795.0 484984.0 549095.0 549944.0 78223.0 79973.0 82449.2 83754.0 87235.0 1071.8 1081.8 1088.2 1102.2 1128.6 18381.0 18758.6 19092.3 19333.4 19347.0 41880.8 42298.0 42530.6 42851.4 43183.0 56400.2 56929.0 57080.0 57134.0 59202.1 8256.6 8334.4 8374.8 8442.2 8662.1 12842.9 13353.4 14281.6 14435.6 14488.9 12273.9 12554.4 12628.4 12892.9 13049.8 11844.0 12057.5 12061.5 12161.6 12789.3 11882.5 12313.8 12493.1 12551.0 13099.5 9144.3 9154.0 9261.6 9600.0 9716.0 10418.5 12039.5 12310.4 12429.7 12554.2 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#3] mootools.html Cycles:180 Average:6204.71 Median:4462.72 stddev:3622.41 (81.2%) stddev-sans-first:3614.51 03:57:28 INFO - PROCESS | 9651 | Values: 1391.2 1527.7 1588.0 1764.3 1916.5 8721.7 9031.1 9067.7 9287.8 9303.1 9071.4 9215.4 9277.3 9295.5 9295.8 2441.9 2464.2 2464.5 2464.6 2466.8 2389.3 2435.1 2441.4 2443.3 2444.1 2107.3 2110.0 2117.2 2120.4 2131.3 2310.7 2372.6 2379.7 2381.2 2406.0 2360.4 2363.5 2364.2 2368.8 2368.9 9167.0 9178.1 9255.3 9276.3 9296.3 5236.7 5441.8 5449.3 5450.8 5451.5 3517.7 3529.1 3535.7 3582.3 3603.8 1227.4 1230.2 1231.7 1249.8 1259.7 13465.5 13594.3 13605.7 13624.3 13627.9 4593.3 4633.4 4733.1 4735.7 4905.2 10506.7 10538.6 10594.3 10614.9 10622.3 5593.6 5600.9 5607.6 5629.9 5635.2 4651.3 4698.5 5190.9 5210.0 5234.4 3993.4 3997.0 4046.8 4075.2 4105.3 1150.8 1151.5 1152.7 1174.5 1197.5 908.9 1018.5 1021.6 1026.9 1037.9 6371.6 6511.7 6625.7 6702.5 6723.5 979.8 980.3 1002.2 1012.8 1034.1 3974.2 4322.4 4424.6 4456.7 4468.8 11710.7 12126.6 12158.3 12162.2 12193.8 11911.4 12037.8 12066.9 12303.4 12328.0 8605.4 8628.0 8647.7 8672.9 8761.9 6234.4 6374.1 6417.5 6528.8 6574.3 10822.5 10870.1 10901.1 10952.5 11133.0 11151.7 11230.0 11303.7 11331.6 11380.7 8140.6 8159.1 8220.7 8327.8 8539.4 9373.6 9388.0 9443.1 9444.3 9469.8 8237.9 8249.6 8353.8 8496.2 8544.8 8129.2 8149.6 8158.3 8245.3 8297.7 7421.9 7529.2 7590.0 7720.3 7741.8 5396.2 5486.9 5520.0 5658.2 5689.3 5600.4 5607.5 5718.0 5723.0 5817.4 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#4] prototype.html Cycles:180 Average:4689.22 Median:5223.20 stddev:1345.65 (25.8%) stddev-sans-first:1309.18 03:57:28 INFO - PROCESS | 9651 | Values: 337.6 358.6 358.6 359.8 366.6 5530.3 5563.0 5604.6 5605.9 5613.6 5221.9 5270.2 5392.4 5471.5 5552.5 4302.4 4324.5 4324.8 4337.6 4339.5 4333.0 4352.6 4364.2 4367.8 4373.5 4137.2 4285.4 4308.2 4310.0 4331.4 4262.9 4296.8 4300.9 4311.9 4314.3 3813.9 3819.0 3828.7 3833.8 3834.7 5235.4 5327.4 5365.1 5429.1 5431.9 4924.0 4927.9 4932.3 4935.0 4936.0 5716.7 5720.3 5731.6 5733.8 5744.2 4087.3 4113.7 4140.0 4172.2 4177.4 5897.4 5913.7 5921.1 5924.0 5949.7 4265.8 4269.9 4270.3 4274.8 4280.7 4186.3 4349.4 4354.7 4355.9 4381.6 4896.3 4899.0 4901.4 4905.2 4919.2 5787.6 5805.2 5809.2 5820.9 5835.9 1457.8 1461.2 1499.2 1511.6 1515.8 940.5 963.3 967.8 968.4 972.8 5013.9 5025.5 5028.8 5034.7 5045.5 5220.7 5259.7 5259.9 5262.0 5277.4 4680.6 5020.1 5024.5 5042.0 5043.0 2793.4 2793.8 2801.4 2805.5 2817.2 5428.7 5436.4 5455.0 5459.4 5474.6 5180.9 5204.7 5224.5 5296.0 5383.8 5351.5 5371.5 5373.9 5388.4 5481.6 5210.6 5215.1 5266.4 5284.3 5306.7 4923.5 5131.7 5152.8 5163.4 5170.8 5345.6 5375.0 5385.7 5388.9 5482.6 3932.6 3954.3 3959.5 3979.2 4008.9 5327.6 5893.1 5903.9 5910.8 5927.3 5777.2 5792.4 5801.9 5804.6 5823.6 5656.3 5659.9 5774.3 5807.1 5829.0 5788.4 5795.9 5818.6 5828.3 5841.8 5864.7 5864.8 5870.8 5881.4 5881.8 5519.6 5644.6 5696.1 5719.4 5724.7 03:57:28 INFO - PROCESS | 9651 | 03:57:28 INFO - PROCESS | 9651 | [#5] yui.html Cycles:180 Average:21866.20 Median:4587.42 stddev:31112.34 (678.2%) stddev-sans-first:31159.49 03:57:28 INFO - PROCESS | 9651 | Values: 823.8 835.9 842.8 852.3 896.4 16475.4 17570.7 17751.9 17817.1 17826.4 16260.3 16302.6 16395.4 16485.0 16570.0 886.0 905.4 908.6 908.7 908.8 733.2 886.8 891.6 901.7 909.0 940.0 947.5 948.2 948.5 949.9 940.3 941.7 942.8 943.0 944.7 568.2 661.3 674.6 676.3 696.9 16178.7 17005.3 17010.7 17057.2 17059.4 15238.7 16140.4 16314.3 16491.4 16831.2 13731.2 14256.6 14655.0 14680.0 14812.6 4553.3 4621.5 4639.4 4671.6 4674.1 86898.0 86956.0 87012.6 87442.6 87609.0 11753.8 11763.8 11837.4 12039.0 12133.0 21532.4 21603.6 21668.6 21763.1 21782.3 9046.1 9087.7 9213.9 9274.0 9364.9 4932.8 5062.8 5129.2 5197.9 5201.6 3771.9 3873.5 3875.5 3877.2 3879.7 514.9 594.6 594.9 596.0 600.3 625.3 641.1 745.3 773.9 789.6 10049.4 10100.9 10164.1 10256.5 10472.5 683.3 698.4 770.2 819.0 862.3 4837.7 4853.5 4912.4 5082.9 5324.8 66444.0 119854.0 120840.0 123199.8 125066.4 100867.0 100895.0 101342.0 101442.5 105668.9 82606.6 92209.0 92448.1 93022.5 93355.0 10054.5 10701.7 10795.5 11080.9 11357.4 54540.0 54742.5 55403.0 55972.4 56541.7 69205.7 78675.2 79355.2 81295.6 81784.0 12998.0 13411.1 13826.7 14185.4 14197.8 15231.2 15355.9 15418.8 15839.4 16129.7 14647.7 14836.2 15145.9 15236.1 15966.8 13013.9 13144.9 13203.3 14249.9 14735.3 13184.0 13193.8 13214.9 13218.3 13238.8 9519.9 9583.9 9640.4 9819.9 10014.4 10323.3 10524.5 10612.2 10683.8 10763.5 03:57:28 INFO - PROCESS | 9651 | -------- Summary: end -------- 03:57:28 INFO - PROCESS | 9651 | 03:57:29 INFO - TEST-INFO | 9651: exit 0 03:57:29 INFO - TEST-OK | dromaeo_css | took 1112450ms 03:57:29 INFO - TEST-START | kraken 03:57:29 INFO - operating with platform_type : linux_ 03:57:29 INFO - Initialising browser for kraken test... 03:57:29 INFO - TEST-INFO | started process 9848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjw_fbQ/profile http://localhost:44648/getInfo.html) 03:57:33 INFO - PROCESS | 9848 | __metrics Screen width/height:1600/1200 03:57:33 INFO - PROCESS | 9848 | colorDepth:24 03:57:33 INFO - PROCESS | 9848 | Browser inner width/height: 1024/697 03:57:33 INFO - PROCESS | 9848 | __metrics 03:57:34 INFO - PROCESS | 9848 | 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" 03:57:34 INFO - PROCESS | 9848 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:57:35 INFO - TEST-INFO | 9848: exit 0 03:57:35 INFO - Browser initialized. 03:57:35 INFO - Running cycle 1/1 for kraken test... 03:57:35 INFO - TEST-INFO | started process 9936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjw_fbQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:46 INFO - PROCESS | 9936 | RSS: Main: 145039360 03:57:46 INFO - PROCESS | 9936 | 03:57:49 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44648/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:50 INFO - PROCESS | 9936 | RSS: Main: 191463424 03:57:50 INFO - PROCESS | 9936 | 03:57:52 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44648/tests/kraken/driver.html?testName=audio-dft) 03:57:53 INFO - PROCESS | 9936 | RSS: Main: 181329920 03:57:53 INFO - PROCESS | 9936 | 03:57:56 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44648/tests/kraken/driver.html?testName=audio-fft) 03:57:56 INFO - PROCESS | 9936 | RSS: Main: 270229504 03:57:56 INFO - PROCESS | 9936 | 03:57:58 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44648/tests/kraken/driver.html?testName=audio-oscillator) 03:57:59 INFO - PROCESS | 9936 | RSS: Main: 176087040 03:57:59 INFO - PROCESS | 9936 | 03:58:01 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:58:02 INFO - PROCESS | 9936 | RSS: Main: 177328128 03:58:02 INFO - PROCESS | 9936 | 03:58:05 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44648/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:05 INFO - PROCESS | 9936 | RSS: Main: 213708800 03:58:05 INFO - PROCESS | 9936 | 03:58:09 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44648/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:09 INFO - PROCESS | 9936 | RSS: Main: 212246528 03:58:09 INFO - PROCESS | 9936 | 03:58:12 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44648/tests/kraken/driver.html?testName=json-parse-financial) 03:58:13 INFO - PROCESS | 9936 | RSS: Main: 212037632 03:58:13 INFO - PROCESS | 9936 | 03:58:14 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:15 INFO - PROCESS | 9936 | RSS: Main: 175792128 03:58:15 INFO - PROCESS | 9936 | 03:58:16 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:17 INFO - PROCESS | 9936 | RSS: Main: 182095872 03:58:17 INFO - PROCESS | 9936 | 03:58:19 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:58:20 INFO - PROCESS | 9936 | RSS: Main: 186535936 03:58:20 INFO - PROCESS | 9936 | 03:58:22 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:58:23 INFO - PROCESS | 9936 | RSS: Main: 180826112 03:58:23 INFO - PROCESS | 9936 | 03:58:25 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:58:26 INFO - PROCESS | 9936 | RSS: Main: 184721408 03:58:26 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | Cycle 1(1): loaded http://localhost:44648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44648/tests/kraken/driver.html?testName=ai-astar) 03:58:28 INFO - PROCESS | 9936 | RSS: Main: 235978752 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | __start_tp_report 03:58:28 INFO - PROCESS | 9936 | _x_x_mozilla_page_load 03:58:28 INFO - PROCESS | 9936 | _x_x_mozilla_page_load_details 03:58:28 INFO - PROCESS | 9936 | |i|pagename|runs| 03:58:28 INFO - PROCESS | 9936 | |0;ai-astar;100;112;111;112;113;111;111;110;112;112 03:58:28 INFO - PROCESS | 9936 | |1;audio-beat-detection;142;114;117;187;115;123;146;116;154;120 03:58:28 INFO - PROCESS | 9936 | |2;audio-dft;159;165;161;160;162;161;161;160;161;159 03:58:28 INFO - PROCESS | 9936 | |3;audio-fft;75;75;76;122;77;76;74;76;96;74 03:58:28 INFO - PROCESS | 9936 | |4;audio-oscillator;83;83;125;82;82;82;121;82;84;130 03:58:28 INFO - PROCESS | 9936 | |5;imaging-gaussian-blur;117;117;116;125;117;117;117;117;117;117 03:58:28 INFO - PROCESS | 9936 | |6;imaging-darkroom;145;146;147;145;146;146;146;146;145;146 03:58:28 INFO - PROCESS | 9936 | |7;imaging-desaturate;94;95;94;95;94;95;95;94;97;95 03:58:28 INFO - PROCESS | 9936 | |8;json-parse-financial;51;50;50;51;51;51;51;50;51;51 03:58:28 INFO - PROCESS | 9936 | |9;json-stringify-tinderbox;62;61;60;60;60;60;60;59;60;60 03:58:28 INFO - PROCESS | 9936 | |10;stanford-crypto-aes;72;79;72;77;74;72;72;73;74;75 03:58:28 INFO - PROCESS | 9936 | |11;stanford-crypto-ccm;118;116;118;118;123;115;119;126;173;118 03:58:28 INFO - PROCESS | 9936 | |12;stanford-crypto-pbkdf2;150;153;157;155;153;152;152;152;150;150 03:58:28 INFO - PROCESS | 9936 | |13;stanford-crypto-sha256-iterative;62;65;63;60;62;61;61;60;60;61 03:58:28 INFO - PROCESS | 9936 | __end_tp_report 03:58:28 INFO - PROCESS | 9936 | __start_cc_report 03:58:28 INFO - PROCESS | 9936 | _x_x_mozilla_cycle_collect,1636 03:58:28 INFO - PROCESS | 9936 | __end_cc_report 03:58:28 INFO - PROCESS | 9936 | __startTimestamp1470394708315__endTimestamp 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | ------- Summary: start ------- 03:58:28 INFO - PROCESS | 9936 | Number of tests: 14 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.75 (3.3%) stddev-sans-first:0.88 03:58:28 INFO - PROCESS | 9936 | Values: 100.0 112.0 111.0 112.0 113.0 111.0 111.0 110.0 112.0 112.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:132.50 stddev:23.82 (18.0%) stddev-sans-first:25.06 03:58:28 INFO - PROCESS | 9936 | Values: 142.0 114.0 117.0 187.0 115.0 123.0 146.0 116.0 154.0 120.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.73 (1.1%) stddev-sans-first:1.69 03:58:28 INFO - PROCESS | 9936 | Values: 159.0 165.0 161.0 160.0 162.0 161.0 161.0 160.0 161.0 159.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:15.47 (20.4%) stddev-sans-first:16.20 03:58:28 INFO - PROCESS | 9936 | Values: 75.0 75.0 76.0 122.0 77.0 76.0 74.0 76.0 96.0 74.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:82.00 stddev:20.77 (25.3%) stddev-sans-first:21.55 03:58:28 INFO - PROCESS | 9936 | Values: 83.0 83.0 125.0 82.0 82.0 82.0 121.0 82.0 84.0 130.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:2.58 (2.2%) stddev-sans-first:2.73 03:58:28 INFO - PROCESS | 9936 | Values: 117.0 117.0 116.0 125.0 117.0 117.0 117.0 117.0 117.0 117.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:58:28 INFO - PROCESS | 9936 | Values: 145.0 146.0 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 03:58:28 INFO - PROCESS | 9936 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 97.0 95.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 03:58:28 INFO - PROCESS | 9936 | Values: 51.0 50.0 50.0 51.0 51.0 51.0 51.0 50.0 51.0 51.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.50 03:58:28 INFO - PROCESS | 9936 | Values: 62.0 61.0 60.0 60.0 60.0 60.0 60.0 59.0 60.0 60.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:2.40 (3.2%) stddev-sans-first:2.44 03:58:28 INFO - PROCESS | 9936 | Values: 72.0 79.0 72.0 77.0 74.0 72.0 72.0 73.0 74.0 75.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:118.50 stddev:17.38 (14.7%) stddev-sans-first:18.28 03:58:28 INFO - PROCESS | 9936 | Values: 118.0 116.0 118.0 118.0 123.0 115.0 119.0 126.0 173.0 118.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.50 stddev:2.27 (1.5%) stddev-sans-first:2.24 03:58:28 INFO - PROCESS | 9936 | Values: 150.0 153.0 157.0 155.0 153.0 152.0 152.0 152.0 150.0 150.0 03:58:28 INFO - PROCESS | 9936 | 03:58:28 INFO - PROCESS | 9936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.58 (2.6%) stddev-sans-first:1.67 03:58:28 INFO - PROCESS | 9936 | Values: 62.0 65.0 63.0 60.0 62.0 61.0 61.0 60.0 60.0 61.0 03:58:28 INFO - PROCESS | 9936 | -------- Summary: end -------- 03:58:28 INFO - PROCESS | 9936 | 03:58:29 INFO - TEST-INFO | 9936: exit 0 03:58:29 INFO - TEST-OK | kraken | took 59954ms 03:58:29 INFO - SUITE-END | took 1172s 03:58:29 INFO - Completed test suite (00:19:32) 03:58:29 INFO - javascript benchmark 03:58:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.5727455430797, 3308.2060305526675, 3312.3540909522653, 3341.766076374655, 3345.5818022747158, 5610.102383618617, 5730.512906402955, 5740.138979153118, 5746.0806270996645, 5761.279840019997, 5677.261955945722, 5719.914201286984, 5736.4550367715, 5742.339630942432, 5776.133579963008, 4991.625628077891, 5102.0306141833025, 5124.8975020499565, 5183.067047931371, 5205.531502164805, 5017.774200161001, 5122.92315615266, 5157.174852023677, 5177.0, 5181.481851814826, 5063.696178229299, 5112.335396398463, 5122.897542049157, 5139.383274007106, 5146.74266286686, 5197.948020519803, 5211.895762084737, 5218.139007063849, 5225.451327610622, 5251.6061295403, 4945.554900059012, 4954.975225123887, 4997.250412438127, 5091.930694554148, 5102.821401250939, 5476.67139971603, 5491.588130890199, 5504.614676972614, 5520.447955204488, 5544.279243698334, 6032.095185722133, 6065.8180254592435, 6078.787242446493, 6080.635161890256, 6081.726322315506, 5844.1818145459665, 5941.168236446901, 6045.486133678643, 6058.575899687024, 6086.969565152191, 5741.827745167651, 5751.338596061465, 5758.193852860602, 5761.596688231867, 5761.971190144022, 6254.2807577129215, 6261.530385221035, 6263.874722505616, 6266.0, 6271.184745982993, 5793.420657934257, 5896.616719913192, 5940.732667029994, 5948.7323070461935, 6043.395660434009, 6114.4190257321325, 6115.357887421846, 6115.785947491817, 6119.663418512025, 6140.232470941132, 6089.117078023662, 6091.2081429414775, 6093.2078829751845, 6093.786717464867, 6113.724882380304, 5854.121881717776, 5967.671778052162, 6005.849853753691, 6020.397960203944, 6133.0800379942475, 4624.838130665478, 4657.1617108920045, 4658.0218154188, 4661.0, 4693.272542755878, 4156.750594964312, 4168.7290326128705, 4178.331466965271, 4189.162167566499, 4191.601797829201, 5605.887882242332, 5719.971400143056, 5777.277840269966, 5782.277215348082, 5873.295204575478, 6167.259928808482, 6173.783917562864, 6177.938220617826, 6180.81457556274, 6185.072239164071, 5825.650460972355, 5827.504662103769, 5830.212921255661, 5831.504322132581, 5841.912371314434, 5139.794408223704, 5174.301469301671, 5220.738963051908, 5260.658057226268, 5351.143816989263, 6340.809775706736, 6381.553291269659, 6383.776567820104, 6384.457321127663, 6393.392627700361, 6095.817125486243, 6106.175666285172, 6159.137720719193, 6168.907466388097, 6178.227721534809, 6190.783322583688, 6211.192544969125, 6228.719707613078, 6236.75052997875, 6306.400891915261, 5994.700264986646, 6001.879962400641, 6005.069214271794, 6009.90985135232, 6041.335453100243, 6082.635041897501, 6099.603525770811, 6101.38986101404, 6102.4507794298725, 6103.572749907464, 5758.0, 5848.064309710426, 5897.321807992136, 5909.468147866713, 6027.457528822427, 5938.4061593842, 5970.343262241063, 5974.2830860297045, 5979.312379076462, 5982.4316689914385, 5898.970505147447, 5955.583109182489, 5966.403359663999, 5969.611975221596, 5975.073863551156, 5902.0, 5933.851653708692, 6006.429389208019, 6008.03871380577, 6113.144159817718, 5874.676892770939, 5896.204012458435, 5921.792737254175, 5924.940750592611, 5931.733072011856], "value": 5607.741889293492, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9308929473109, 615.6706162203222, 616.9228846394203, 638.9552731308809, 652.1359199061245, 36994.815025924865, 48000.519994800045, 48955.51044489554, 48994.26508602374, 49123.75438122814, 51605.74197129009, 52027.479725202735, 52041.73979130109, 52109.0, 52129.0, 8684.001339845903, 9390.436573805559, 9556.713298601053, 9556.80886382272, 11245.943770281137, 11014.724631884186, 11441.485133169028, 11475.426228688531, 11490.942545287262, 11493.310401375902, 11519.078473722082, 11556.90209430107, 11578.478968446398, 11581.710457238552, 11582.362970036645, 11447.141464390163, 11488.483018264198, 11504.597339093176, 11517.13621478384, 11517.942410287978, 11293.71765705864, 11374.0, 11390.316581005167, 11397.316161030365, 11400.258983166068, 47424.0, 47720.0, 47795.761021194674, 47854.28218576689, 47858.28212576814, 4103.97948010261, 4188.308929026707, 4332.588404101605, 4480.260756975095, 4718.716876987358, 35804.28391432157, 36189.45715814265, 36230.818845905604, 36526.45210321847, 38236.617633823866, 4703.2474804031535, 4761.714297142183, 4785.545373189541, 4789.3294938708605, 4829.951700482985, 403418.0, 409905.0, 410571.0, 411567.0, 411940.0, 68473.0, 68973.0, 69018.65490672615, 69038.65480672666, 69052.65473672599, 40387.59612403897, 40864.591354086675, 41200.0, 71070.64464677643, 71316.64341678258, 16446.83553164477, 16648.75026874598, 16659.41692040797, 16661.916690416714, 16670.58323541897, 12651.873481265253, 12755.872441275655, 12862.935685321514, 12971.0, 13177.868221317856, 21574.24490142869, 21605.703657780585, 21771.238006670006, 21788.782112178993, 21801.345959621238, 7609.467337286337, 7629.427792915553, 7702.767557190822, 7788.104367997639, 7945.443818932619, 1030.835066389374, 1071.651090342679, 1076.1283360478037, 1208.2086233517061, 1222.6759908624222, 35591.28817423637, 36443.45334819927, 36549.0, 36607.0, 36666.45000324997, 1142.257532603814, 1145.9713507162387, 1204.8433703618473, 1209.5101483899034, 1271.205496564647, 18740.344087957128, 18861.81138188628, 18862.43412697621, 18952.62094758097, 19021.524461888286, 580113.0, 632512.0, 643922.0, 645800.0, 979789.0, 68198.65900670465, 68877.0, 69036.6548167256, 69157.65421172862, 69389.65305173442, 1359.632899117233, 1426.5862899759368, 1463.6706740983193, 1484.9925750371178, 1522.4519173097676, 32783.83608081944, 36946.261074777816, 37106.25787484181, 37177.81411092927, 37602.811985939894, 57721.0, 58313.4168658308, 58416.78707671119, 58442.0, 58491.4150858503, 423960.0, 426828.0, 426960.0, 427848.7215127809, 428302.0, 28974.27564310825, 30588.388232235677, 30642.233944151576, 30727.078187654406, 32826.0, 54346.72826635841, 55479.44520554904, 55634.0, 56402.71798640981, 56676.43323566877, 46479.0, 47598.52401476079, 47978.0, 48318.0, 48443.5155648439, 46251.53748462472, 47275.0, 47523.28715069208, 47843.28235076407, 48425.757871210415, 44912.32631510595, 45442.31836522389, 46006.07987840292, 46249.76875115603, 46340.768296158305, 39941.80029099836, 41139.0, 41548.3767743478, 41995.37006944837, 42033.57966420297, 27930.86034569814, 27965.0, 28148.577771333858, 28172.71827281701, 28189.718102818708], "value": 22633.63967710574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4860949508367, 411.36649559678096, 427.8759159843645, 429.80873511287473, 441.7967734841973, 19599.902000489994, 20557.794422055777, 21181.788182118195, 21706.89146554269, 21904.780952190475, 18136.727949080774, 19820.60358792823, 20443.284485043027, 20573.074211660474, 20749.17003319869, 5779.508741756956, 6050.939490605104, 6053.303870054956, 6055.303640081381, 6056.757729690807, 5728.255326807509, 5877.6473411595225, 5903.11453282009, 5926.229590153274, 5959.16571679963, 5873.972054890399, 5877.52979761618, 5877.764889404419, 5886.175935369051, 5937.940620593804, 5762.078067509199, 5893.351731309574, 5957.553183511254, 5965.850853728648, 5971.283445986466, 5268.841934741964, 5325.440828713007, 5356.517913387775, 5360.088784906575, 5361.865953351197, 24191.153309634254, 24330.635040474408, 24534.263972080866, 24678.876605617035, 24760.876195619087, 2634.538955682767, 2645.7751091157274, 2664.5736682130764, 2734.7265273472494, 2939.1917222763695, 14873.553793386216, 15602.687946241012, 15638.13990230537, 15647.139407332592, 16367.59081022984, 1874.6438176746374, 1982.3656429942423, 2029.1173339597322, 2049.405672355015, 2106.368089573122, 73704.0, 79957.20042799556, 80294.19705802925, 81319.5934020332, 82281.0, 11120.110391168688, 11268.605598804166, 11419.371934543513, 11451.141164412702, 11553.0, 16339.101349425895, 16340.673186536204, 16352.100634464981, 16366.427175049053, 16366.754498682529, 8549.957250213834, 8622.31021518277, 8944.01615822259, 8973.237274831581, 9123.452592844318, 8625.69810056645, 8665.2634526066, 8696.695615653422, 8883.37816352849, 8889.511076890703, 7098.3256590623805, 7181.245969173162, 7211.206767255598, 7236.286392602774, 7270.913875763502, 2078.864873783199, 2131.531063166101, 2138.155428605723, 2139.229877244191, 2139.6362618354915, 1061.787642471509, 1063.1441689440076, 1070.9250352475408, 1099.2854644481151, 1104.1994553948323, 20446.0, 21422.464438389165, 21476.0, 21746.782532174475, 21779.346619601438, 1058.7564860082225, 1060.9337615696177, 1065.4566171252718, 1072.5924148823397, 1142.0863309352485, 11224.719382015352, 12282.877171228174, 12317.8298061684, 12472.314022728837, 12497.500099995897, 468130.0, 468795.0, 484984.0, 549095.0, 549944.0, 78223.0, 79973.0, 82449.17550824535, 83754.0, 87235.0, 1071.7695695425366, 1081.8377243413393, 1088.2327958789035, 1102.2449622008949, 1128.5767837061103, 18381.0, 18758.624827503645, 19092.33176838804, 19333.419997400102, 19347.0, 41880.79059604683, 42298.01760795446, 42530.5746942539, 42851.357229640955, 43183.0, 56400.15399769089, 56929.0, 57080.0, 57134.0, 59202.11196832137, 8256.628451719567, 8334.416590838584, 8374.790630234293, 8442.197991191073, 8662.133786621287, 12842.871571284168, 13353.399097040463, 14281.64295892611, 14435.566932992027, 14488.855111449173, 12273.938630307148, 12554.43505042257, 12628.43172057278, 12892.935535322264, 13049.804252936403, 11844.0, 12057.457414416196, 12061.457234424297, 12161.574344897886, 12789.296588687712, 11882.524699011943, 12313.815292770436, 12493.125481216592, 12551.0, 13099.476020959437, 9144.268458523435, 9154.0, 9261.583228754587, 9599.976245032467, 9715.951420243136, 10418.479076046016, 12039.518419263131, 12310.384480776105, 12429.689257768629, 12554.157671406167], "value": 9896.852286919446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.1653008195078, 1527.7250094982903, 1587.9995602770252, 1764.3383731100837, 1916.4538106639611, 8721.651133954641, 9031.142041506055, 9067.682631107913, 9287.814243715138, 9303.11620396063, 9071.365004449692, 9215.354925155241, 9277.25781937445, 9295.535223238845, 9295.814083718322, 2441.877906104692, 2464.2484042367073, 2464.544059349026, 2464.6426268191103, 2466.7903228225623, 2389.283215035491, 2435.0990133650575, 2441.389652586853, 2443.328084776692, 2444.0590372706547, 2107.283523601975, 2109.9789002109937, 2117.227212067592, 2120.3532922458644, 2131.2540610786177, 2310.653401989698, 2372.5729368713623, 2379.7263314718857, 2381.214199314231, 2405.9639105413435, 2360.409897525619, 2363.515479326734, 2364.1843563970574, 2368.798652114572, 2368.881555922197, 9166.954165229132, 9178.082191780835, 9255.305852061123, 9276.304277179172, 9296.349255552046, 5236.7119808410525, 5441.782328706847, 5449.264349312872, 5450.836474905759, 5451.509364157245, 3517.7009954153928, 3529.100079479742, 3535.6641119093647, 3582.3193593217206, 3603.8017909014993, 1227.3924407418297, 1230.1819290172025, 1231.6612931443835, 1249.7562975219835, 1259.6913756129716, 13465.528706495325, 13594.32028398586, 13605.659858503517, 13624.250666213355, 13627.863721362759, 4593.26507758757, 4633.374494443275, 4733.077049975291, 4735.739534325577, 4905.2151655734915, 10506.737331566772, 10538.57845686164, 10594.311369761095, 10614.893851061544, 10622.256442048982, 5593.580481463825, 5600.85997850057, 5607.635503692247, 5629.943700563023, 5635.154726790932, 4651.279051746985, 4698.506656801055, 5190.896182076337, 5210.036143313499, 5234.42421333653, 3993.4409182714444, 3996.9600303997167, 4046.826420338069, 4075.184963007351, 4105.261053010487, 1150.775598758251, 1151.5048529132387, 1152.6714886257375, 1174.4790496307303, 1197.4970512384818, 908.881845360099, 1018.5467466977124, 1021.5760459409411, 1026.9229807764448, 1037.9481025948671, 6371.617702937839, 6511.739530418825, 6625.668716564152, 6702.497312701469, 6723.462123030145, 979.7942432089341, 980.294188184506, 1002.1982414068716, 1012.8480727890875, 1034.0848349211003, 3974.18529201513, 4322.416473776063, 4424.601785839225, 4456.68803183774, 4468.754218517947, 11710.70723231926, 12126.575569855013, 12158.270503769802, 12162.209456385306, 12193.817092743617, 11911.404429778477, 12037.759244815055, 12066.879331206575, 12303.384830758427, 12328.0, 8605.354598405145, 8627.95686021566, 8647.740567782977, 8672.913270867211, 8761.912380876238, 6234.35202479838, 6374.107624932606, 6417.454516366161, 6528.771492997722, 6574.276829548841, 10822.458877056273, 10870.130389568974, 10901.149082967138, 10952.452377381258, 11133.0, 11151.72120696989, 11230.0, 11303.660890173307, 11331.603393881504, 11380.658580242605, 8140.592970351578, 8159.143289954469, 8220.6846904495, 8327.833443331221, 8539.444936079135, 9373.625054997723, 9387.953060234655, 9443.055694430503, 9444.338896277195, 9469.810603788024, 8237.876431853647, 8249.587520624065, 8353.791155221168, 8496.192861678377, 8544.829103417773, 8129.187081291823, 8149.633266502903, 8158.3065439438315, 8245.299149572114, 8297.709580164665, 7421.888671670037, 7529.247075292427, 7590.0, 7720.3437707795465, 7741.7677469676, 5396.244525766318, 5486.890262194814, 5519.972400137974, 5658.17956396312, 5689.288838895138, 5600.35595906476, 5607.467290607386, 5718.0, 5723.0, 5817.360090390139], "value": 4901.996869089272, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.6050021474874, 358.5500197252448, 358.64253799369385, 359.84166966534707, 366.594912621553, 5530.3363596368445, 5562.970850392675, 5604.551635869131, 5605.859853503654, 5613.578981576377, 5221.869453263661, 5270.209468579715, 5392.406835248129, 5471.50756431921, 5552.500274975251, 4302.376155457457, 4324.502682191541, 4324.783760811963, 4337.633645401696, 4339.522652508222, 4333.0, 4352.607165706975, 4364.214441400547, 4367.825286988516, 4373.469285749994, 4137.193247316774, 4285.357196420547, 4308.159908817782, 4310.030243195288, 4331.43691320128, 4262.850800221977, 4296.839853239608, 4300.913981720348, 4311.935320970172, 4314.331278651814, 3813.904652383685, 3819.0, 3828.712846536521, 3833.8083095845377, 3834.731568790186, 5235.3717553893775, 5327.413984461706, 5365.141577347606, 5429.131338985743, 5431.886463275019, 4924.039812236615, 4927.915858511157, 4932.260160975847, 4934.950650493521, 4935.988122434892, 5716.742746576372, 5720.313562372542, 5731.570132240098, 5733.770649174028, 5744.22452968848, 4087.2847251731127, 4113.732607380541, 4139.958600413987, 4172.207280616673, 4177.373393990895, 5897.410258974069, 5913.704314784287, 5921.134842524591, 5924.0, 5949.732262048175, 4265.762928750628, 4269.914601707948, 4270.29540125882, 4274.829006839692, 4280.6789490788315, 4186.330187170038, 4349.391085248068, 4354.695171337976, 4355.867474456664, 4381.605655490957, 4896.2655601660035, 4898.951010489921, 4901.436334821541, 4905.190643543775, 4919.237518184687, 5787.594868359174, 5805.216295800013, 5809.24479817621, 5820.854478637983, 5835.941640583625, 1457.7813328000673, 1461.152531531709, 1499.2054211268046, 1511.586666466857, 1515.772634104871, 940.5062342270226, 963.2631037256505, 967.7580604848788, 968.4431451915177, 972.8103019911049, 5013.949860501421, 5025.4974502550185, 5028.823991160292, 5034.697918124924, 5045.495450454925, 5220.686758794484, 5259.684418934876, 5259.895421961431, 5261.973690131601, 5277.445868183862, 4680.648951328664, 5020.146575082244, 5024.537976391542, 5042.016806722727, 5043.0, 2793.4133831895124, 2793.846338451405, 2801.3836955869674, 2805.5130780685863, 2817.225263052677, 5428.728563571805, 5436.401995780461, 5454.972725136349, 5459.372172200168, 5474.644148130359, 5180.948190518046, 5204.739763011834, 5224.529792318634, 5295.973520132375, 5383.838484845461, 5351.545118664879, 5371.495981125291, 5373.865653358619, 5388.407275199725, 5481.588880833874, 5210.609204309616, 5215.1056163829435, 5266.394364647961, 5284.26020357158, 5306.708131052675, 4923.458419573915, 5131.743412829269, 5152.805260738366, 5163.3545806774155, 5170.793168273227, 5345.625806193529, 5375.0, 5385.703786291791, 5388.865278368072, 5482.5613950883035, 3932.6067393260446, 3954.3079961007284, 3959.4852669152824, 3979.164375481181, 4008.9198216034933, 5327.600429967691, 5893.116032595145, 5903.852403689943, 5910.763569457174, 5927.347991720993, 5777.162311464898, 5792.3917988612275, 5801.883962320646, 5804.593678442468, 5823.621464604787, 5656.3132512056445, 5659.858503537444, 5774.307083150049, 5807.128930660435, 5829.0, 5788.392218817132, 5795.884082318415, 5818.563607729353, 5828.329742079715, 5841.831633673198, 5864.736086876186, 5864.765409383577, 5870.823875283749, 5881.353051164454, 5881.823545293648, 5519.641223320471, 5644.604877658525, 5696.1455781633085, 5719.370869204467, 5724.685142317213], "value": 4267.435042999615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.7816978500698, 835.9289460395865, 842.7850898021005, 852.279823549101, 896.4486840593037, 16475.423360182394, 17570.736438953427, 17751.911240443813, 17817.10914454277, 17826.376076837296, 16260.268287927041, 16302.592435189126, 16395.4261600844, 16485.01089934605, 16570.0, 886.0165216609558, 905.3888625178012, 908.6229214875818, 908.727381785465, 908.7728067983004, 733.2264460993649, 886.76500727307, 891.5765011619461, 901.711452335253, 908.9636414543444, 939.9624015039391, 947.4646824544111, 948.2129832239225, 948.506776476232, 949.9382540134903, 940.3276657190141, 941.6610020392619, 942.7878727286375, 942.985855212169, 944.6552008516842, 568.1761445903456, 661.2527843536773, 674.6356967237685, 676.347324831535, 696.8954656801469, 16178.676426471522, 17005.319787208497, 17010.744838827304, 17057.2324245408, 17059.40292089783, 15238.695226095528, 16140.435084771976, 16314.265858036417, 16491.422800202054, 16831.242594083295, 13731.24478153701, 14256.572302830931, 14655.0, 14680.0, 14812.555623331318, 4553.294239392866, 4621.537846215351, 4639.350490931272, 4671.649626278008, 4674.111918735463, 86898.0, 86956.0, 87012.5649371749, 87442.56278718566, 87609.0, 11753.764924701458, 11763.823542646867, 11837.351636642927, 12039.0, 12132.968697660797, 21532.354029379145, 21603.56792864134, 21668.566628667337, 21763.12947482083, 21782.346529604136, 9046.140616641409, 9087.68193113251, 9213.90786092144, 9274.0, 9364.90635093654, 4932.778024988884, 5062.797488100435, 5129.153689641242, 5197.922031169535, 5201.557867581222, 3771.8868433947027, 3873.4770805941403, 3875.5349358076646, 3877.1664092219744, 3879.6702280305926, 514.8738559053056, 594.560025581067, 594.9434803693642, 595.9851003724855, 600.3246347858659, 625.2778041362234, 641.0640464921267, 745.273358475482, 773.9303462688385, 789.5933594198992, 10049.447280399649, 10100.898991010143, 10164.136048435967, 10256.538455769509, 10472.476376181161, 683.2586643491768, 698.420875354165, 770.1989930472246, 818.9713360032371, 862.3187681731362, 4837.6613637045775, 4853.514648535118, 4912.38595175603, 5082.872928176826, 5324.760385782649, 66444.0, 119854.0, 120840.0, 123199.76800232062, 125066.3746681279, 100867.0, 100895.0, 101342.0, 101442.49278753706, 105668.94331056591, 82606.58696706599, 92209.0, 92448.07551924529, 93022.53488732649, 93355.0, 10054.54754536033, 10701.732456688645, 10795.514201861091, 11080.889191108308, 11357.432128393713, 54540.0, 54742.45257547373, 55403.0, 55972.440275596724, 56541.71729141328, 69205.65397172981, 78675.21324786908, 79355.20644793478, 81295.59352203438, 81784.0, 12998.0, 13411.061225714106, 13826.65433364174, 14185.432582696989, 14197.787033194303, 15231.238438078273, 15355.923220383827, 15418.768718469457, 15839.445619403266, 16129.67740645204, 14647.70704585881, 14836.247536853743, 15145.924270379019, 15236.060073494133, 15966.840331597, 13013.869861301266, 13144.934275328562, 13203.339833008504, 14249.928750356183, 14735.2632368379, 13184.0, 13193.80209296842, 13214.867851321364, 13218.272994985367, 13238.801417978932, 9519.904800951901, 9583.904160958302, 9640.42157470554, 9819.85270220933, 10014.449205293779, 10323.277370583986, 10524.473776311, 10612.151027917902, 10683.786324273626, 10763.461826908466], "value": 8042.760974289904, "unit": "score"}], "name": "dromaeo_css", "value": 7718.0095144616325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 111.0, 112.0, 113.0, 111.0, 111.0, 110.0, 112.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 117.0, 187.0, 115.0, 123.0, 146.0, 116.0, 154.0, 120.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 161.0, 160.0, 162.0, 161.0, 161.0, 160.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 122.0, 77.0, 76.0, 74.0, 76.0, 96.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 82.0, 82.0, 82.0, 121.0, 82.0, 84.0, 130.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 125.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 97.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 50.0, 51.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 72.0, 77.0, 74.0, 72.0, 72.0, 73.0, 74.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 118.0, 118.0, 123.0, 115.0, 119.0, 126.0, 173.0, 118.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 157.0, 155.0, 153.0, 152.0, 152.0, 152.0, 150.0, 150.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 60.0, 62.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1463.7000000000003, "alertThreshold": 2.0}]} 03:58:29 INFO - Return code: 0 03:58:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:58:29 INFO - # TBPL SUCCESS # 03:58:29 INFO - Running post-action listener: _resource_record_post_action 03:58:29 INFO - [mozharness: 2016-08-05 10:58:29.638065Z] Finished run-tests step (success) 03:58:29 INFO - Running post-run listener: _resource_record_post_run 03:58:29 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 512012288; Read time: 32; Write time: 613292 03:58:29 INFO - TinderboxPrint: CPU usage
13.0% 03:58:29 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 03:58:29 INFO - TinderboxPrint: I/O write bytes / time
512,012,288 / 613,292 03:58:29 INFO - TinderboxPrint: CPU idle
8,252.3 (86.9%) 03:58:29 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 03:58:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:58:29 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259780608; Read time: 0; Write time: 410604 03:58:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252231680; Read time: 12; Write time: 202688 03:58:30 INFO - Running post-run listener: _upload_blobber_files 03:58:30 INFO - Blob upload gear active. 03:58:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:30 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 03:58:30 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'] 03:58:30 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 03:58:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:31 INFO - (blobuploader) - INFO - Done attempting. 03:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:32 INFO - (blobuploader) - INFO - Done attempting. 03:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:58:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:35 INFO - (blobuploader) - INFO - Done attempting. 03:58:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:35 INFO - Return code: 0 03:58:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57f586945d887ee0fe8e7938ee4d88c992ad1ccf84d4fcbe7e37acd038d7c32e87edf2f25aa3d9c112bc5c258a8e466e177fb2d756f26c046f3e9f2d75427d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c70a42124586b48f1cb214d6b516d70c4f2631d9c85d1ecb8b7a97f3023389b652e535ecefed6d0e39550e9df1195dd312bc740b7e34cfe36cbb7d673df66fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1424ae99d65b7220c95dc17d9c5f5b81768dcec1162fa196524fc4f0d7f58c1b15f9b53612c699d8364ade278c7292dc97dfebb35a5dbe33e776866824cd6f67"} 03:58:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:35 INFO - Contents: 03:58:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57f586945d887ee0fe8e7938ee4d88c992ad1ccf84d4fcbe7e37acd038d7c32e87edf2f25aa3d9c112bc5c258a8e466e177fb2d756f26c046f3e9f2d75427d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c70a42124586b48f1cb214d6b516d70c4f2631d9c85d1ecb8b7a97f3023389b652e535ecefed6d0e39550e9df1195dd312bc740b7e34cfe36cbb7d673df66fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1424ae99d65b7220c95dc17d9c5f5b81768dcec1162fa196524fc4f0d7f58c1b15f9b53612c699d8364ade278c7292dc97dfebb35a5dbe33e776866824cd6f67"} 03:58:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:35 INFO - Copying logs to upload dir... 03:58:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.167869 ========= master_lag: 1.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-05 03:58:36.069682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 03:58:36.077467) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 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/57f586945d887ee0fe8e7938ee4d88c992ad1ccf84d4fcbe7e37acd038d7c32e87edf2f25aa3d9c112bc5c258a8e466e177fb2d756f26c046f3e9f2d75427d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c70a42124586b48f1cb214d6b516d70c4f2631d9c85d1ecb8b7a97f3023389b652e535ecefed6d0e39550e9df1195dd312bc740b7e34cfe36cbb7d673df66fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1424ae99d65b7220c95dc17d9c5f5b81768dcec1162fa196524fc4f0d7f58c1b15f9b53612c699d8364ade278c7292dc97dfebb35a5dbe33e776866824cd6f67"} build_url:https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/dyqgAhJnSNWyZpli1E4vgw/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/57f586945d887ee0fe8e7938ee4d88c992ad1ccf84d4fcbe7e37acd038d7c32e87edf2f25aa3d9c112bc5c258a8e466e177fb2d756f26c046f3e9f2d75427d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c70a42124586b48f1cb214d6b516d70c4f2631d9c85d1ecb8b7a97f3023389b652e535ecefed6d0e39550e9df1195dd312bc740b7e34cfe36cbb7d673df66fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1424ae99d65b7220c95dc17d9c5f5b81768dcec1162fa196524fc4f0d7f58c1b15f9b53612c699d8364ade278c7292dc97dfebb35a5dbe33e776866824cd6f67"}' ========= master_lag: 0.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 03:58:36.356420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:58:36.356802) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1470393487.640214-391511041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 03:58:36.373845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 03:58:36.374180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 03:58:36.374472) ========= ========= Total master_lag: 1.57 =========