builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1463531775.26 results: success (0) buildid: 20160517143014 builduid: 78307bea84c140ec80590f2839ed3cb4 revision: f79314b1a23fa5fd403fbcf97b81a59a800d9614 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.264458) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.265472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.266124) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.281724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.282331) ========= 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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 17:36:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.9M=0s 2016-05-17 17:36:15 (44.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.371024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.372815) ========= 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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.422321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.422665) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f79314b1a23fa5fd403fbcf97b81a59a800d9614 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f79314b1a23fa5fd403fbcf97b81a59a800d9614 --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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 17:36:15,718 truncating revision to first 12 chars 2016-05-17 17:36:15,718 Setting DEBUG logging. 2016-05-17 17:36:15,718 attempt 1/10 2016-05-17 17:36:15,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f79314b1a23f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 17:36:15,963 unpacking tar archive at: fx-team-f79314b1a23f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529635 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.970052) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.970791) ========= script_repo_revision: f79314b1a23fa5fd403fbcf97b81a59a800d9614 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.971655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.972316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 17:36:15.982762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 17:36:15.983071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:36:16 INFO - MultiFileLogger online at 20160517 17:36:16 in /builds/slave/test 17:36:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:36:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:16 INFO - {'append_to_log': False, 17:36:16 INFO - 'base_work_dir': '/builds/slave/test', 17:36:16 INFO - 'blob_upload_branch': 'Fx-Team', 17:36:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:16 INFO - 'branch': 'Fx-Team', 17:36:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:16 INFO - 'config_files': ('talos/linux_config.py',), 17:36:16 INFO - 'default_actions': ('clobber', 17:36:16 INFO - 'read-buildbot-config', 17:36:16 INFO - 'download-and-extract', 17:36:16 INFO - 'populate-webroot', 17:36:16 INFO - 'create-virtualenv', 17:36:16 INFO - 'install', 17:36:16 INFO - 'run-tests'), 17:36:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:16 INFO - 'download_minidump_stackwalk': True, 17:36:16 INFO - 'download_symbols': 'ondemand', 17:36:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:16 INFO - 'installer_path': 'installer.exe', 17:36:16 INFO - 'log_level': 'info', 17:36:16 INFO - 'log_name': 'talos', 17:36:16 INFO - 'log_to_console': True, 17:36:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:36:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:36:16 INFO - 'opt_config_files': (), 17:36:16 INFO - 'pip_index': False, 17:36:16 INFO - 'sps_profile': False, 17:36:16 INFO - 'sps_profile_interval': 0, 17:36:16 INFO - 'suite': 'dromaeojs', 17:36:16 INFO - 'system_bits': '32', 17:36:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:16 INFO - 'title': 'talos-linux64-ix-048', 17:36:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:16 INFO - 'use_talos_json': True, 17:36:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:16 INFO - 'work_dir': 'build'} 17:36:16 INFO - ##### 17:36:16 INFO - ##### Running clobber step. 17:36:16 INFO - ##### 17:36:16 INFO - Running pre-action listener: _resource_record_pre_action 17:36:16 INFO - Running main action method: clobber 17:36:16 INFO - rmtree: /builds/slave/test/build 17:36:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:16 INFO - Running post-action listener: _resource_record_post_action 17:36:16 INFO - ##### 17:36:16 INFO - ##### Finished clobber step (success) 17:36:16 INFO - ##### 17:36:16 INFO - ##### 17:36:16 INFO - ##### Running read-buildbot-config step. 17:36:16 INFO - ##### 17:36:16 INFO - Running pre-action listener: _resource_record_pre_action 17:36:16 INFO - Running main action method: read_buildbot_config 17:36:16 INFO - Using buildbot properties: 17:36:16 INFO - { 17:36:16 INFO - "project": "", 17:36:16 INFO - "product": "firefox", 17:36:16 INFO - "script_repo_revision": "production", 17:36:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:36:16 INFO - "repository": "", 17:36:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:36:16 INFO - "buildid": "20160517143014", 17:36:16 INFO - "pgo_build": "True", 17:36:16 INFO - "basedir": "/builds/slave/test", 17:36:16 INFO - "buildnumber": 1162, 17:36:16 INFO - "slavename": "talos-linux64-ix-048", 17:36:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:36:16 INFO - "platform": "ubuntu64_hw", 17:36:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:36:16 INFO - "branch": "fx-team", 17:36:16 INFO - "repo_path": "integration/fx-team", 17:36:16 INFO - "revision": "f79314b1a23fa5fd403fbcf97b81a59a800d9614", 17:36:16 INFO - "stage_platform": "linux64-pgo", 17:36:16 INFO - "builduid": "78307bea84c140ec80590f2839ed3cb4", 17:36:16 INFO - "slavebuilddir": "test" 17:36:16 INFO - } 17:36:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:36:16 INFO - Running post-action listener: _resource_record_post_action 17:36:16 INFO - ##### 17:36:16 INFO - ##### Finished read-buildbot-config step (success) 17:36:16 INFO - ##### 17:36:16 INFO - ##### 17:36:16 INFO - ##### Running download-and-extract step. 17:36:16 INFO - ##### 17:36:16 INFO - Running pre-action listener: _resource_record_pre_action 17:36:16 INFO - Running main action method: download_and_extract 17:36:16 INFO - mkdir: /builds/slave/test/build/tests 17:36: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')]} 17:36:16 INFO - https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:36:17 INFO - Downloaded 1361 bytes. 17:36:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:36:17 INFO - Using the following test package requirements: 17:36:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:36:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:36:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'jsshell-linux-x86_64.zip'], 17:36:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:36:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:36:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:36:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:36:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:36:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:36:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:36:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:17 INFO - https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:18 INFO - Downloaded 24024983 bytes. 17:36:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:19 INFO - Return code: 0 17:36:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:19 INFO - https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:20 INFO - Downloaded 24024983 bytes. 17:36:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:36:22 INFO - Return code: 0 17:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:22 INFO - https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:36:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:36:23 INFO - Downloaded 10840194 bytes. 17:36:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:36:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:36:23 INFO - Return code: 0 17:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:23 INFO - https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:36:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:36:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:36:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:36:26 INFO - Downloaded 58406849 bytes. 17:36:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:36:26 INFO - mkdir: /builds/slave/test/properties 17:36:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:26 INFO - Contents: 17:36:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:36:27 INFO - Running post-action listener: _resource_record_post_action 17:36:27 INFO - Running post-action listener: set_extra_try_arguments 17:36:27 INFO - ##### 17:36:27 INFO - ##### Finished download-and-extract step (success) 17:36:27 INFO - ##### 17:36:27 INFO - ##### 17:36:27 INFO - ##### Running populate-webroot step. 17:36:27 INFO - ##### 17:36:27 INFO - Running pre-action listener: _resource_record_pre_action 17:36:27 INFO - Running main action method: populate_webroot 17:36:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:27 INFO - '--tppagecycles', 17:36:27 INFO - '7'], 17:36:27 INFO - 'tests': ['tsvgm']}}, 17:36:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['damp', 'tps']}, 17:36:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'tests': ['damp', 'tps']}, 17:36:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['dromaeo_dom']}, 17:36:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['a11yr', 17:36:27 INFO - 'ts_paint', 17:36:27 INFO - 'tpaint', 17:36:27 INFO - 'sessionrestore', 17:36:27 INFO - 'sessionrestore_no_auto_restore', 17:36:27 INFO - 'tabpaint']}, 17:36:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['tsvgx', 17:36:27 INFO - 'tsvgr_opacity', 17:36:27 INFO - 'tart', 17:36:27 INFO - 'tscrollx', 17:36:27 INFO - 'cart']}, 17:36:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:27 INFO - 'tsvgr_opacity', 17:36:27 INFO - 'tart', 17:36:27 INFO - 'tscrollx', 17:36:27 INFO - 'cart']}, 17:36:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'talos_options': ['--disable-e10s'], 17:36:27 INFO - 'tests': ['tp5o']}, 17:36:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'tests': ['tp5o']}, 17:36:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'talos_options': ['--disable-e10s', 17:36:27 INFO - '--xperf_path', 17:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:27 INFO - 'tests': ['tp5n']}, 17:36:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:27 INFO - 'talos_options': ['--xperf_path', 17:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:27 INFO - 'tests': ['tp5n']}}, 17:36:27 INFO - 'talos.zip': {'path': '', 17:36:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:27 INFO - Running post-action listener: _resource_record_post_action 17:36:27 INFO - ##### 17:36:27 INFO - ##### Finished populate-webroot step (success) 17:36:27 INFO - ##### 17:36:27 INFO - ##### 17:36:27 INFO - ##### Running create-virtualenv step. 17:36:27 INFO - ##### 17:36:27 INFO - Running pre-action listener: _resource_record_pre_action 17:36:27 INFO - Running main action method: create_virtualenv 17:36:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:36:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:27 INFO - Using real prefix '/usr' 17:36:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:29 INFO - Installing pip.................done. 17:36:29 INFO - Return code: 0 17:36:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36: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', 'pip>=1.5'] in /builds/slave/test/build 17:36: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 pip>=1.5 17:36:29 INFO - Using env: {'DISPLAY': ':0', 17:36:29 INFO - 'HOME': '/home/cltbld', 17:36:29 INFO - 'LANG': 'en_US.UTF-8', 17:36:29 INFO - 'LANGUAGE': 'en_US:en', 17:36:29 INFO - 'LOGNAME': 'cltbld', 17:36:29 INFO - 'MAIL': '/var/mail/cltbld', 17:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:29 INFO - 'MOZ_NO_REMOTE': '1', 17:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:29 INFO - 'NO_EM_RESTART': '1', 17:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:29 INFO - 'PWD': '/builds/slave/test', 17:36:29 INFO - 'SHELL': '/bin/bash', 17:36:29 INFO - 'SHLVL': '1', 17:36:29 INFO - 'TERM': 'linux', 17:36:29 INFO - 'TMOUT': '86400', 17:36:29 INFO - 'USER': 'cltbld', 17:36:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:29 INFO - '_': '/tools/buildbot/bin/python'} 17:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:36:29 INFO - Cleaning up... 17:36:29 INFO - Return code: 0 17:36:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', '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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:36: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 psutil>=3.1.1 17:36:29 INFO - Using env: {'DISPLAY': ':0', 17:36:29 INFO - 'HOME': '/home/cltbld', 17:36:29 INFO - 'LANG': 'en_US.UTF-8', 17:36:29 INFO - 'LANGUAGE': 'en_US:en', 17:36:29 INFO - 'LOGNAME': 'cltbld', 17:36:29 INFO - 'MAIL': '/var/mail/cltbld', 17:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:29 INFO - 'MOZ_NO_REMOTE': '1', 17:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:29 INFO - 'NO_EM_RESTART': '1', 17:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:29 INFO - 'PWD': '/builds/slave/test', 17:36:29 INFO - 'SHELL': '/bin/bash', 17:36:29 INFO - 'SHLVL': '1', 17:36:29 INFO - 'TERM': 'linux', 17:36:29 INFO - 'TMOUT': '86400', 17:36:29 INFO - 'USER': 'cltbld', 17:36:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:29 INFO - '_': '/tools/buildbot/bin/python'} 17:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:30 INFO - Downloading/unpacking psutil>=3.1.1 17:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:32 INFO - Installing collected packages: psutil 17:36:32 INFO - Running setup.py install for psutil 17:36:32 INFO - building 'psutil._psutil_linux' extension 17:36:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:36:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:36:32 INFO - building 'psutil._psutil_posix' extension 17:36:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:36:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:32 INFO - Successfully installed psutil 17:36:32 INFO - Cleaning up... 17:36:32 INFO - Return code: 0 17:36:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:32 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:32 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 17:36:32 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 17:36:32 INFO - Using env: {'DISPLAY': ':0', 17:36:32 INFO - 'HOME': '/home/cltbld', 17:36:32 INFO - 'LANG': 'en_US.UTF-8', 17:36:32 INFO - 'LANGUAGE': 'en_US:en', 17:36:32 INFO - 'LOGNAME': 'cltbld', 17:36:32 INFO - 'MAIL': '/var/mail/cltbld', 17:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:32 INFO - 'MOZ_NO_REMOTE': '1', 17:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:32 INFO - 'NO_EM_RESTART': '1', 17:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:32 INFO - 'PWD': '/builds/slave/test', 17:36:32 INFO - 'SHELL': '/bin/bash', 17:36:32 INFO - 'SHLVL': '1', 17:36:32 INFO - 'TERM': 'linux', 17:36:32 INFO - 'TMOUT': '86400', 17:36:32 INFO - 'USER': 'cltbld', 17:36:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:32 INFO - '_': '/tools/buildbot/bin/python'} 17:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:34 INFO - Installing collected packages: mozsystemmonitor 17:36:34 INFO - Running setup.py install for mozsystemmonitor 17:36:34 INFO - Successfully installed mozsystemmonitor 17:36:34 INFO - Cleaning up... 17:36:34 INFO - Return code: 0 17:36:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:34 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:36:34 INFO - Using env: {'DISPLAY': ':0', 17:36:34 INFO - 'HOME': '/home/cltbld', 17:36:34 INFO - 'LANG': 'en_US.UTF-8', 17:36:34 INFO - 'LANGUAGE': 'en_US:en', 17:36:34 INFO - 'LOGNAME': 'cltbld', 17:36:34 INFO - 'MAIL': '/var/mail/cltbld', 17:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:34 INFO - 'MOZ_NO_REMOTE': '1', 17:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:34 INFO - 'NO_EM_RESTART': '1', 17:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:34 INFO - 'PWD': '/builds/slave/test', 17:36:34 INFO - 'SHELL': '/bin/bash', 17:36:34 INFO - 'SHLVL': '1', 17:36:34 INFO - 'TERM': 'linux', 17:36:34 INFO - 'TMOUT': '86400', 17:36:34 INFO - 'USER': 'cltbld', 17:36:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:34 INFO - '_': '/tools/buildbot/bin/python'} 17:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:37 INFO - Downloading docopt-0.6.1.tar.gz 17:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:37 INFO - Running setup.py install for blobuploader 17:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:37 INFO - Running setup.py install for requests 17:36:38 INFO - Running setup.py install for docopt 17:36:38 INFO - Successfully installed blobuploader requests docopt 17:36:38 INFO - Cleaning up... 17:36:38 INFO - Return code: 0 17:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:38 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:38 INFO - Using env: {'DISPLAY': ':0', 17:36:38 INFO - 'HOME': '/home/cltbld', 17:36:38 INFO - 'LANG': 'en_US.UTF-8', 17:36:38 INFO - 'LANGUAGE': 'en_US:en', 17:36:38 INFO - 'LOGNAME': 'cltbld', 17:36:38 INFO - 'MAIL': '/var/mail/cltbld', 17:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:38 INFO - 'MOZ_NO_REMOTE': '1', 17:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:38 INFO - 'NO_EM_RESTART': '1', 17:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:38 INFO - 'PWD': '/builds/slave/test', 17:36:38 INFO - 'SHELL': '/bin/bash', 17:36:38 INFO - 'SHLVL': '1', 17:36:38 INFO - 'TERM': 'linux', 17:36:38 INFO - 'TMOUT': '86400', 17:36:38 INFO - 'USER': 'cltbld', 17:36:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:38 INFO - '_': '/tools/buildbot/bin/python'} 17:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:38 INFO - Running setup.py (path:/tmp/pip-UVy1V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:38 INFO - Running setup.py (path:/tmp/pip-j_6vU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:38 INFO - Running setup.py (path:/tmp/pip-5tppkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:38 INFO - Running setup.py (path:/tmp/pip-yJ1J0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:38 INFO - Running setup.py (path:/tmp/pip-xvZhEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:39 INFO - Running setup.py (path:/tmp/pip-oXxe0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:39 INFO - Running setup.py (path:/tmp/pip-VlMbFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:39 INFO - Running setup.py (path:/tmp/pip-1GoIbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:39 INFO - Running setup.py (path:/tmp/pip-LB8fXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:39 INFO - Running setup.py (path:/tmp/pip-6tsYD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:39 INFO - Running setup.py (path:/tmp/pip-pw3LBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:39 INFO - Running setup.py (path:/tmp/pip-qWcyWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:39 INFO - Running setup.py (path:/tmp/pip-fH54h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:39 INFO - Running setup.py (path:/tmp/pip-OwkGzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:39 INFO - Running setup.py (path:/tmp/pip-mJyvbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:39 INFO - Running setup.py (path:/tmp/pip-B8XQBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:39 INFO - Running setup.py (path:/tmp/pip-sM34h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:39 INFO - Running setup.py install for manifestparser 17:36:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for mozcrash 17:36:40 INFO - Running setup.py install for mozdebug 17:36:40 INFO - Running setup.py install for mozdevice 17:36:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for mozfile 17:36:40 INFO - Running setup.py install for mozhttpd 17:36:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for mozinfo 17:36:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for mozInstall 17:36:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for mozleak 17:36:40 INFO - Running setup.py install for mozlog 17:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:40 INFO - Running setup.py install for moznetwork 17:36:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozprocess 17:36:41 INFO - Running setup.py install for mozprofile 17:36:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozrunner 17:36:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Running setup.py install for mozscreenshot 17:36:41 INFO - Running setup.py install for moztest 17:36:41 INFO - Running setup.py install for mozversion 17:36:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:41 INFO - Cleaning up... 17:36:41 INFO - Return code: 0 17:36:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:41 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:41 INFO - Using env: {'DISPLAY': ':0', 17:36:41 INFO - 'HOME': '/home/cltbld', 17:36:41 INFO - 'LANG': 'en_US.UTF-8', 17:36:41 INFO - 'LANGUAGE': 'en_US:en', 17:36:41 INFO - 'LOGNAME': 'cltbld', 17:36:41 INFO - 'MAIL': '/var/mail/cltbld', 17:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:41 INFO - 'MOZ_NO_REMOTE': '1', 17:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:41 INFO - 'NO_EM_RESTART': '1', 17:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:41 INFO - 'PWD': '/builds/slave/test', 17:36:41 INFO - 'SHELL': '/bin/bash', 17:36:41 INFO - 'SHLVL': '1', 17:36:41 INFO - 'TERM': 'linux', 17:36:41 INFO - 'TMOUT': '86400', 17:36:41 INFO - 'USER': 'cltbld', 17:36:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:41 INFO - '_': '/tools/buildbot/bin/python'} 17:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:41 INFO - Running setup.py (path:/tmp/pip-fraYwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:41 INFO - Running setup.py (path:/tmp/pip-tNYmn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:42 INFO - Running setup.py (path:/tmp/pip-5a__Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:42 INFO - Running setup.py (path:/tmp/pip-RObasQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:42 INFO - Running setup.py (path:/tmp/pip-eyILB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:42 INFO - Running setup.py (path:/tmp/pip-rU12N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:42 INFO - Running setup.py (path:/tmp/pip-xUYWfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:42 INFO - Running setup.py (path:/tmp/pip-XNCDPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:42 INFO - Running setup.py (path:/tmp/pip-KIWBHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:42 INFO - Running setup.py (path:/tmp/pip-iOX1fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:42 INFO - Running setup.py (path:/tmp/pip-4_zpsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:42 INFO - Running setup.py (path:/tmp/pip-316_KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:42 INFO - Running setup.py (path:/tmp/pip-4miOQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:42 INFO - Running setup.py (path:/tmp/pip-h5jGe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:42 INFO - Running setup.py (path:/tmp/pip-_o1YtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:43 INFO - Running setup.py (path:/tmp/pip-uc4kDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:43 INFO - Running setup.py (path:/tmp/pip-OW0Qg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:45 INFO - Downloading blessings-1.6.tar.gz 17:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:45 INFO - Installing collected packages: blessings 17:36:45 INFO - Running setup.py install for blessings 17:36:45 INFO - Successfully installed blessings 17:36:45 INFO - Cleaning up... 17:36:45 INFO - Return code: 0 17:36:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:45 INFO - Reading from file tmpfile_stdout 17:36:45 INFO - Current package versions: 17:36:45 INFO - argparse == 1.2.1 17:36:45 INFO - blessings == 1.6 17:36:45 INFO - blobuploader == 1.2.4 17:36:45 INFO - docopt == 0.6.1 17:36:45 INFO - manifestparser == 1.1 17:36:45 INFO - mozInstall == 1.12 17:36:45 INFO - mozcrash == 0.17 17:36:45 INFO - mozdebug == 0.1 17:36:45 INFO - mozdevice == 0.48 17:36:45 INFO - mozfile == 1.2 17:36:45 INFO - mozhttpd == 0.7 17:36:45 INFO - mozinfo == 0.9 17:36:45 INFO - mozleak == 0.1 17:36:45 INFO - mozlog == 3.2 17:36:45 INFO - moznetwork == 0.27 17:36:45 INFO - mozprocess == 0.22 17:36:45 INFO - mozprofile == 0.28 17:36:45 INFO - mozrunner == 6.11 17:36:45 INFO - mozscreenshot == 0.1 17:36:45 INFO - mozsystemmonitor == 0.3 17:36:45 INFO - moztest == 0.7 17:36:45 INFO - mozversion == 1.4 17:36:45 INFO - psutil == 3.1.1 17:36:45 INFO - requests == 1.2.3 17:36:45 INFO - wsgiref == 0.1.2 17:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:45 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:45 INFO - Using env: {'DISPLAY': ':0', 17:36:45 INFO - 'HOME': '/home/cltbld', 17:36:45 INFO - 'LANG': 'en_US.UTF-8', 17:36:45 INFO - 'LANGUAGE': 'en_US:en', 17:36:45 INFO - 'LOGNAME': 'cltbld', 17:36:45 INFO - 'MAIL': '/var/mail/cltbld', 17:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:45 INFO - 'MOZ_NO_REMOTE': '1', 17:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:45 INFO - 'NO_EM_RESTART': '1', 17:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:45 INFO - 'PWD': '/builds/slave/test', 17:36:45 INFO - 'SHELL': '/bin/bash', 17:36:45 INFO - 'SHLVL': '1', 17:36:45 INFO - 'TERM': 'linux', 17:36:45 INFO - 'TMOUT': '86400', 17:36:45 INFO - 'USER': 'cltbld', 17:36:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:45 INFO - '_': '/tools/buildbot/bin/python'} 17:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:45 INFO - Cleaning up... 17:36:45 INFO - Return code: 0 17:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:45 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 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:36:45 INFO - Using env: {'DISPLAY': ':0', 17:36:45 INFO - 'HOME': '/home/cltbld', 17:36:45 INFO - 'LANG': 'en_US.UTF-8', 17:36:45 INFO - 'LANGUAGE': 'en_US:en', 17:36:45 INFO - 'LOGNAME': 'cltbld', 17:36:45 INFO - 'MAIL': '/var/mail/cltbld', 17:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:45 INFO - 'MOZ_NO_REMOTE': '1', 17:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:45 INFO - 'NO_EM_RESTART': '1', 17:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:45 INFO - 'PWD': '/builds/slave/test', 17:36:45 INFO - 'SHELL': '/bin/bash', 17:36:45 INFO - 'SHLVL': '1', 17:36:45 INFO - 'TERM': 'linux', 17:36:45 INFO - 'TMOUT': '86400', 17:36:45 INFO - 'USER': 'cltbld', 17:36:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:45 INFO - '_': '/tools/buildbot/bin/python'} 17:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:45 INFO - Downloading/unpacking jsonschema 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:47 INFO - Downloading/unpacking functools32 (from jsonschema) 17:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:48 INFO - warning: no files found matching '*.txt' 17:36:48 INFO - no previously-included directories found matching 'build' 17:36:48 INFO - no previously-included directories found matching 'dist' 17:36:48 INFO - no previously-included directories found matching '.git*' 17:36:48 INFO - Installing collected packages: jsonschema, functools32 17:36:48 INFO - Running setup.py install for functools32 17:36:48 INFO - warning: no files found matching '*.txt' 17:36:48 INFO - no previously-included directories found matching 'build' 17:36:48 INFO - no previously-included directories found matching 'dist' 17:36:48 INFO - no previously-included directories found matching '.git*' 17:36:48 INFO - Successfully installed jsonschema functools32 17:36:48 INFO - Cleaning up... 17:36:48 INFO - Return code: 0 17:36:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0ba6c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, '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': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:36:48 INFO - Using env: {'DISPLAY': ':0', 17:36:48 INFO - 'HOME': '/home/cltbld', 17:36:48 INFO - 'LANG': 'en_US.UTF-8', 17:36:48 INFO - 'LANGUAGE': 'en_US:en', 17:36:48 INFO - 'LOGNAME': 'cltbld', 17:36:48 INFO - 'MAIL': '/var/mail/cltbld', 17:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:48 INFO - 'MOZ_NO_REMOTE': '1', 17:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:48 INFO - 'NO_EM_RESTART': '1', 17:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:48 INFO - 'PWD': '/builds/slave/test', 17:36:48 INFO - 'SHELL': '/bin/bash', 17:36:48 INFO - 'SHLVL': '1', 17:36:48 INFO - 'TERM': 'linux', 17:36:48 INFO - 'TMOUT': '86400', 17:36:48 INFO - 'USER': 'cltbld', 17:36:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:48 INFO - '_': '/tools/buildbot/bin/python'} 17:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:48 INFO - Downloading/unpacking flake8 17:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:36:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:36:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:36:51 INFO - no previously-included directories found matching 'docs/_build' 17:36:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:36:51 INFO - Running setup.py install for pep8 17:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:36:51 INFO - no previously-included directories found matching 'docs/_build' 17:36:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:36:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:36:51 INFO - Cleaning up... 17:36:51 INFO - Return code: 0 17:36:51 INFO - Running post-action listener: _resource_record_post_action 17:36:51 INFO - Running post-action listener: _start_resource_monitoring 17:36:51 INFO - Starting resource monitoring. 17:36:51 INFO - ##### 17:36:51 INFO - ##### Finished create-virtualenv step (success) 17:36:51 INFO - ##### 17:36:51 INFO - ##### 17:36:51 INFO - ##### Running install step. 17:36:51 INFO - ##### 17:36:51 INFO - Running pre-action listener: _resource_record_pre_action 17:36:51 INFO - Running main action method: install 17:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:51 INFO - Reading from file tmpfile_stdout 17:36:51 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:51 INFO - Reading from file tmpfile_stdout 17:36:51 INFO - Output received: 17:36:51 INFO - Usage: mozinstall [options] installer 17:36:51 INFO - Options: 17:36:51 INFO - -h, --help show this help message and exit 17:36:51 INFO - -d DEST, --destination=DEST 17:36:51 INFO - Directory to install application into. [default: 17:36:51 INFO - "/builds/slave/test"] 17:36:51 INFO - --app=APP Application being installed. [default: firefox] 17:36:51 INFO - mkdir: /builds/slave/test/build/application 17:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:37:08 INFO - Reading from file tmpfile_stdout 17:37:08 INFO - Output received: 17:37:08 INFO - /builds/slave/test/build/application/firefox/firefox 17:37:08 INFO - Running post-action listener: _resource_record_post_action 17:37:08 INFO - ##### 17:37:08 INFO - ##### Finished install step (success) 17:37:08 INFO - ##### 17:37:08 INFO - ##### 17:37:08 INFO - ##### Running run-tests step. 17:37:08 INFO - ##### 17:37:08 INFO - Running pre-action listener: _resource_record_pre_action 17:37:08 INFO - Running main action method: run_tests 17:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:08 INFO - Python 2.7.3 17:37:08 INFO - Return code: 0 17:37:08 INFO - grabbing minidump binary from tooltool 17:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:08 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 0x1d4f9c0>, '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 0x1d508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d50d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:37:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:37:08 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 17:37:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:08 INFO - Return code: 0 17:37:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:37:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:37:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:37:09 INFO - Return code: 0 17:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:37:09 INFO - Using env: {'DISPLAY': ':0', 17:37:09 INFO - 'HOME': '/home/cltbld', 17:37:09 INFO - 'LANG': 'en_US.UTF-8', 17:37:09 INFO - 'LANGUAGE': 'en_US:en', 17:37:09 INFO - 'LOGNAME': 'cltbld', 17:37:09 INFO - 'MAIL': '/var/mail/cltbld', 17:37:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:09 INFO - 'MOZ_NO_REMOTE': '1', 17:37:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:37:09 INFO - 'NO_EM_RESTART': '1', 17:37:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:09 INFO - 'PWD': '/builds/slave/test', 17:37:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:09 INFO - 'SHELL': '/bin/bash', 17:37:09 INFO - 'SHLVL': '1', 17:37:09 INFO - 'TERM': 'linux', 17:37:09 INFO - 'TMOUT': '86400', 17:37:09 INFO - 'USER': 'cltbld', 17:37:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667', 17:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:09 INFO - '_': '/tools/buildbot/bin/python'} 17:37:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:37:09 INFO - mozversion application_buildid: 20160517143014 17:37:09 INFO - mozversion application_changeset: f79314b1a23fa5fd403fbcf97b81a59a800d9614 17:37:09 INFO - mozversion application_display_name: Nightly 17:37:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:09 INFO - mozversion application_name: Firefox 17:37:09 INFO - mozversion application_remotingname: firefox 17:37:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:37:09 INFO - mozversion application_vendor: Mozilla 17:37:09 INFO - mozversion application_version: 49.0a1 17:37:09 INFO - mozversion platform_buildid: 20160517143014 17:37:09 INFO - mozversion platform_changeset: f79314b1a23fa5fd403fbcf97b81a59a800d9614 17:37:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:37:09 INFO - mozversion platform_version: 49.0a1 17:37:09 INFO - using testdate: 1463531829 17:37:09 INFO - actual date: 1463531829 17:37:09 INFO - starting webserver on 'localhost:54286' 17:37:09 INFO - SUITE-START | Running 2 tests 17:37:09 INFO - TEST-START | dromaeo_css 17:37:09 INFO - operating with platform_type : linux_ 17:37:09 INFO - Initialising browser for dromaeo_css test... 17:37:09 INFO - TEST-INFO | started process 8383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5t3VbI/profile http://localhost:54286/getInfo.html) 17:37:13 INFO - PROCESS | 8383 | __metrics Screen width/height:1600/1200 17:37:13 INFO - PROCESS | 8383 | colorDepth:24 17:37:13 INFO - PROCESS | 8383 | Browser inner width/height: 1024/697 17:37:13 INFO - PROCESS | 8383 | __metrics 17:37:15 ERROR - PROCESS | 8383 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:37:15 INFO - TEST-INFO | 8383: exit 0 17:37:15 INFO - Browser initialized. 17:37:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:15 INFO - TEST-INFO | started process 8465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5t3VbI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:27 INFO - PROCESS | 8465 | RSS: Main: 152432640 17:37:27 INFO - PROCESS | 8465 | 17:38:18 INFO - PROCESS | 8465 | 1463531898835 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:40:26 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54286/tests/dromaeo/cssquery-ext.html) 17:40:28 INFO - PROCESS | 8465 | RSS: Main: 380948480 17:40:28 INFO - PROCESS | 8465 | 17:43:30 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-ext.html (next: http://localhost:54286/tests/dromaeo/cssquery-jquery.html) 17:43:31 INFO - PROCESS | 8465 | RSS: Main: 240291840 17:43:31 INFO - PROCESS | 8465 | 17:46:33 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54286/tests/dromaeo/cssquery-mootools.html) 17:46:33 INFO - PROCESS | 8465 | RSS: Main: 236228608 17:46:33 INFO - PROCESS | 8465 | 17:49:35 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54286/tests/dromaeo/cssquery-prototype.html) 17:49:36 INFO - PROCESS | 8465 | RSS: Main: 235327488 17:49:36 INFO - PROCESS | 8465 | 17:52:39 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54286/tests/dromaeo/cssquery-yui.html) 17:52:39 INFO - PROCESS | 8465 | RSS: Main: 215011328 17:52:39 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-yui.html (next: http://localhost:54286/tests/dromaeo/cssquery-dojo.html) 17:55:42 INFO - PROCESS | 8465 | RSS: Main: 264511488 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | __start_tp_report 17:55:42 INFO - PROCESS | 8465 | _x_x_mozilla_page_load 17:55:42 INFO - PROCESS | 8465 | _x_x_mozilla_page_load_details 17:55:42 INFO - PROCESS | 8465 | |i|pagename|runs| 17:55:42 INFO - PROCESS | 8465 | |0;dojo.html;3145.1822526143205;3154.9211269718253;3185.5221716742494;3191.457452233123;3218.034589623114;5359.222912677659;5373.032854086263;5455.727213639322;5455.91816122758;5513.889722205558;5359.437259087788;5397.109476936311;5400.216968539559;5438.891222175564;5464.480874316933;4857.757112144396;4954.653174277802;4994.5255200756055;5012.223105418666;5054.342935418391;4957.776900039489;5002.749862506878;5011.799528018893;5025.246213068032;5032.446430892599;4788.970371370172;4800.783964721596;4829.396325459317;4840.709557426548;4954.653174277802;4815.277708343741;4826.34844296019;4890.193118135503;4892.461829198785;4932.112219800434;4719.386479757643;4802.711837289774;4847.151748444008;4856.587190088847;4875.536824001714;5245.711485868275;5284;5285.603579731497;5342.332208473941;5345.973270133663;5760.164776107483;5763.6541807491685;5779.479846813807;5787.623804452697;5849.941500585025;5756.5682573807135;5831.562632802556;5840.912386314209;5865.296164460292;5868.882622347572;5360.785568577252;5487.670739755627;5506.80726174586;5506.889862202814;5514.779408823642;5980.880382392328;5986.401359864066;6016.548758843104;6018.7291571878495;6019.157317975487;5623.634463759842;5686.97156514223;5743.195952566561;5755.913661295084;5790.305163380337;5839.386864379179;5842.415758424124;5843.152742852348;5844.94155058444;5890.352061273256;5809.099589563624;5844.795432159854;5851.1515830205235;5852.795152169653;5857.20927674767;5651.971740141273;5785.50823180026;5789.536837053026;5842.152887831241;5853.590248682552;4458.308962110813;4462.062966776948;4463.2635615123145;4468.821247150077;4502.189605870909;3968.3253846846105;3986.903601509608;4007.3788562772233;4012.498437695288;4030.2544029354663;5402.162664786964;5426.511613954763;5438.15708565173;5439.211314359475;5439.456054394529;5852.180694702745;5893.911591326134;5894.322152952465;5941.376155503696;5949.434803693643;5471.480209380103;5474.42518535556;5524.558035357162;5538.224648549206;5544.750486228129;4826.348442960226;4887.706737595756;4959.776810043557;4985.601151907838;4987.675801072919;6002.459778619946;6020.458158765732;6024.216851809324;6024.246969128859;6050.909236361458;5832.533397328289;5851.268591426072;5853.824385268449;5856.0630299151935;5862.736176872051;5866.67733274674;5880.411958804086;5934.525237981037;6020.096985452217;6020.90968635462;5657.4059723728415;5691.373948865705;5691.914621280767;5697.6296540724725;5699.1451282306325;5825.76696932118;5831.329397119385;5832.12518122285;5833.9416605835095;5837.5329973601165;5641.12562552805;5661.773529058792;5666.858328541819;5670.291213598301;5692.31692196939;5686.744096515584;5691.886162276648;5695.45893140151;5695.715214239354;5702.230198923092;5548.861278468071;5574.386817449996;5594.244776955059;5597.272354593877;5608.298962629671;5790.536757059341;5825.0388685866355;5836.066229403275;5843.152742852348;5846.41535846412;5639.859003524781;5647.661140331593;5652.604317697722;5671.234383358194;5689.886202276014 17:55:42 INFO - PROCESS | 8465 | |1;ext.html;571.7912961768956;646.0890144895696;646.7057488842577;650.8372906773307;654.1365397675069;32042.198945026386;32725;43509.782451087776;44858;44930.10139797202;44209.557904420944;44675.55324446755;44870.32694509585;44887;44896.10207795842;8934.776630584221;9069.863952040692;9072.77318067047;9078.455292682427;9080.364374493787;8832.072632373605;8943.821123577525;8946.463212207256;8952.060033696433;8957.372983891097;8961.865572016424;9001.144891235323;9003.459792412476;9006.68476603319;9012.143846334588;8954.19412252897;8961.865572016424;8992.100789921022;8994.955025224897;8998.14517620825;8884.644614215424;8941.910580894173;8948.55257237142;8954.417962832395;8959.552022398919;43017.56982430167;43362;43391.78304108459;43437.131257374676;43489.347659785126;3464.0300715799617;3497.2306092659574;3674.889753307405;3878.8642397516232;4120.484939382577;33129.834350828336;33199.502007469666;33621.83189084039;33625.49561756576;34920.650793491994;4137.710360274782;4204.138151678929;4244.936325955113;4410;4461.620762235214;327572;329512;329886;330137;331109;53958.730206348715;59644.70177649084;61433;61736.69131654313;62218.377816221255;65588.34411655918;65597.34402655912;65857;65994.67002665052;66077.66961165164;17352.219150138273;17507.47477575675;17513.460548220435;17519.649607008043;17522.386716464862;10873.619423320304;13001.674958125934;13022.088453808143;13397.464101435833;13413.128146670435;18559.44321670352;18776.812231877506;19006.71489927652;19009.239630414628;19066.618667626848;6278.717457714414;6371.713272902731;6382.489400847921;6431.1317972073175;6440.61356318613;1059.7562560611102;1090.7436752363187;1091.1761619976867;1109.6837401340579;1230.8030715085542;33558.49662255068;33820.32359352799;33876.66123338735;34112.82943585266;34122.82938585341;1133.7789131119353;1143.3768596115137;1158.5481662151767;1198.3948106206485;1244.7323825377407;17415.73876391855;17829.375971840924;17879;17894.284228630968;17965.640687186184;147580;148244.2587787054;149357;149629;149644;60070;61379.386206137366;61403.692981534805;61444.69277653672;61491.38508614946;1272.26844564374;1392.4778208171936;1416.199847086393;1442.8485009074107;1455.927203639835;33536;34986.300273994886;35389.115272118404;35399.115022123624;35772.4634130483;53158;57382.42617573771;58547.4145258542;58747.70626146842;64810;361215;363031;363203;365825;366464;25420.49159016846;28349;28790.42419151647;28838.567421488275;29150.27124321909;50552;50652.24021639752;50654.49345506498;51172;51662.74168629283;41514.37728434136;42756.786216069966;42933;43458.348124778786;43867;42748.358774619024;42758.57241427546;43667.56332436762;43681.34477982769;44142.33786493269;43129.56870431256;43473.130537389705;43506.34740478832;44109.11781764282;44412.77793611141;35560.82219588989;36229.27541449209;36885.63114368822;37182;37193.628063719014;28378.612903066118;28570.714292856806;28689.28276793097;29326.56010159892;29429.705702942698 17:55:42 INFO - PROCESS | 8465 | |2;jquery.html;397.142172906522;412.67398754983566;414.1117303384241;414.2026598797315;426.53294642366615;11570.826437603442;12088.093392995539;18371.173297201625;20224.39326820196;20321.085551150198;20608.38174854753;20856.957152142408;21312.786872131273;21364.679529807065;21577;6158.076288556707;6215.098810672461;6443.967780161092;6448.742495213435;6448.871022579546;6132.4480796728285;6356.300806911236;6369.585976911486;6389.137466442017;6395.616263024233;6301.275353334357;6351.809445716636;6384.936150638504;6390.904136437957;6393.392627700361;6115.113308570255;6351.9364806351805;6352.364763523657;6363.204599425072;6391.680415979183;6164.106204600353;6172.814815555495;6180.907286390708;6196.752129914798;6212;22578.661320080213;22587.983540740704;22832.429189270235;23539;26480.337991550172;2641.841489510616;2662.4941261160316;2794.399204171113;2805.705400932893;2837.75879050281;15952.521424357288;16519.174041298007;16576.585585360343;16602.667946641;16818.159092045473;2053.240301088592;2133.4666333416644;2246.3485589179118;2253.425376528991;2285.931422057324;92506.53746731291;92557.5372123135;93784;93984.53007734986;95312;16580.4403788959;18535.88856091156;18862.49100071991;19434.514137146685;19609.705854412194;32143.35713285721;32379;32595;32683.40482546918;32760.180995475304;10002.649907253211;10509.9474502627;10748.140148788078;10917.836232456519;10918.344899306067;8994.415363001384;9061.77345566366;9087.36388452802;9088.136627020422;9171.862422063674;8998.79529515273;9053.502057386775;9066.727998160066;9093.727188184233;9152.176304132527;3529.505869178317;3629.9818500907327;3663.816809159531;3674.9632503675157;3697.98305465999;942.5852624845184;1005.9899401006043;1047.4867315015588;1053.1785207538132;1088.580896354909;18903.43289701311;19958.401247962585;20125.59748805045;20294.492637684176;20318.593628127353;1022.2231104360591;1025.3898930136556;1026.389298367485;1026.4200726589454;1048.6329784575337;10594.993475619804;11089.667309980714;11188.104951603853;11227.831582526269;11250.606228781953;409773;410767;412488;421677;433041;65451;84006;88146.55926720325;89206;89608.5519572411;906.5240748606902;924.8843894513186;963.8361478548663;990.4404011733347;1003.8343673293971;16797.396403557468;18177.363792267206;18279.36022239215;18381.356652517097;18685.81314186895;41593.168136636494;42058.15883682248;42102.789486053596;42457;43689.78155109204;58987.41012589819;59717.701411492664;60615.39384606097;60865.69567152136;60892;8189.099199088215;8258.587070646563;8263.504189748634;8280.50316980983;9182.770430739285;12488.37558122072;13296.335183240994;13467.528636497676;14058;14119.435222591392;12150.331731754839;12174.817377739164;12175.208611440228;12217.389130543259;12543.12198146121;11898.464569094238;12050.939745301217;12170.208936419105;12292;12601.684957876127;11978.401079945794;12558.748825023631;12683.11218214716;12699.365031748192;12701.745965080832;8707.738767836974;8731;8738.432001919855;8806.251468625238;8826.514541700268;9087.727368178965;11592.6522204334;12317;12491.750164996467;12591.748165036832 17:55:42 INFO - PROCESS | 8465 | |3;mootools.html;1411.1180512179888;1589.276879020046;1598.6882557901208;1767.6199617082325;1886.1229528269353;8875.156860098288;9318.161365477106;9345.766355841108;9676.371035882663;9696.757581060478;9388.483633400161;9608.039196080406;9610.37532560383;9612.519374031306;9618.47098409589;2151.7955794199524;2221.9777802221934;2360.268316821791;2441.8290719649676;2481.813863960201;2488.8631125288102;2509.3475696318906;2512.1207577347964;2512.346789834638;2514.0446630280558;2465.926022219336;2471.7775400213977;2480.4790993891306;2488.713797913245;2491.202815099169;2069.668852983523;2322.5587138443643;2387.546366190427;2405.482821193452;2429.1983645396976;2422.6729391532094;2437.5612389769835;2438.0369753947093;2439.707235131778;2440.548498527778;9249.445033297956;9282.0253873343;9307.3019523536;9313.58088885995;9314.813703725955;5341.65279256847;5543.362513310981;5547.223388725582;5551.805686800983;5563.916541251884;3433.6223015468277;3467.514547963287;3507.421275489541;3550.8934731958084;3557.0395993081725;1192.7059140832207;1209.6975756060986;1223.4677915106956;1237.919535230216;1254.7741406546818;13351.599452016455;13402.195868247838;13406.530771422953;13415.731685366336;13428.395722192525;5027.974860125676;5057.797688092509;5069.239614057921;5095.0828850806465;5162.793488260502;10952.726181845359;10996.23026388145;11000.22998390121;11010.889891100986;11013.724656883642;5662.631928924689;5667.801626943037;5704.8859022819315;5712.057510510802;5712.6001179917;4563.247064234431;4692.483826779052;5121.3854337479;5121.974390128025;5207.921881171786;4197.265478541243;4207.200631879933;4298.247806633826;4331.155424692155;4368.4321038264825;1355.5255660518937;1382.4332023870165;1385.757492438819;1390.652336915771;1391.749485092693;1044.4046893270763;1057.5505410200633;1060.7772367802847;1066.461436974323;1073.2701762801214;6246.656433896179;6384;6425.164728585348;6471.352864713585;6551;992.8510723391405;1048.046277887119;1053.6206965492418;1056.7833594113188;1087.488880226308;4337.110892267077;4415.094905544356;4417.668674849399;4426.313921342197;4435.733855968652;11706.70733231676;12101.576444824565;12105.970992465564;12116.27302361861;12124.939375303244;11165.27425717342;11675;11676.299422034705;12003.219790713576;12065.758684826254;8588.184122508352;8769;8793.780155496035;8798.340124490689;8808.867866982;6086.878262434638;6215.34738852414;6342.587731797418;6363;6416.871662566816;10201.642942496977;10205.540750666387;10234.232432567736;10321.535530901278;10689.931006899247;11161.609343672932;11166.776664466503;11210.607628732956;11267.154963377616;11279.436028198394;7336.523125996793;7412.6664300107705;8179.10029896699;8243.958780206061;8425.87361189595;9188.678396256098;9215.76960575991;9231.58457869411;9300.20948219409;9311.580978855833;7954.642041108048;8029.959850200712;8031.718889839061;8075.555844428378;8255.958720206361;8039.557824319719;8104;8143.144969778088;8228.547429891414;8268.875966860622;7064.15230172362;7070.222275549582;7153.141623005273;7196.96401517989;7200.71197152108;5223.947402448874;5298.761555729924;5383.434739352311;5391;5429.212764149255;5212.895742085213;5237.16205407133;5243.017592684745;5308.309919710413;5359.222912677717 17:55:42 INFO - PROCESS | 8465 | |4;prototype.html;336.84505127641285;338.67994744966;346.85778830679413;349.994750078749;353.4892080943038;5394.568434525234;5418.756155972976;5438.592105592082;5439.48324909133;5471.097268950618;5312.60155488338;5381.246625472437;5381.300430943981;5381.569474442045;5418.5369950113545;3925.3523168677134;4181.268278051344;4194.538600753915;4226.53508114108;4247.171801498709;4139.648129908961;4148.647364973981;4157.085441202946;4160.979195104021;4162.708610397273;3892.4161375793715;4105.651019663317;4114.691398145136;4118.176364727052;4127.731697439657;3918.196769662227;4055.4930633670792;4078.062045729469;4087.8773636790943;4092.5498195198506;3574.7318951078514;3576.8390422431053;3585.748997570171;3588.22853086585;3596.5684117905757;4927.6550641455115;5045.4702256262935;5122.385313762373;5136.330692524944;5165.457626949154;4714.363560919266;4724.669273150881;4727.550882666142;4732.574068333832;4734.502877197913;5590.552755779528;5599.32808063031;5602.635828671123;5606.943930560683;5608.943910560883;3942.250972315251;3992.5208974923194;3997.2804895118866;4013.779242141681;4050.5949405059555;5712.057510510761;5756.539476841843;5776.59563830532;5788.7684492620665;5807.506361959238;4115.238680843993;4126;4127.8968025799595;4128.6284234419045;4149.688773342012;3985.6412922837085;4110.23960567296;4150.91698166041;4182.142660754538;4188.183304255702;4688.874670079224;4715.0805592909055;4717.268823332389;4725.69282996611;4744.478107408182;5583.860403489945;5584.301962254718;5599.8880022400135;5638.295213098363;5674.375818659944;1376.9311534423239;1435.117402797293;1448.160067161044;1448.217962300346;1452.716720239543;930.1256818590504;935.2845073518764;949.9857502137473;950.3252690589759;951.8952915179325;4855.830045948375;4931.408231012301;4956.21576232556;4971.850844474671;4977.0884032841195;5082.74586270685;5090.847274581768;5142.382914050263;5154.871128221749;5159.509846564571;5156;5156.607715916682;5402.594805389612;5422.295101636762;5429.755660995264;3004.173852190665;3039.042701549005;3040.559118927743;3055.7860949733304;3066.9233269168003;5793.797217097382;5895.115732640053;5898.997170481029;6020.1036673447725;6032.939670603326;5816.912746308809;5849.2103566018895;5861;5936.287645482484;5947.316058653224;5895;5908;5955.642661440327;5973.970130149409;5984.31180414258;5475.589330800286;5807.361190268983;5815.04051831443;5836.766529338779;5838.591298609226;5736.68448235351;5737.540996720336;5747.241324164341;5749.913751293818;5769.451902069297;5734.283214598176;5930.703464826827;5985.396352586638;6022.849428764316;6026.306974697791;4205.642520385679;4216.494020717533;4227.577242275871;4260.8721738347895;4261.126469073894;5794.246747922743;5869.826034793144;5879.353271140257;5880.059190529495;5901.852453688693;5387.568994480511;5644.3508996465935;5660.405657405913;5678.488935995781;5732.111522713986;5582.804601838916;5643.266375371176;5650.180723795109;5703.258576385043;5710.971445142914;5302.734863256745;5461.180822876441;5533.197686335539;5574.581906357121;5588.441155884379;5703.743331550173;5710.143478478261;5726.284214473191;5739.598228123991;5744.942550574441;5365.436629154039;5552.611317207757;5570.721463926869;5587.273654424899;5599.440055994531 17:55:42 INFO - PROCESS | 8465 | |5;yui.html;744.8137965508627;754.2947344233143;755.5164694595456;801.4510060608483;891.1355984694845;12549.247045177284;13097.279649619291;13148.408321625526;13173.209607423561;13221.206727596338;14168.574942751708;14508.05697629656;14703.485378011772;14717.264136793145;14745.631359216024;693.5110746923432;842.334555700997;846.0693237438829;857.0443954990203;857.1642648417806;814.6944895664126;854.4147259127486;855.8630619100945;858.8239410920778;859.4413631139747;878.8593824988003;879.5514287713248;880.8898887639045;883.244825674049;884.4251236696167;726.4007194064865;750.0549307872066;887.6582515731425;890.5102193793421;891.0999890111002;548.2434240747742;612.9478994285491;639.7089324357406;639.7824739588563;641.0288413054227;14396.928015359961;14415.207163605997;14419.35112919921;14425.134491930517;14433.639159021108;13286.26925519096;13373.264470454122;13555.051146419755;13725.725485490235;13729.45082196711;11789.941050294694;12397.566085186974;12501.310436063237;12604.495820167182;12900.419481123372;4421.07157496926;4470.687051906368;4502.144592527409;4505.864824055284;4623.884402889921;55362;55746.44253557493;56813.431865681225;56885;56955.43044569584;10024.899751002396;10213.932423574275;10244.231682623833;10337.844932326021;10373.740656483647;19148.808511914704;19212.71180932259;19233.90383048076;19240.615187696447;19340.903295483433;8167.224113709188;8180.836383272302;8218.209696770598;8248.52437404493;8284;4801;4844.2007068833245;4852.296417019583;4897.681650692693;5010;3468.5490886184634;3669.3028324618235;3685.631436856293;3690.5202323698286;3709.0727318170457;674.4065222604077;692.7436848366136;711.7651175112304;712.6009434716575;715.5635062611802;729.7347006745564;743.108270075911;752.7779305104898;755.8979537762442;765.9004329437249;10062.345947513388;10293.869194915567;10543.736406589896;10621.2034097443;10864;649.389573800626;673.5554534007531;715.599264411931;768.1895600141904;780.9765707028798;4649.16443933756;4659.138059459011;4737.786799594027;4844.2007068833245;4911.656184067081;70220.2977970224;70518;70702;70972.64513677398;71111.2888871115;63474.682626586575;65316;65898.67050664716;66130;66318;58491.122633160536;58518.707406463545;59456;60248.69875650594;60303.09545356911;9463.479508626817;9525.285603579621;9543.18882894934;9581.904180958101;9584.185344245538;37680;38922.6107738919;39723.40414893837;39757.60242397655;40658.39012414757;48457.515424845304;52647.47352526426;52964.73517632387;53610.73194634002;53986.73006634942;11040.834387484354;11099.72250693739;11116.666500005012;11427.771444571228;11692.824607631062;12957.22256664603;13053.412596433373;13314.600561983156;13334.33328333599;13425;12108.273503589813;12342.321172335607;12587.307698076695;12968.351582420653;13336.466541338237;12310.384480776105;12998.220106793622;13015.609531714064;13260.668483287609;14031.719365612835;12513.249205047727;12658.367081646065;12736.872631273569;13385.799213011618;13636.318184090955;11345.319280843176;11438.714032149262;11525.711857203301;11735.354555499529;11741.823872641746;11424.771504569695;11448.771024579295;11731.178817482694;11743.941280293544;11747.706307342385 17:55:42 INFO - PROCESS | 8465 | __end_tp_report 17:55:42 INFO - PROCESS | 8465 | __start_cc_report 17:55:42 INFO - PROCESS | 8465 | _x_x_mozilla_cycle_collect,1832 17:55:42 INFO - PROCESS | 8465 | __end_cc_report 17:55:42 INFO - PROCESS | 8465 | __startTimestamp1463532942664__endTimestamp 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | ------- Summary: start ------- 17:55:42 INFO - PROCESS | 8465 | Number of tests: 6 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#0] dojo.html Cycles:165 Average:5398.79 Median:5641.13 stddev:618.03 (11.0%) stddev-sans-first:594.10 17:55:42 INFO - PROCESS | 8465 | Values: 3145.2 3154.9 3185.5 3191.5 3218.0 5359.2 5373.0 5455.7 5455.9 5513.9 5359.4 5397.1 5400.2 5438.9 5464.5 4857.8 4954.7 4994.5 5012.2 5054.3 4957.8 5002.7 5011.8 5025.2 5032.4 4789.0 4800.8 4829.4 4840.7 4954.7 4815.3 4826.3 4890.2 4892.5 4932.1 4719.4 4802.7 4847.2 4856.6 4875.5 5245.7 5284.0 5285.6 5342.3 5346.0 5760.2 5763.7 5779.5 5787.6 5849.9 5756.6 5831.6 5840.9 5865.3 5868.9 5360.8 5487.7 5506.8 5506.9 5514.8 5980.9 5986.4 6016.5 6018.7 6019.2 5623.6 5687.0 5743.2 5755.9 5790.3 5839.4 5842.4 5843.2 5844.9 5890.4 5809.1 5844.8 5851.2 5852.8 5857.2 5652.0 5785.5 5789.5 5842.2 5853.6 4458.3 4462.1 4463.3 4468.8 4502.2 3968.3 3986.9 4007.4 4012.5 4030.3 5402.2 5426.5 5438.2 5439.2 5439.5 5852.2 5893.9 5894.3 5941.4 5949.4 5471.5 5474.4 5524.6 5538.2 5544.8 4826.3 4887.7 4959.8 4985.6 4987.7 6002.5 6020.5 6024.2 6024.2 6050.9 5832.5 5851.3 5853.8 5856.1 5862.7 5866.7 5880.4 5934.5 6020.1 6020.9 5657.4 5691.4 5691.9 5697.6 5699.1 5825.8 5831.3 5832.1 5833.9 5837.5 5641.1 5661.8 5666.9 5670.3 5692.3 5686.7 5691.9 5695.5 5695.7 5702.2 5548.9 5574.4 5594.2 5597.3 5608.3 5790.5 5825.0 5836.1 5843.2 5846.4 5639.9 5647.7 5652.6 5671.2 5689.9 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#1] ext.html Cycles:180 Average:47865.27 Median:23496.65 stddev:77986.55 (331.9%) stddev-sans-first:78124.48 17:55:42 INFO - PROCESS | 8465 | Values: 571.8 646.1 646.7 650.8 654.1 32042.2 32725.0 43509.8 44858.0 44930.1 44209.6 44675.6 44870.3 44887.0 44896.1 8934.8 9069.9 9072.8 9078.5 9080.4 8832.1 8943.8 8946.5 8952.1 8957.4 8961.9 9001.1 9003.5 9006.7 9012.1 8954.2 8961.9 8992.1 8995.0 8998.1 8884.6 8941.9 8948.6 8954.4 8959.6 43017.6 43362.0 43391.8 43437.1 43489.3 3464.0 3497.2 3674.9 3878.9 4120.5 33129.8 33199.5 33621.8 33625.5 34920.7 4137.7 4204.1 4244.9 4410.0 4461.6 327572.0 329512.0 329886.0 330137.0 331109.0 53958.7 59644.7 61433.0 61736.7 62218.4 65588.3 65597.3 65857.0 65994.7 66077.7 17352.2 17507.5 17513.5 17519.6 17522.4 10873.6 13001.7 13022.1 13397.5 13413.1 18559.4 18776.8 19006.7 19009.2 19066.6 6278.7 6371.7 6382.5 6431.1 6440.6 1059.8 1090.7 1091.2 1109.7 1230.8 33558.5 33820.3 33876.7 34112.8 34122.8 1133.8 1143.4 1158.5 1198.4 1244.7 17415.7 17829.4 17879.0 17894.3 17965.6 147580.0 148244.3 149357.0 149629.0 149644.0 60070.0 61379.4 61403.7 61444.7 61491.4 1272.3 1392.5 1416.2 1442.8 1455.9 33536.0 34986.3 35389.1 35399.1 35772.5 53158.0 57382.4 58547.4 58747.7 64810.0 361215.0 363031.0 363203.0 365825.0 366464.0 25420.5 28349.0 28790.4 28838.6 29150.3 50552.0 50652.2 50654.5 51172.0 51662.7 41514.4 42756.8 42933.0 43458.3 43867.0 42748.4 42758.6 43667.6 43681.3 44142.3 43129.6 43473.1 43506.3 44109.1 44412.8 35560.8 36229.3 36885.6 37182.0 37193.6 28378.6 28570.7 28689.3 29326.6 29429.7 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#2] jquery.html Cycles:180 Average:28516.20 Median:32487.00 stddev:69235.02 (213.1%) stddev-sans-first:69397.05 17:55:42 INFO - PROCESS | 8465 | Values: 397.1 412.7 414.1 414.2 426.5 11570.8 12088.1 18371.2 20224.4 20321.1 20608.4 20857.0 21312.8 21364.7 21577.0 6158.1 6215.1 6444.0 6448.7 6448.9 6132.4 6356.3 6369.6 6389.1 6395.6 6301.3 6351.8 6384.9 6390.9 6393.4 6115.1 6351.9 6352.4 6363.2 6391.7 6164.1 6172.8 6180.9 6196.8 6212.0 22578.7 22588.0 22832.4 23539.0 26480.3 2641.8 2662.5 2794.4 2805.7 2837.8 15952.5 16519.2 16576.6 16602.7 16818.2 2053.2 2133.5 2246.3 2253.4 2285.9 92506.5 92557.5 93784.0 93984.5 95312.0 16580.4 18535.9 18862.5 19434.5 19609.7 32143.4 32379.0 32595.0 32683.4 32760.2 10002.6 10509.9 10748.1 10917.8 10918.3 8994.4 9061.8 9087.4 9088.1 9171.9 8998.8 9053.5 9066.7 9093.7 9152.2 3529.5 3630.0 3663.8 3675.0 3698.0 942.6 1006.0 1047.5 1053.2 1088.6 18903.4 19958.4 20125.6 20294.5 20318.6 1022.2 1025.4 1026.4 1026.4 1048.6 10595.0 11089.7 11188.1 11227.8 11250.6 409773.0 410767.0 412488.0 421677.0 433041.0 65451.0 84006.0 88146.6 89206.0 89608.6 906.5 924.9 963.8 990.4 1003.8 16797.4 18177.4 18279.4 18381.4 18685.8 41593.2 42058.2 42102.8 42457.0 43689.8 58987.4 59717.7 60615.4 60865.7 60892.0 8189.1 8258.6 8263.5 8280.5 9182.8 12488.4 13296.3 13467.5 14058.0 14119.4 12150.3 12174.8 12175.2 12217.4 12543.1 11898.5 12050.9 12170.2 12292.0 12601.7 11978.4 12558.7 12683.1 12699.4 12701.7 8707.7 8731.0 8738.4 8806.3 8826.5 9087.7 11592.7 12317.0 12491.8 12591.7 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#3] mootools.html Cycles:180 Average:6177.61 Median:4416.38 stddev:3556.64 (80.5%) stddev-sans-first:3548.57 17:55:42 INFO - PROCESS | 8465 | Values: 1411.1 1589.3 1598.7 1767.6 1886.1 8875.2 9318.2 9345.8 9676.4 9696.8 9388.5 9608.0 9610.4 9612.5 9618.5 2151.8 2222.0 2360.3 2441.8 2481.8 2488.9 2509.3 2512.1 2512.3 2514.0 2465.9 2471.8 2480.5 2488.7 2491.2 2069.7 2322.6 2387.5 2405.5 2429.2 2422.7 2437.6 2438.0 2439.7 2440.5 9249.4 9282.0 9307.3 9313.6 9314.8 5341.7 5543.4 5547.2 5551.8 5563.9 3433.6 3467.5 3507.4 3550.9 3557.0 1192.7 1209.7 1223.5 1237.9 1254.8 13351.6 13402.2 13406.5 13415.7 13428.4 5028.0 5057.8 5069.2 5095.1 5162.8 10952.7 10996.2 11000.2 11010.9 11013.7 5662.6 5667.8 5704.9 5712.1 5712.6 4563.2 4692.5 5121.4 5122.0 5207.9 4197.3 4207.2 4298.2 4331.2 4368.4 1355.5 1382.4 1385.8 1390.7 1391.7 1044.4 1057.6 1060.8 1066.5 1073.3 6246.7 6384.0 6425.2 6471.4 6551.0 992.9 1048.0 1053.6 1056.8 1087.5 4337.1 4415.1 4417.7 4426.3 4435.7 11706.7 12101.6 12106.0 12116.3 12124.9 11165.3 11675.0 11676.3 12003.2 12065.8 8588.2 8769.0 8793.8 8798.3 8808.9 6086.9 6215.3 6342.6 6363.0 6416.9 10201.6 10205.5 10234.2 10321.5 10689.9 11161.6 11166.8 11210.6 11267.2 11279.4 7336.5 7412.7 8179.1 8244.0 8425.9 9188.7 9215.8 9231.6 9300.2 9311.6 7954.6 8030.0 8031.7 8075.6 8256.0 8039.6 8104.0 8143.1 8228.5 8268.9 7064.2 7070.2 7153.1 7197.0 7200.7 5223.9 5298.8 5383.4 5391.0 5429.2 5212.9 5237.2 5243.0 5308.3 5359.2 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#4] prototype.html Cycles:180 Average:4695.79 Median:5381.27 stddev:1387.52 (25.8%) stddev-sans-first:1352.29 17:55:42 INFO - PROCESS | 8465 | Values: 336.8 338.7 346.9 350.0 353.5 5394.6 5418.8 5438.6 5439.5 5471.1 5312.6 5381.2 5381.3 5381.6 5418.5 3925.4 4181.3 4194.5 4226.5 4247.2 4139.6 4148.6 4157.1 4161.0 4162.7 3892.4 4105.7 4114.7 4118.2 4127.7 3918.2 4055.5 4078.1 4087.9 4092.5 3574.7 3576.8 3585.7 3588.2 3596.6 4927.7 5045.5 5122.4 5136.3 5165.5 4714.4 4724.7 4727.6 4732.6 4734.5 5590.6 5599.3 5602.6 5606.9 5608.9 3942.3 3992.5 3997.3 4013.8 4050.6 5712.1 5756.5 5776.6 5788.8 5807.5 4115.2 4126.0 4127.9 4128.6 4149.7 3985.6 4110.2 4150.9 4182.1 4188.2 4688.9 4715.1 4717.3 4725.7 4744.5 5583.9 5584.3 5599.9 5638.3 5674.4 1376.9 1435.1 1448.2 1448.2 1452.7 930.1 935.3 950.0 950.3 951.9 4855.8 4931.4 4956.2 4971.9 4977.1 5082.7 5090.8 5142.4 5154.9 5159.5 5156.0 5156.6 5402.6 5422.3 5429.8 3004.2 3039.0 3040.6 3055.8 3066.9 5793.8 5895.1 5899.0 6020.1 6032.9 5816.9 5849.2 5861.0 5936.3 5947.3 5895.0 5908.0 5955.6 5974.0 5984.3 5475.6 5807.4 5815.0 5836.8 5838.6 5736.7 5737.5 5747.2 5749.9 5769.5 5734.3 5930.7 5985.4 6022.8 6026.3 4205.6 4216.5 4227.6 4260.9 4261.1 5794.2 5869.8 5879.4 5880.1 5901.9 5387.6 5644.4 5660.4 5678.5 5732.1 5582.8 5643.3 5650.2 5703.3 5711.0 5302.7 5461.2 5533.2 5574.6 5588.4 5703.7 5710.1 5726.3 5739.6 5744.9 5365.4 5552.6 5570.7 5587.3 5599.4 17:55:42 INFO - PROCESS | 8465 | 17:55:42 INFO - PROCESS | 8465 | [#5] yui.html Cycles:180 Average:16124.13 Median:4654.15 stddev:19597.01 (421.1%) stddev-sans-first:19617.95 17:55:42 INFO - PROCESS | 8465 | Values: 744.8 754.3 755.5 801.5 891.1 12549.2 13097.3 13148.4 13173.2 13221.2 14168.6 14508.1 14703.5 14717.3 14745.6 693.5 842.3 846.1 857.0 857.2 814.7 854.4 855.9 858.8 859.4 878.9 879.6 880.9 883.2 884.4 726.4 750.1 887.7 890.5 891.1 548.2 612.9 639.7 639.8 641.0 14396.9 14415.2 14419.4 14425.1 14433.6 13286.3 13373.3 13555.1 13725.7 13729.5 11789.9 12397.6 12501.3 12604.5 12900.4 4421.1 4470.7 4502.1 4505.9 4623.9 55362.0 55746.4 56813.4 56885.0 56955.4 10024.9 10213.9 10244.2 10337.8 10373.7 19148.8 19212.7 19233.9 19240.6 19340.9 8167.2 8180.8 8218.2 8248.5 8284.0 4801.0 4844.2 4852.3 4897.7 5010.0 3468.5 3669.3 3685.6 3690.5 3709.1 674.4 692.7 711.8 712.6 715.6 729.7 743.1 752.8 755.9 765.9 10062.3 10293.9 10543.7 10621.2 10864.0 649.4 673.6 715.6 768.2 781.0 4649.2 4659.1 4737.8 4844.2 4911.7 70220.3 70518.0 70702.0 70972.6 71111.3 63474.7 65316.0 65898.7 66130.0 66318.0 58491.1 58518.7 59456.0 60248.7 60303.1 9463.5 9525.3 9543.2 9581.9 9584.2 37680.0 38922.6 39723.4 39757.6 40658.4 48457.5 52647.5 52964.7 53610.7 53986.7 11040.8 11099.7 11116.7 11427.8 11692.8 12957.2 13053.4 13314.6 13334.3 13425.0 12108.3 12342.3 12587.3 12968.4 13336.5 12310.4 12998.2 13015.6 13260.7 14031.7 12513.2 12658.4 12736.9 13385.8 13636.3 11345.3 11438.7 11525.7 11735.4 11741.8 11424.8 11448.8 11731.2 11743.9 11747.7 17:55:42 INFO - PROCESS | 8465 | -------- Summary: end -------- 17:55:42 INFO - PROCESS | 8465 | 17:55:43 INFO - TEST-INFO | 8465: exit 0 17:55:43 INFO - TEST-OK | dromaeo_css | took 1113931ms 17:55:43 INFO - TEST-START | kraken 17:55:43 INFO - operating with platform_type : linux_ 17:55:43 INFO - Initialising browser for kraken test... 17:55:43 INFO - TEST-INFO | started process 8656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKOLET/profile http://localhost:54286/getInfo.html) 17:55:47 INFO - PROCESS | 8656 | __metrics Screen width/height:1600/1200 17:55:47 INFO - PROCESS | 8656 | colorDepth:24 17:55:47 INFO - PROCESS | 8656 | Browser inner width/height: 1024/697 17:55:47 INFO - PROCESS | 8656 | __metrics 17:55:48 ERROR - PROCESS | 8656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:55:49 INFO - TEST-INFO | 8656: exit 0 17:55:49 INFO - Browser initialized. 17:55:49 INFO - Running cycle 1/1 for kraken test... 17:55:49 INFO - TEST-INFO | started process 8737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKOLET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:01 INFO - PROCESS | 8737 | RSS: Main: 152698880 17:56:01 INFO - PROCESS | 8737 | 17:56:04 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:04 INFO - PROCESS | 8737 | RSS: Main: 208461824 17:56:04 INFO - PROCESS | 8737 | 17:56:07 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-dft) 17:56:08 INFO - PROCESS | 8737 | RSS: Main: 197775360 17:56:08 INFO - PROCESS | 8737 | 17:56:11 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-fft) 17:56:12 INFO - PROCESS | 8737 | RSS: Main: 265424896 17:56:12 INFO - PROCESS | 8737 | 17:56:14 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-oscillator) 17:56:14 INFO - PROCESS | 8737 | RSS: Main: 174936064 17:56:14 INFO - PROCESS | 8737 | 17:56:17 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:17 INFO - PROCESS | 8737 | RSS: Main: 179007488 17:56:17 INFO - PROCESS | 8737 | 17:56:20 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:21 INFO - PROCESS | 8737 | RSS: Main: 215470080 17:56:21 INFO - PROCESS | 8737 | 17:56:25 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:25 INFO - PROCESS | 8737 | RSS: Main: 212889600 17:56:25 INFO - PROCESS | 8737 | 17:56:28 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54286/tests/kraken/driver.html?testName=json-parse-financial) 17:56:29 INFO - PROCESS | 8737 | RSS: Main: 213413888 17:56:29 INFO - PROCESS | 8737 | 17:56:30 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:31 INFO - PROCESS | 8737 | RSS: Main: 201990144 17:56:31 INFO - PROCESS | 8737 | 17:56:33 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:33 INFO - PROCESS | 8737 | RSS: Main: 206200832 17:56:33 INFO - PROCESS | 8737 | 17:56:35 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:36 INFO - PROCESS | 8737 | RSS: Main: 216625152 17:56:36 INFO - PROCESS | 8737 | 17:56:39 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:39 INFO - PROCESS | 8737 | RSS: Main: 223920128 17:56:39 INFO - PROCESS | 8737 | 17:56:42 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:43 INFO - PROCESS | 8737 | RSS: Main: 219385856 17:56:43 INFO - PROCESS | 8737 | 17:56:44 INFO - PROCESS | 8737 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54286/tests/kraken/driver.html?testName=ai-astar) 17:56:45 INFO - PROCESS | 8737 | RSS: Main: 264732672 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | __start_tp_report 17:56:45 INFO - PROCESS | 8737 | _x_x_mozilla_page_load 17:56:45 INFO - PROCESS | 8737 | _x_x_mozilla_page_load_details 17:56:45 INFO - PROCESS | 8737 | |i|pagename|runs| 17:56:45 INFO - PROCESS | 8737 | |0;ai-astar;111;105;112;108;109;111;109;110;109;110 17:56:45 INFO - PROCESS | 8737 | |1;audio-beat-detection;156;124;152;212;123;151;150;128;178;122 17:56:45 INFO - PROCESS | 8737 | |2;audio-dft;161;159;161;159;159;161;161;159;162;160 17:56:45 INFO - PROCESS | 8737 | |3;audio-fft;74;74;74;151;75;74;76;74;130;74 17:56:45 INFO - PROCESS | 8737 | |4;audio-oscillator;91;92;146;92;92;92;124;92;91;133 17:56:45 INFO - PROCESS | 8737 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;116;117 17:56:45 INFO - PROCESS | 8737 | |6;imaging-darkroom;145;145;144;146;145;146;146;145;145;145 17:56:45 INFO - PROCESS | 8737 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;95;94 17:56:45 INFO - PROCESS | 8737 | |8;json-parse-financial;54;52;54;54;54;54;53;108;52;52 17:56:45 INFO - PROCESS | 8737 | |9;json-stringify-tinderbox;58;58;57;58;58;58;58;58;58;59 17:56:45 INFO - PROCESS | 8737 | |10;stanford-crypto-aes;77;78;77;77;78;77;77;79;79;78 17:56:45 INFO - PROCESS | 8737 | |11;stanford-crypto-ccm;119;118;117;115;124;119;124;117;197;123 17:56:45 INFO - PROCESS | 8737 | |12;stanford-crypto-pbkdf2;161;159;161;163;167;161;164;163;163;160 17:56:45 INFO - PROCESS | 8737 | |13;stanford-crypto-sha256-iterative;62;63;63;62;62;68;62;62;61;63 17:56:45 INFO - PROCESS | 8737 | __end_tp_report 17:56:45 INFO - PROCESS | 8737 | __start_cc_report 17:56:45 INFO - PROCESS | 8737 | _x_x_mozilla_cycle_collect,1886 17:56:45 INFO - PROCESS | 8737 | __end_cc_report 17:56:45 INFO - PROCESS | 8737 | __startTimestamp1463533005120__endTimestamp 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | ------- Summary: start ------- 17:56:45 INFO - PROCESS | 8737 | Number of tests: 14 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.96 (1.8%) stddev-sans-first:1.99 17:56:45 INFO - PROCESS | 8737 | Values: 111.0 105.0 112.0 108.0 109.0 111.0 109.0 110.0 109.0 110.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:151.50 stddev:28.56 (18.9%) stddev-sans-first:30.20 17:56:45 INFO - PROCESS | 8737 | Values: 156.0 124.0 152.0 212.0 123.0 151.0 150.0 128.0 178.0 122.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 17:56:45 INFO - PROCESS | 8737 | Values: 161.0 159.0 161.0 159.0 159.0 161.0 161.0 159.0 162.0 160.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.00 stddev:28.32 (38.3%) stddev-sans-first:29.61 17:56:45 INFO - PROCESS | 8737 | Values: 74.0 74.0 74.0 151.0 75.0 74.0 76.0 74.0 130.0 74.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:92.00 stddev:21.24 (23.1%) stddev-sans-first:21.96 17:56:45 INFO - PROCESS | 8737 | Values: 91.0 92.0 146.0 92.0 92.0 92.0 124.0 92.0 91.0 133.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:56:45 INFO - PROCESS | 8737 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:56:45 INFO - PROCESS | 8737 | Values: 145.0 145.0 144.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:56:45 INFO - PROCESS | 8737 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:54.00 stddev:17.35 (32.1%) stddev-sans-first:18.32 17:56:45 INFO - PROCESS | 8737 | Values: 54.0 52.0 54.0 54.0 54.0 54.0 53.0 108.0 52.0 52.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 17:56:45 INFO - PROCESS | 8737 | Values: 58.0 58.0 57.0 58.0 58.0 58.0 58.0 58.0 58.0 59.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 17:56:45 INFO - PROCESS | 8737 | Values: 77.0 78.0 77.0 77.0 78.0 77.0 77.0 79.0 79.0 78.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:121.00 stddev:24.69 (20.4%) stddev-sans-first:26.00 17:56:45 INFO - PROCESS | 8737 | Values: 119.0 118.0 117.0 115.0 124.0 119.0 124.0 117.0 197.0 123.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:2.30 (1.4%) stddev-sans-first:2.40 17:56:45 INFO - PROCESS | 8737 | Values: 161.0 159.0 161.0 163.0 167.0 161.0 164.0 163.0 163.0 160.0 17:56:45 INFO - PROCESS | 8737 | 17:56:45 INFO - PROCESS | 8737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.93 (3.1%) stddev-sans-first:2.03 17:56:45 INFO - PROCESS | 8737 | Values: 62.0 63.0 63.0 62.0 62.0 68.0 62.0 62.0 61.0 63.0 17:56:45 INFO - PROCESS | 8737 | -------- Summary: end -------- 17:56:45 INFO - PROCESS | 8737 | 17:56:46 INFO - TEST-INFO | 8737: exit 0 17:56:46 INFO - TEST-OK | kraken | took 62755ms 17:56:46 INFO - SUITE-END | took 1176s 17:56:46 INFO - Completed test suite (00:19:36) 17:56:46 INFO - javascript benchmark 17:56:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.1822526143205, 3154.9211269718253, 3185.5221716742494, 3191.457452233123, 3218.034589623114, 5359.222912677659, 5373.032854086263, 5455.727213639322, 5455.91816122758, 5513.889722205558, 5359.437259087788, 5397.109476936311, 5400.216968539559, 5438.891222175564, 5464.480874316933, 4857.757112144396, 4954.653174277802, 4994.5255200756055, 5012.223105418666, 5054.342935418391, 4957.776900039489, 5002.749862506878, 5011.799528018893, 5025.246213068032, 5032.446430892599, 4788.970371370172, 4800.783964721596, 4829.396325459317, 4840.709557426548, 4954.653174277802, 4815.277708343741, 4826.34844296019, 4890.193118135503, 4892.461829198785, 4932.112219800434, 4719.386479757643, 4802.711837289774, 4847.151748444008, 4856.587190088847, 4875.536824001714, 5245.711485868275, 5284.0, 5285.603579731497, 5342.332208473941, 5345.973270133663, 5760.164776107483, 5763.6541807491685, 5779.479846813807, 5787.623804452697, 5849.941500585025, 5756.5682573807135, 5831.562632802556, 5840.912386314209, 5865.296164460292, 5868.882622347572, 5360.785568577252, 5487.670739755627, 5506.80726174586, 5506.889862202814, 5514.779408823642, 5980.880382392328, 5986.401359864066, 6016.548758843104, 6018.7291571878495, 6019.157317975487, 5623.634463759842, 5686.97156514223, 5743.195952566561, 5755.913661295084, 5790.305163380337, 5839.386864379179, 5842.415758424124, 5843.152742852348, 5844.94155058444, 5890.352061273256, 5809.099589563624, 5844.795432159854, 5851.1515830205235, 5852.795152169653, 5857.20927674767, 5651.971740141273, 5785.50823180026, 5789.536837053026, 5842.152887831241, 5853.590248682552, 4458.308962110813, 4462.062966776948, 4463.2635615123145, 4468.821247150077, 4502.189605870909, 3968.3253846846105, 3986.903601509608, 4007.3788562772233, 4012.498437695288, 4030.2544029354663, 5402.162664786964, 5426.511613954763, 5438.15708565173, 5439.211314359475, 5439.456054394529, 5852.180694702745, 5893.911591326134, 5894.322152952465, 5941.376155503696, 5949.434803693643, 5471.480209380103, 5474.42518535556, 5524.558035357162, 5538.224648549206, 5544.750486228129, 4826.348442960226, 4887.706737595756, 4959.776810043557, 4985.601151907838, 4987.675801072919, 6002.459778619946, 6020.458158765732, 6024.216851809324, 6024.246969128859, 6050.909236361458, 5832.533397328289, 5851.268591426072, 5853.824385268449, 5856.0630299151935, 5862.736176872051, 5866.67733274674, 5880.411958804086, 5934.525237981037, 6020.096985452217, 6020.90968635462, 5657.4059723728415, 5691.373948865705, 5691.914621280767, 5697.6296540724725, 5699.1451282306325, 5825.76696932118, 5831.329397119385, 5832.12518122285, 5833.9416605835095, 5837.5329973601165, 5641.12562552805, 5661.773529058792, 5666.858328541819, 5670.291213598301, 5692.31692196939, 5686.744096515584, 5691.886162276648, 5695.45893140151, 5695.715214239354, 5702.230198923092, 5548.861278468071, 5574.386817449996, 5594.244776955059, 5597.272354593877, 5608.298962629671, 5790.536757059341, 5825.0388685866355, 5836.066229403275, 5843.152742852348, 5846.41535846412, 5639.859003524781, 5647.661140331593, 5652.604317697722, 5671.234383358194, 5689.886202276014], "value": 5357.104274667181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7912961768956, 646.0890144895696, 646.7057488842577, 650.8372906773307, 654.1365397675069, 32042.198945026386, 32725.0, 43509.782451087776, 44858.0, 44930.10139797202, 44209.557904420944, 44675.55324446755, 44870.32694509585, 44887.0, 44896.10207795842, 8934.776630584221, 9069.863952040692, 9072.77318067047, 9078.455292682427, 9080.364374493787, 8832.072632373605, 8943.821123577525, 8946.463212207256, 8952.060033696433, 8957.372983891097, 8961.865572016424, 9001.144891235323, 9003.459792412476, 9006.68476603319, 9012.143846334588, 8954.19412252897, 8961.865572016424, 8992.100789921022, 8994.955025224897, 8998.14517620825, 8884.644614215424, 8941.910580894173, 8948.55257237142, 8954.417962832395, 8959.552022398919, 43017.56982430167, 43362.0, 43391.78304108459, 43437.131257374676, 43489.347659785126, 3464.0300715799617, 3497.2306092659574, 3674.889753307405, 3878.8642397516232, 4120.484939382577, 33129.834350828336, 33199.502007469666, 33621.83189084039, 33625.49561756576, 34920.650793491994, 4137.710360274782, 4204.138151678929, 4244.936325955113, 4410.0, 4461.620762235214, 327572.0, 329512.0, 329886.0, 330137.0, 331109.0, 53958.730206348715, 59644.70177649084, 61433.0, 61736.69131654313, 62218.377816221255, 65588.34411655918, 65597.34402655912, 65857.0, 65994.67002665052, 66077.66961165164, 17352.219150138273, 17507.47477575675, 17513.460548220435, 17519.649607008043, 17522.386716464862, 10873.619423320304, 13001.674958125934, 13022.088453808143, 13397.464101435833, 13413.128146670435, 18559.44321670352, 18776.812231877506, 19006.71489927652, 19009.239630414628, 19066.618667626848, 6278.717457714414, 6371.713272902731, 6382.489400847921, 6431.1317972073175, 6440.61356318613, 1059.7562560611102, 1090.7436752363187, 1091.1761619976867, 1109.6837401340579, 1230.8030715085542, 33558.49662255068, 33820.32359352799, 33876.66123338735, 34112.82943585266, 34122.82938585341, 1133.7789131119353, 1143.3768596115137, 1158.5481662151767, 1198.3948106206485, 1244.7323825377407, 17415.73876391855, 17829.375971840924, 17879.0, 17894.284228630968, 17965.640687186184, 147580.0, 148244.2587787054, 149357.0, 149629.0, 149644.0, 60070.0, 61379.386206137366, 61403.692981534805, 61444.69277653672, 61491.38508614946, 1272.26844564374, 1392.4778208171936, 1416.199847086393, 1442.8485009074107, 1455.927203639835, 33536.0, 34986.300273994886, 35389.115272118404, 35399.115022123624, 35772.4634130483, 53158.0, 57382.42617573771, 58547.4145258542, 58747.70626146842, 64810.0, 361215.0, 363031.0, 363203.0, 365825.0, 366464.0, 25420.49159016846, 28349.0, 28790.42419151647, 28838.567421488275, 29150.27124321909, 50552.0, 50652.24021639752, 50654.49345506498, 51172.0, 51662.74168629283, 41514.37728434136, 42756.786216069966, 42933.0, 43458.348124778786, 43867.0, 42748.358774619024, 42758.57241427546, 43667.56332436762, 43681.34477982769, 44142.33786493269, 43129.56870431256, 43473.130537389705, 43506.34740478832, 44109.11781764282, 44412.77793611141, 35560.82219588989, 36229.27541449209, 36885.63114368822, 37182.0, 37193.628063719014, 28378.612903066118, 28570.714292856806, 28689.28276793097, 29326.56010159892, 29429.705702942698], "value": 19818.632645993694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.142172906522, 412.67398754983566, 414.1117303384241, 414.2026598797315, 426.53294642366615, 11570.826437603442, 12088.093392995539, 18371.173297201625, 20224.39326820196, 20321.085551150198, 20608.38174854753, 20856.957152142408, 21312.786872131273, 21364.679529807065, 21577.0, 6158.076288556707, 6215.098810672461, 6443.967780161092, 6448.742495213435, 6448.871022579546, 6132.4480796728285, 6356.300806911236, 6369.585976911486, 6389.137466442017, 6395.616263024233, 6301.275353334357, 6351.809445716636, 6384.936150638504, 6390.904136437957, 6393.392627700361, 6115.113308570255, 6351.9364806351805, 6352.364763523657, 6363.204599425072, 6391.680415979183, 6164.106204600353, 6172.814815555495, 6180.907286390708, 6196.752129914798, 6212.0, 22578.661320080213, 22587.983540740704, 22832.429189270235, 23539.0, 26480.337991550172, 2641.841489510616, 2662.4941261160316, 2794.399204171113, 2805.705400932893, 2837.75879050281, 15952.521424357288, 16519.174041298007, 16576.585585360343, 16602.667946641, 16818.159092045473, 2053.240301088592, 2133.4666333416644, 2246.3485589179118, 2253.425376528991, 2285.931422057324, 92506.53746731291, 92557.5372123135, 93784.0, 93984.53007734986, 95312.0, 16580.4403788959, 18535.88856091156, 18862.49100071991, 19434.514137146685, 19609.705854412194, 32143.35713285721, 32379.0, 32595.0, 32683.40482546918, 32760.180995475304, 10002.649907253211, 10509.9474502627, 10748.140148788078, 10917.836232456519, 10918.344899306067, 8994.415363001384, 9061.77345566366, 9087.36388452802, 9088.136627020422, 9171.862422063674, 8998.79529515273, 9053.502057386775, 9066.727998160066, 9093.727188184233, 9152.176304132527, 3529.505869178317, 3629.9818500907327, 3663.816809159531, 3674.9632503675157, 3697.98305465999, 942.5852624845184, 1005.9899401006043, 1047.4867315015588, 1053.1785207538132, 1088.580896354909, 18903.43289701311, 19958.401247962585, 20125.59748805045, 20294.492637684176, 20318.593628127353, 1022.2231104360591, 1025.3898930136556, 1026.389298367485, 1026.4200726589454, 1048.6329784575337, 10594.993475619804, 11089.667309980714, 11188.104951603853, 11227.831582526269, 11250.606228781953, 409773.0, 410767.0, 412488.0, 421677.0, 433041.0, 65451.0, 84006.0, 88146.55926720325, 89206.0, 89608.5519572411, 906.5240748606902, 924.8843894513186, 963.8361478548663, 990.4404011733347, 1003.8343673293971, 16797.396403557468, 18177.363792267206, 18279.36022239215, 18381.356652517097, 18685.81314186895, 41593.168136636494, 42058.15883682248, 42102.789486053596, 42457.0, 43689.78155109204, 58987.41012589819, 59717.701411492664, 60615.39384606097, 60865.69567152136, 60892.0, 8189.099199088215, 8258.587070646563, 8263.504189748634, 8280.50316980983, 9182.770430739285, 12488.37558122072, 13296.335183240994, 13467.528636497676, 14058.0, 14119.435222591392, 12150.331731754839, 12174.817377739164, 12175.208611440228, 12217.389130543259, 12543.12198146121, 11898.464569094238, 12050.939745301217, 12170.208936419105, 12292.0, 12601.684957876127, 11978.401079945794, 12558.748825023631, 12683.11218214716, 12699.365031748192, 12701.745965080832, 8707.738767836974, 8731.0, 8738.432001919855, 8806.251468625238, 8826.514541700268, 9087.727368178965, 11592.6522204334, 12317.0, 12491.750164996467, 12591.748165036832], "value": 10442.846444258674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.1180512179888, 1589.276879020046, 1598.6882557901208, 1767.6199617082325, 1886.1229528269353, 8875.156860098288, 9318.161365477106, 9345.766355841108, 9676.371035882663, 9696.757581060478, 9388.483633400161, 9608.039196080406, 9610.37532560383, 9612.519374031306, 9618.47098409589, 2151.7955794199524, 2221.9777802221934, 2360.268316821791, 2441.8290719649676, 2481.813863960201, 2488.8631125288102, 2509.3475696318906, 2512.1207577347964, 2512.346789834638, 2514.0446630280558, 2465.926022219336, 2471.7775400213977, 2480.4790993891306, 2488.713797913245, 2491.202815099169, 2069.668852983523, 2322.5587138443643, 2387.546366190427, 2405.482821193452, 2429.1983645396976, 2422.6729391532094, 2437.5612389769835, 2438.0369753947093, 2439.707235131778, 2440.548498527778, 9249.445033297956, 9282.0253873343, 9307.3019523536, 9313.58088885995, 9314.813703725955, 5341.65279256847, 5543.362513310981, 5547.223388725582, 5551.805686800983, 5563.916541251884, 3433.6223015468277, 3467.514547963287, 3507.421275489541, 3550.8934731958084, 3557.0395993081725, 1192.7059140832207, 1209.6975756060986, 1223.4677915106956, 1237.919535230216, 1254.7741406546818, 13351.599452016455, 13402.195868247838, 13406.530771422953, 13415.731685366336, 13428.395722192525, 5027.974860125676, 5057.797688092509, 5069.239614057921, 5095.0828850806465, 5162.793488260502, 10952.726181845359, 10996.23026388145, 11000.22998390121, 11010.889891100986, 11013.724656883642, 5662.631928924689, 5667.801626943037, 5704.8859022819315, 5712.057510510802, 5712.6001179917, 4563.247064234431, 4692.483826779052, 5121.3854337479, 5121.974390128025, 5207.921881171786, 4197.265478541243, 4207.200631879933, 4298.247806633826, 4331.155424692155, 4368.4321038264825, 1355.5255660518937, 1382.4332023870165, 1385.757492438819, 1390.652336915771, 1391.749485092693, 1044.4046893270763, 1057.5505410200633, 1060.7772367802847, 1066.461436974323, 1073.2701762801214, 6246.656433896179, 6384.0, 6425.164728585348, 6471.352864713585, 6551.0, 992.8510723391405, 1048.046277887119, 1053.6206965492418, 1056.7833594113188, 1087.488880226308, 4337.110892267077, 4415.094905544356, 4417.668674849399, 4426.313921342197, 4435.733855968652, 11706.70733231676, 12101.576444824565, 12105.970992465564, 12116.27302361861, 12124.939375303244, 11165.27425717342, 11675.0, 11676.299422034705, 12003.219790713576, 12065.758684826254, 8588.184122508352, 8769.0, 8793.780155496035, 8798.340124490689, 8808.867866982, 6086.878262434638, 6215.34738852414, 6342.587731797418, 6363.0, 6416.871662566816, 10201.642942496977, 10205.540750666387, 10234.232432567736, 10321.535530901278, 10689.931006899247, 11161.609343672932, 11166.776664466503, 11210.607628732956, 11267.154963377616, 11279.436028198394, 7336.523125996793, 7412.6664300107705, 8179.10029896699, 8243.958780206061, 8425.87361189595, 9188.678396256098, 9215.76960575991, 9231.58457869411, 9300.20948219409, 9311.580978855833, 7954.642041108048, 8029.959850200712, 8031.718889839061, 8075.555844428378, 8255.958720206361, 8039.557824319719, 8104.0, 8143.144969778088, 8228.547429891414, 8268.875966860622, 7064.15230172362, 7070.222275549582, 7153.141623005273, 7196.96401517989, 7200.71197152108, 5223.947402448874, 5298.761555729924, 5383.434739352311, 5391.0, 5429.212764149255, 5212.895742085213, 5237.16205407133, 5243.017592684745, 5308.309919710413, 5359.222912677717], "value": 4935.454553018632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.84505127641285, 338.67994744966, 346.85778830679413, 349.994750078749, 353.4892080943038, 5394.568434525234, 5418.756155972976, 5438.592105592082, 5439.48324909133, 5471.097268950618, 5312.60155488338, 5381.246625472437, 5381.300430943981, 5381.569474442045, 5418.5369950113545, 3925.3523168677134, 4181.268278051344, 4194.538600753915, 4226.53508114108, 4247.171801498709, 4139.648129908961, 4148.647364973981, 4157.085441202946, 4160.979195104021, 4162.708610397273, 3892.4161375793715, 4105.651019663317, 4114.691398145136, 4118.176364727052, 4127.731697439657, 3918.196769662227, 4055.4930633670792, 4078.062045729469, 4087.8773636790943, 4092.5498195198506, 3574.7318951078514, 3576.8390422431053, 3585.748997570171, 3588.22853086585, 3596.5684117905757, 4927.6550641455115, 5045.4702256262935, 5122.385313762373, 5136.330692524944, 5165.457626949154, 4714.363560919266, 4724.669273150881, 4727.550882666142, 4732.574068333832, 4734.502877197913, 5590.552755779528, 5599.32808063031, 5602.635828671123, 5606.943930560683, 5608.943910560883, 3942.250972315251, 3992.5208974923194, 3997.2804895118866, 4013.779242141681, 4050.5949405059555, 5712.057510510761, 5756.539476841843, 5776.59563830532, 5788.7684492620665, 5807.506361959238, 4115.238680843993, 4126.0, 4127.8968025799595, 4128.6284234419045, 4149.688773342012, 3985.6412922837085, 4110.23960567296, 4150.91698166041, 4182.142660754538, 4188.183304255702, 4688.874670079224, 4715.0805592909055, 4717.268823332389, 4725.69282996611, 4744.478107408182, 5583.860403489945, 5584.301962254718, 5599.8880022400135, 5638.295213098363, 5674.375818659944, 1376.9311534423239, 1435.117402797293, 1448.160067161044, 1448.217962300346, 1452.716720239543, 930.1256818590504, 935.2845073518764, 949.9857502137473, 950.3252690589759, 951.8952915179325, 4855.830045948375, 4931.408231012301, 4956.21576232556, 4971.850844474671, 4977.0884032841195, 5082.74586270685, 5090.847274581768, 5142.382914050263, 5154.871128221749, 5159.509846564571, 5156.0, 5156.607715916682, 5402.594805389612, 5422.295101636762, 5429.755660995264, 3004.173852190665, 3039.042701549005, 3040.559118927743, 3055.7860949733304, 3066.9233269168003, 5793.797217097382, 5895.115732640053, 5898.997170481029, 6020.1036673447725, 6032.939670603326, 5816.912746308809, 5849.2103566018895, 5861.0, 5936.287645482484, 5947.316058653224, 5895.0, 5908.0, 5955.642661440327, 5973.970130149409, 5984.31180414258, 5475.589330800286, 5807.361190268983, 5815.04051831443, 5836.766529338779, 5838.591298609226, 5736.68448235351, 5737.540996720336, 5747.241324164341, 5749.913751293818, 5769.451902069297, 5734.283214598176, 5930.703464826827, 5985.396352586638, 6022.849428764316, 6026.306974697791, 4205.642520385679, 4216.494020717533, 4227.577242275871, 4260.8721738347895, 4261.126469073894, 5794.246747922743, 5869.826034793144, 5879.353271140257, 5880.059190529495, 5901.852453688693, 5387.568994480511, 5644.3508996465935, 5660.405657405913, 5678.488935995781, 5732.111522713986, 5582.804601838916, 5643.266375371176, 5650.180723795109, 5703.258576385043, 5710.971445142914, 5302.734863256745, 5461.180822876441, 5533.197686335539, 5574.581906357121, 5588.441155884379, 5703.743331550173, 5710.143478478261, 5726.284214473191, 5739.598228123991, 5744.942550574441, 5365.436629154039, 5552.611317207757, 5570.721463926869, 5587.273654424899, 5599.440055994531], "value": 4257.51565656279, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8137965508627, 754.2947344233143, 755.5164694595456, 801.4510060608483, 891.1355984694845, 12549.247045177284, 13097.279649619291, 13148.408321625526, 13173.209607423561, 13221.206727596338, 14168.574942751708, 14508.05697629656, 14703.485378011772, 14717.264136793145, 14745.631359216024, 693.5110746923432, 842.334555700997, 846.0693237438829, 857.0443954990203, 857.1642648417806, 814.6944895664126, 854.4147259127486, 855.8630619100945, 858.8239410920778, 859.4413631139747, 878.8593824988003, 879.5514287713248, 880.8898887639045, 883.244825674049, 884.4251236696167, 726.4007194064865, 750.0549307872066, 887.6582515731425, 890.5102193793421, 891.0999890111002, 548.2434240747742, 612.9478994285491, 639.7089324357406, 639.7824739588563, 641.0288413054227, 14396.928015359961, 14415.207163605997, 14419.35112919921, 14425.134491930517, 14433.639159021108, 13286.26925519096, 13373.264470454122, 13555.051146419755, 13725.725485490235, 13729.45082196711, 11789.941050294694, 12397.566085186974, 12501.310436063237, 12604.495820167182, 12900.419481123372, 4421.07157496926, 4470.687051906368, 4502.144592527409, 4505.864824055284, 4623.884402889921, 55362.0, 55746.44253557493, 56813.431865681225, 56885.0, 56955.43044569584, 10024.899751002396, 10213.932423574275, 10244.231682623833, 10337.844932326021, 10373.740656483647, 19148.808511914704, 19212.71180932259, 19233.90383048076, 19240.615187696447, 19340.903295483433, 8167.224113709188, 8180.836383272302, 8218.209696770598, 8248.52437404493, 8284.0, 4801.0, 4844.2007068833245, 4852.296417019583, 4897.681650692693, 5010.0, 3468.5490886184634, 3669.3028324618235, 3685.631436856293, 3690.5202323698286, 3709.0727318170457, 674.4065222604077, 692.7436848366136, 711.7651175112304, 712.6009434716575, 715.5635062611802, 729.7347006745564, 743.108270075911, 752.7779305104898, 755.8979537762442, 765.9004329437249, 10062.345947513388, 10293.869194915567, 10543.736406589896, 10621.2034097443, 10864.0, 649.389573800626, 673.5554534007531, 715.599264411931, 768.1895600141904, 780.9765707028798, 4649.16443933756, 4659.138059459011, 4737.786799594027, 4844.2007068833245, 4911.656184067081, 70220.2977970224, 70518.0, 70702.0, 70972.64513677398, 71111.2888871115, 63474.682626586575, 65316.0, 65898.67050664716, 66130.0, 66318.0, 58491.122633160536, 58518.707406463545, 59456.0, 60248.69875650594, 60303.09545356911, 9463.479508626817, 9525.285603579621, 9543.18882894934, 9581.904180958101, 9584.185344245538, 37680.0, 38922.6107738919, 39723.40414893837, 39757.60242397655, 40658.39012414757, 48457.515424845304, 52647.47352526426, 52964.73517632387, 53610.73194634002, 53986.73006634942, 11040.834387484354, 11099.72250693739, 11116.666500005012, 11427.771444571228, 11692.824607631062, 12957.22256664603, 13053.412596433373, 13314.600561983156, 13334.33328333599, 13425.0, 12108.273503589813, 12342.321172335607, 12587.307698076695, 12968.351582420653, 13336.466541338237, 12310.384480776105, 12998.220106793622, 13015.609531714064, 13260.668483287609, 14031.719365612835, 12513.249205047727, 12658.367081646065, 12736.872631273569, 13385.799213011618, 13636.318184090955, 11345.319280843176, 11438.714032149262, 11525.711857203301, 11735.354555499529, 11741.823872641746, 11424.771504569695, 11448.771024579295, 11731.178817482694, 11743.941280293544, 11747.706307342385], "value": 7064.532175066129, "unit": "score"}], "name": "dromaeo_css", "value": 7402.963201023572, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 108.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 152.0, 212.0, 123.0, 151.0, 150.0, 128.0, 178.0, 122.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 159.0, 159.0, 161.0, 161.0, 159.0, 162.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 151.0, 75.0, 74.0, 76.0, 74.0, 130.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 146.0, 92.0, 92.0, 92.0, 124.0, 92.0, 91.0, 133.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 144.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 54.0, 54.0, 54.0, 53.0, 108.0, 52.0, 52.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 77.0, 78.0, 77.0, 77.0, 79.0, 79.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 115.0, 124.0, 119.0, 124.0, 117.0, 197.0, 123.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 163.0, 167.0, 161.0, 164.0, 163.0, 163.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 62.0, 68.0, 62.0, 62.0, 61.0, 63.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1514.5, "alertThreshold": 2.0}]} 17:56:46 INFO - Return code: 0 17:56:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:56:46 ERROR - # TBPL SUCCESS # 17:56:46 INFO - Running post-action listener: _resource_record_post_action 17:56:46 INFO - ##### 17:56:46 INFO - ##### Finished run-tests step (success) 17:56:46 INFO - ##### 17:56:46 INFO - Running post-run listener: _resource_record_post_run 17:56:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537350144; Read time: 20; Write time: 626016 17:56:46 INFO - TinderboxPrint: CPU usage
13.1% 17:56:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 17:56:46 INFO - TinderboxPrint: I/O write bytes / time
537,350,144 / 626,016 17:56:46 INFO - TinderboxPrint: CPU idle
8,279.3 (86.9%) 17:56:46 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 17:56:46 INFO - TinderboxPrint: Swap in / out
0 / 0 17:56:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252907520; Read time: 0; Write time: 293552 17:56:46 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284442624; Read time: 20; Write time: 332464 17:56:47 INFO - Running post-run listener: _upload_blobber_files 17:56:47 INFO - Blob upload gear active. 17:56:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:47 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 17:56:47 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:47 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:47 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:52 INFO - (blobuploader) - INFO - Done attempting. 17:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:52 INFO - (blobuploader) - INFO - Done attempting. 17:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:53 INFO - (blobuploader) - INFO - Done attempting. 17:56:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:53 INFO - Return code: 0 17:56:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13f0979bc6b75991c0be2b8738d1ed6d5d5cf4f85839f753a36f9b6a37a49c9119758bad8d615aa958c80950952de007341114a98bd29b35d8d226b1de04c228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d6b3e27502c96c66286d9d9be6971ece5907ee46b4a102468e66a5373b82e3af9defae00e6d2664d8e50b79ce5a2b9aea54b0132511913159ff42b840096ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb86f5f8abdf1d10fce73e38ab367197c44a466c59ea41fc83f3997e08f1af0bc8285875bbcc9be8e094248da6c1b26fa73feecac543249be453c27925f962c7"} 17:56:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:53 INFO - Contents: 17:56:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13f0979bc6b75991c0be2b8738d1ed6d5d5cf4f85839f753a36f9b6a37a49c9119758bad8d615aa958c80950952de007341114a98bd29b35d8d226b1de04c228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d6b3e27502c96c66286d9d9be6971ece5907ee46b4a102468e66a5373b82e3af9defae00e6d2664d8e50b79ce5a2b9aea54b0132511913159ff42b840096ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb86f5f8abdf1d10fce73e38ab367197c44a466c59ea41fc83f3997e08f1af0bc8285875bbcc9be8e094248da6c1b26fa73feecac543249be453c27925f962c7"} 17:56:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:53 INFO - Copying logs to upload dir... 17:56:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.488815 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-17 17:56:53.482971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 17:56:53.486198) ========= 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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13f0979bc6b75991c0be2b8738d1ed6d5d5cf4f85839f753a36f9b6a37a49c9119758bad8d615aa958c80950952de007341114a98bd29b35d8d226b1de04c228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d6b3e27502c96c66286d9d9be6971ece5907ee46b4a102468e66a5373b82e3af9defae00e6d2664d8e50b79ce5a2b9aea54b0132511913159ff42b840096ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb86f5f8abdf1d10fce73e38ab367197c44a466c59ea41fc83f3997e08f1af0bc8285875bbcc9be8e094248da6c1b26fa73feecac543249be453c27925f962c7"} build_url:https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/Y68P-li6TR2ycCC4hmf81Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13f0979bc6b75991c0be2b8738d1ed6d5d5cf4f85839f753a36f9b6a37a49c9119758bad8d615aa958c80950952de007341114a98bd29b35d8d226b1de04c228", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d6b3e27502c96c66286d9d9be6971ece5907ee46b4a102468e66a5373b82e3af9defae00e6d2664d8e50b79ce5a2b9aea54b0132511913159ff42b840096ec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb86f5f8abdf1d10fce73e38ab367197c44a466c59ea41fc83f3997e08f1af0bc8285875bbcc9be8e094248da6c1b26fa73feecac543249be453c27925f962c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 17:56:53.512694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:56:53.513437) ========= 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=fa44defc139c4ba8574fe040000001db-1463531774.851483-364921667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 17:56:53.594606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 17:56:53.595018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 17:56:53.595393) ========= ========= Total master_lag: 0.17 =========