builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1464265157.86 results: success (0) buildid: 20160526023003 builduid: ef97d721cf714cae9c4890c89d04cde6 revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:17.861207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:17.861642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:17.861949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:17.907415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:17.907731) ========= 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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 05:19:18-- 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% 15.3M=0.001s 2016-05-26 05:19:18 (15.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179414 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.137773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.138066) ========= 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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.121064 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.271275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.271646) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebf96465a8de20345f7b8d176d827ec538ecbd09 --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 ebf96465a8de20345f7b8d176d827ec538ecbd09 --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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 05:19:18,353 truncating revision to first 12 chars 2016-05-26 05:19:18,353 Setting DEBUG logging. 2016-05-26 05:19:18,353 attempt 1/10 2016-05-26 05:19:18,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebf96465a8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 05:19:18,662 unpacking tar archive at: fx-team-ebf96465a8de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.929849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.930163) ========= script_repo_revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.930635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.930909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:19:18.939356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-26 05:19:18.939700) ========= /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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:19 INFO - MultiFileLogger online at 20160526 05:19:19 in /builds/slave/test 05:19:19 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 05:19:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:19 INFO - {'append_to_log': False, 05:19:19 INFO - 'base_work_dir': '/builds/slave/test', 05:19:19 INFO - 'blob_upload_branch': 'Fx-Team', 05:19:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:19 INFO - 'branch': 'Fx-Team', 05:19:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:19 INFO - 'config_files': ('talos/linux_config.py',), 05:19:19 INFO - 'default_actions': ('clobber', 05:19:19 INFO - 'read-buildbot-config', 05:19:19 INFO - 'download-and-extract', 05:19:19 INFO - 'populate-webroot', 05:19:19 INFO - 'create-virtualenv', 05:19:19 INFO - 'install', 05:19:19 INFO - 'run-tests'), 05:19:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:19 INFO - 'download_minidump_stackwalk': True, 05:19:19 INFO - 'download_symbols': 'ondemand', 05:19:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:19 INFO - 'installer_path': 'installer.exe', 05:19:19 INFO - 'log_level': 'info', 05:19:19 INFO - 'log_name': 'talos', 05:19:19 INFO - 'log_to_console': True, 05:19:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:19 INFO - 'opt_config_files': (), 05:19:19 INFO - 'pip_index': False, 05:19:19 INFO - 'sps_profile': False, 05:19:19 INFO - 'sps_profile_interval': 0, 05:19:19 INFO - 'suite': 'dromaeojs', 05:19:19 INFO - 'system_bits': '32', 05:19:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:19 INFO - 'title': 'talos-linux64-ix-044', 05:19:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:19 INFO - 'use_talos_json': True, 05:19:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:19 INFO - 'work_dir': 'build'} 05:19:19 INFO - ##### 05:19:19 INFO - ##### Running clobber step. 05:19:19 INFO - ##### 05:19:19 INFO - Running pre-action listener: _resource_record_pre_action 05:19:19 INFO - Running main action method: clobber 05:19:19 INFO - rmtree: /builds/slave/test/build 05:19:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:21 INFO - Running post-action listener: _resource_record_post_action 05:19:21 INFO - ##### 05:19:21 INFO - ##### Finished clobber step (success) 05:19:21 INFO - ##### 05:19:21 INFO - ##### 05:19:21 INFO - ##### Running read-buildbot-config step. 05:19:21 INFO - ##### 05:19:21 INFO - Running pre-action listener: _resource_record_pre_action 05:19:21 INFO - Running main action method: read_buildbot_config 05:19:21 INFO - Using buildbot properties: 05:19:21 INFO - { 05:19:21 INFO - "project": "", 05:19:21 INFO - "product": "firefox", 05:19:21 INFO - "script_repo_revision": "production", 05:19:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:19:21 INFO - "repository": "", 05:19:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:19:21 INFO - "buildid": "20160526023003", 05:19:21 INFO - "pgo_build": "True", 05:19:21 INFO - "basedir": "/builds/slave/test", 05:19:21 INFO - "buildnumber": 130, 05:19:21 INFO - "slavename": "talos-linux64-ix-044", 05:19:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:19:21 INFO - "platform": "ubuntu64_hw", 05:19:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:19:21 INFO - "branch": "fx-team", 05:19:21 INFO - "repo_path": "integration/fx-team", 05:19:21 INFO - "revision": "ebf96465a8de20345f7b8d176d827ec538ecbd09", 05:19:21 INFO - "stage_platform": "linux64-pgo", 05:19:21 INFO - "builduid": "ef97d721cf714cae9c4890c89d04cde6", 05:19:21 INFO - "slavebuilddir": "test" 05:19:21 INFO - } 05:19:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:19:21 INFO - Running post-action listener: _resource_record_post_action 05:19:21 INFO - ##### 05:19:21 INFO - ##### Finished read-buildbot-config step (success) 05:19:21 INFO - ##### 05:19:21 INFO - ##### 05:19:21 INFO - ##### Running download-and-extract step. 05:19:21 INFO - ##### 05:19:21 INFO - Running pre-action listener: _resource_record_pre_action 05:19:21 INFO - Running main action method: download_and_extract 05:19:21 INFO - mkdir: /builds/slave/test/build/tests 05:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:21 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:23 INFO - Downloaded 1361 bytes. 05:19:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:19:23 INFO - Using the following test package requirements: 05:19:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:19:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:19:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'jsshell-linux-x86_64.zip'], 05:19:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:19:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:19:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:19:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:19:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:19:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:19: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')]} 05:19:23 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:34 INFO - Downloaded 24408666 bytes. 05:19:34 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'] 05:19:34 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 05:19:36 INFO - Return code: 0 05:19:36 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 05:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:36 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:40 INFO - Downloaded 24408666 bytes. 05:19:40 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'] 05:19:40 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 05:19:41 INFO - Return code: 0 05:19: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')]} 05:19:41 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:42 INFO - Downloaded 10834034 bytes. 05:19:42 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'] 05:19:42 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 05:19:42 INFO - Return code: 0 05:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:42 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:19:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:19:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:19:44 INFO - Downloaded 58668691 bytes. 05:19:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:19:44 INFO - mkdir: /builds/slave/test/properties 05:19:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:44 INFO - Contents: 05:19:44 INFO - build_url:https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:19:44 INFO - Running post-action listener: _resource_record_post_action 05:19:44 INFO - Running post-action listener: set_extra_try_arguments 05:19:44 INFO - ##### 05:19:44 INFO - ##### Finished download-and-extract step (success) 05:19:44 INFO - ##### 05:19:44 INFO - ##### 05:19:44 INFO - ##### Running populate-webroot step. 05:19:44 INFO - ##### 05:19:44 INFO - Running pre-action listener: _resource_record_pre_action 05:19:44 INFO - Running main action method: populate_webroot 05:19:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:45 INFO - '--tppagecycles', 05:19:45 INFO - '7'], 05:19:45 INFO - 'tests': ['tsvgm']}}, 05:19:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:19:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:19:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:19:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['damp', 'tps']}, 05:19:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'tests': ['damp', 'tps']}, 05:19:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['dromaeo_dom']}, 05:19:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'other-e10s': {'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['a11yr', 05:19:45 INFO - 'ts_paint', 05:19:45 INFO - 'tpaint', 05:19:45 INFO - 'sessionrestore', 05:19:45 INFO - 'sessionrestore_no_auto_restore', 05:19:45 INFO - 'tabpaint']}, 05:19:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['tsvgx', 05:19:45 INFO - 'tsvgr_opacity', 05:19:45 INFO - 'tart', 05:19:45 INFO - 'tscrollx', 05:19:45 INFO - 'cart']}, 05:19:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:19:45 INFO - 'tsvgr_opacity', 05:19:45 INFO - 'tart', 05:19:45 INFO - 'tscrollx', 05:19:45 INFO - 'cart']}, 05:19:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'talos_options': ['--disable-e10s'], 05:19:45 INFO - 'tests': ['tp5o']}, 05:19:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'tests': ['tp5o']}, 05:19:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'talos_options': ['--disable-e10s', 05:19:45 INFO - '--xperf_path', 05:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:45 INFO - 'tests': ['tp5n']}, 05:19:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:45 INFO - 'talos_options': ['--xperf_path', 05:19:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:45 INFO - 'tests': ['tp5n']}}, 05:19:45 INFO - 'talos.zip': {'path': '', 05:19:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:45 INFO - Running post-action listener: _resource_record_post_action 05:19:45 INFO - ##### 05:19:45 INFO - ##### Finished populate-webroot step (success) 05:19:45 INFO - ##### 05:19:45 INFO - ##### 05:19:45 INFO - ##### Running create-virtualenv step. 05:19:45 INFO - ##### 05:19:45 INFO - Running pre-action listener: _resource_record_pre_action 05:19:45 INFO - Running main action method: create_virtualenv 05:19:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:45 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 05:19:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:45 INFO - Using real prefix '/usr' 05:19:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:48 INFO - Installing pip.................done. 05:19:48 INFO - Return code: 0 05:19:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:19: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', 'pip>=1.5'] in /builds/slave/test/build 05:19: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 pip>=1.5 05:19:48 INFO - Using env: {'DISPLAY': ':0', 05:19:48 INFO - 'HOME': '/home/cltbld', 05:19:48 INFO - 'LANG': 'en_US.UTF-8', 05:19:48 INFO - 'LANGUAGE': 'en_US:en', 05:19:48 INFO - 'LOGNAME': 'cltbld', 05:19:48 INFO - 'MAIL': '/var/mail/cltbld', 05:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:48 INFO - 'MOZ_NO_REMOTE': '1', 05:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:48 INFO - 'NO_EM_RESTART': '1', 05:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:48 INFO - 'PWD': '/builds/slave/test', 05:19:48 INFO - 'SHELL': '/bin/bash', 05:19:48 INFO - 'SHLVL': '1', 05:19:48 INFO - 'TERM': 'linux', 05:19:48 INFO - 'TMOUT': '86400', 05:19:48 INFO - 'USER': 'cltbld', 05:19:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:48 INFO - '_': '/tools/buildbot/bin/python'} 05:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:48 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 05:19:48 INFO - Cleaning up... 05:19:48 INFO - Return code: 0 05:19:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:19: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')]} 05:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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', '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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:19: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:19: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 psutil>=3.1.1 05:19:48 INFO - Using env: {'DISPLAY': ':0', 05:19:48 INFO - 'HOME': '/home/cltbld', 05:19:48 INFO - 'LANG': 'en_US.UTF-8', 05:19:48 INFO - 'LANGUAGE': 'en_US:en', 05:19:48 INFO - 'LOGNAME': 'cltbld', 05:19:48 INFO - 'MAIL': '/var/mail/cltbld', 05:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:48 INFO - 'MOZ_NO_REMOTE': '1', 05:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:48 INFO - 'NO_EM_RESTART': '1', 05:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:48 INFO - 'PWD': '/builds/slave/test', 05:19:48 INFO - 'SHELL': '/bin/bash', 05:19:48 INFO - 'SHLVL': '1', 05:19:48 INFO - 'TERM': 'linux', 05:19:48 INFO - 'TMOUT': '86400', 05:19:48 INFO - 'USER': 'cltbld', 05:19:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:48 INFO - '_': '/tools/buildbot/bin/python'} 05:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:48 INFO - Downloading/unpacking psutil>=3.1.1 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:51 INFO - Installing collected packages: psutil 05:19:51 INFO - Running setup.py install for psutil 05:19:51 INFO - building 'psutil._psutil_linux' extension 05:19:51 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 05:19:52 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 05:19:52 INFO - building 'psutil._psutil_posix' extension 05:19:52 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 05:19:52 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 05:19:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:52 INFO - Successfully installed psutil 05:19:52 INFO - Cleaning up... 05:19:52 INFO - Return code: 0 05:19:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:19:52 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')]} 05:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:52 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')]} 05:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:52 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:19:52 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 05:19:52 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 05:19:52 INFO - Using env: {'DISPLAY': ':0', 05:19:52 INFO - 'HOME': '/home/cltbld', 05:19:52 INFO - 'LANG': 'en_US.UTF-8', 05:19:52 INFO - 'LANGUAGE': 'en_US:en', 05:19:52 INFO - 'LOGNAME': 'cltbld', 05:19:52 INFO - 'MAIL': '/var/mail/cltbld', 05:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:52 INFO - 'MOZ_NO_REMOTE': '1', 05:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:52 INFO - 'NO_EM_RESTART': '1', 05:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:52 INFO - 'PWD': '/builds/slave/test', 05:19:52 INFO - 'SHELL': '/bin/bash', 05:19:52 INFO - 'SHLVL': '1', 05:19:52 INFO - 'TERM': 'linux', 05:19:52 INFO - 'TMOUT': '86400', 05:19:52 INFO - 'USER': 'cltbld', 05:19:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:52 INFO - '_': '/tools/buildbot/bin/python'} 05:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:19:52 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 05:19:52 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 05:19:52 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 05:19:52 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 05:19:52 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 05:19:52 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 05:19:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:19:54 INFO - Installing collected packages: mozsystemmonitor 05:19:54 INFO - Running setup.py install for mozsystemmonitor 05:19:54 INFO - Successfully installed mozsystemmonitor 05:19:54 INFO - Cleaning up... 05:19:54 INFO - Return code: 0 05:19:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:54 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:19:54 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 05:19:54 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 05:19:54 INFO - Using env: {'DISPLAY': ':0', 05:19:54 INFO - 'HOME': '/home/cltbld', 05:19:54 INFO - 'LANG': 'en_US.UTF-8', 05:19:54 INFO - 'LANGUAGE': 'en_US:en', 05:19:54 INFO - 'LOGNAME': 'cltbld', 05:19:54 INFO - 'MAIL': '/var/mail/cltbld', 05:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:54 INFO - 'MOZ_NO_REMOTE': '1', 05:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:54 INFO - 'NO_EM_RESTART': '1', 05:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:54 INFO - 'PWD': '/builds/slave/test', 05:19:54 INFO - 'SHELL': '/bin/bash', 05:19:54 INFO - 'SHLVL': '1', 05:19:54 INFO - 'TERM': 'linux', 05:19:54 INFO - 'TMOUT': '86400', 05:19:54 INFO - 'USER': 'cltbld', 05:19:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:54 INFO - '_': '/tools/buildbot/bin/python'} 05:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:55 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 05:19:55 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 05:19:55 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 05:19:55 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 05:19:55 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 05:19:55 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 05:19:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:19:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 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 05:19:57 INFO - Downloading docopt-0.6.1.tar.gz 05:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:58 INFO - Running setup.py install for blobuploader 05:19:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:19:58 INFO - Running setup.py install for requests 05:19:58 INFO - Running setup.py install for docopt 05:19:58 INFO - Successfully installed blobuploader requests docopt 05:19:58 INFO - Cleaning up... 05:19:58 INFO - Return code: 0 05:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:58 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')]} 05:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:58 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')]} 05:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:58 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:19:58 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 05:19:58 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 05:19:58 INFO - Using env: {'DISPLAY': ':0', 05:19:58 INFO - 'HOME': '/home/cltbld', 05:19:58 INFO - 'LANG': 'en_US.UTF-8', 05:19:58 INFO - 'LANGUAGE': 'en_US:en', 05:19:58 INFO - 'LOGNAME': 'cltbld', 05:19:58 INFO - 'MAIL': '/var/mail/cltbld', 05:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:58 INFO - 'MOZ_NO_REMOTE': '1', 05:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:58 INFO - 'NO_EM_RESTART': '1', 05:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:58 INFO - 'PWD': '/builds/slave/test', 05:19:58 INFO - 'SHELL': '/bin/bash', 05:19:58 INFO - 'SHLVL': '1', 05:19:58 INFO - 'TERM': 'linux', 05:19:58 INFO - 'TMOUT': '86400', 05:19:58 INFO - 'USER': 'cltbld', 05:19:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:58 INFO - '_': '/tools/buildbot/bin/python'} 05:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:58 INFO - Running setup.py (path:/tmp/pip-c0hMN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:58 INFO - Running setup.py (path:/tmp/pip-qitYHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:59 INFO - Running setup.py (path:/tmp/pip-PG6cGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:59 INFO - Running setup.py (path:/tmp/pip-x_UBx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:59 INFO - Running setup.py (path:/tmp/pip-2AejnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:59 INFO - Running setup.py (path:/tmp/pip-3SFMBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:59 INFO - Running setup.py (path:/tmp/pip-ZvKwHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:59 INFO - Running setup.py (path:/tmp/pip-_T2ZJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:59 INFO - Running setup.py (path:/tmp/pip-GPmUGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:59 INFO - Running setup.py (path:/tmp/pip-8yWUxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:59 INFO - Running setup.py (path:/tmp/pip-86yHFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:59 INFO - Running setup.py (path:/tmp/pip-cSpJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:59 INFO - Running setup.py (path:/tmp/pip-THftqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:59 INFO - Running setup.py (path:/tmp/pip-WLLSmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:59 INFO - Running setup.py (path:/tmp/pip-mfTWKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:59 INFO - Running setup.py (path:/tmp/pip-PjxfIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:00 INFO - Running setup.py (path:/tmp/pip-dXnBcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:00 INFO - Running setup.py install for manifestparser 05:20:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Running setup.py install for mozcrash 05:20:00 INFO - Running setup.py install for mozdebug 05:20:00 INFO - Running setup.py install for mozdevice 05:20:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Running setup.py install for mozfile 05:20:00 INFO - Running setup.py install for mozhttpd 05:20:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Running setup.py install for mozinfo 05:20:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Running setup.py install for mozInstall 05:20:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:00 INFO - Running setup.py install for mozleak 05:20:01 INFO - Running setup.py install for mozlog 05:20:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Running setup.py install for moznetwork 05:20:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Running setup.py install for mozprocess 05:20:01 INFO - Running setup.py install for mozprofile 05:20:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Running setup.py install for mozrunner 05:20:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Running setup.py install for mozscreenshot 05:20:01 INFO - Running setup.py install for moztest 05:20:01 INFO - Running setup.py install for mozversion 05:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:01 INFO - Cleaning up... 05:20:01 INFO - Return code: 0 05:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:01 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')]} 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 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')]} 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:20:01 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 05:20:01 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 05:20:01 INFO - Using env: {'DISPLAY': ':0', 05:20:01 INFO - 'HOME': '/home/cltbld', 05:20:01 INFO - 'LANG': 'en_US.UTF-8', 05:20:01 INFO - 'LANGUAGE': 'en_US:en', 05:20:01 INFO - 'LOGNAME': 'cltbld', 05:20:01 INFO - 'MAIL': '/var/mail/cltbld', 05:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:01 INFO - 'MOZ_NO_REMOTE': '1', 05:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:01 INFO - 'NO_EM_RESTART': '1', 05:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:01 INFO - 'PWD': '/builds/slave/test', 05:20:01 INFO - 'SHELL': '/bin/bash', 05:20:01 INFO - 'SHLVL': '1', 05:20:01 INFO - 'TERM': 'linux', 05:20:01 INFO - 'TMOUT': '86400', 05:20:01 INFO - 'USER': 'cltbld', 05:20:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:01 INFO - '_': '/tools/buildbot/bin/python'} 05:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:02 INFO - Running setup.py (path:/tmp/pip-BLzT72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:02 INFO - Running setup.py (path:/tmp/pip-ef_m87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:02 INFO - Running setup.py (path:/tmp/pip-_mJoSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:02 INFO - Running setup.py (path:/tmp/pip-D3D_MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:02 INFO - Running setup.py (path:/tmp/pip-mJJvhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:02 INFO - Running setup.py (path:/tmp/pip-bhR_Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:02 INFO - Running setup.py (path:/tmp/pip-oRT_Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:02 INFO - Running setup.py (path:/tmp/pip-gPnKRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:02 INFO - Running setup.py (path:/tmp/pip-L4Yhl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:02 INFO - Running setup.py (path:/tmp/pip-jPKL53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:02 INFO - Running setup.py (path:/tmp/pip-kHFDhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:02 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)) 05:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:02 INFO - Running setup.py (path:/tmp/pip-jV5Yq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:03 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)) 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:03 INFO - Running setup.py (path:/tmp/pip-MbvbW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:03 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)) 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:03 INFO - Running setup.py (path:/tmp/pip-2qKgJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:03 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)) 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:03 INFO - Running setup.py (path:/tmp/pip-0ghtV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:03 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)) 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:03 INFO - Running setup.py (path:/tmp/pip-c4UsDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:03 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)) 05:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:03 INFO - Running setup.py (path:/tmp/pip-zG3fC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:03 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)) 05:20:03 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)) 05:20:03 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)) 05:20:03 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)) 05:20:03 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)) 05:20:03 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)) 05:20:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:03 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 05:20:05 INFO - Downloading blessings-1.6.tar.gz 05:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:05 INFO - Installing collected packages: blessings 05:20:05 INFO - Running setup.py install for blessings 05:20:05 INFO - Successfully installed blessings 05:20:05 INFO - Cleaning up... 05:20:05 INFO - Return code: 0 05:20:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:05 INFO - Reading from file tmpfile_stdout 05:20:05 INFO - Current package versions: 05:20:05 INFO - argparse == 1.2.1 05:20:05 INFO - blessings == 1.6 05:20:05 INFO - blobuploader == 1.2.4 05:20:05 INFO - docopt == 0.6.1 05:20:05 INFO - manifestparser == 1.1 05:20:05 INFO - mozInstall == 1.12 05:20:05 INFO - mozcrash == 0.17 05:20:05 INFO - mozdebug == 0.1 05:20:05 INFO - mozdevice == 0.48 05:20:05 INFO - mozfile == 1.2 05:20:05 INFO - mozhttpd == 0.7 05:20:05 INFO - mozinfo == 0.9 05:20:05 INFO - mozleak == 0.1 05:20:05 INFO - mozlog == 3.2 05:20:05 INFO - moznetwork == 0.27 05:20:05 INFO - mozprocess == 0.22 05:20:05 INFO - mozprofile == 0.28 05:20:05 INFO - mozrunner == 6.11 05:20:05 INFO - mozscreenshot == 0.1 05:20:05 INFO - mozsystemmonitor == 0.3 05:20:05 INFO - moztest == 0.7 05:20:05 INFO - mozversion == 1.4 05:20:05 INFO - psutil == 3.1.1 05:20:05 INFO - requests == 1.2.3 05:20:05 INFO - wsgiref == 0.1.2 05:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:05 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')]} 05:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:05 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')]} 05:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:05 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:20:05 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 05:20:05 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 05:20:05 INFO - Using env: {'DISPLAY': ':0', 05:20:05 INFO - 'HOME': '/home/cltbld', 05:20:05 INFO - 'LANG': 'en_US.UTF-8', 05:20:05 INFO - 'LANGUAGE': 'en_US:en', 05:20:05 INFO - 'LOGNAME': 'cltbld', 05:20:05 INFO - 'MAIL': '/var/mail/cltbld', 05:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:05 INFO - 'MOZ_NO_REMOTE': '1', 05:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:05 INFO - 'NO_EM_RESTART': '1', 05:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:05 INFO - 'PWD': '/builds/slave/test', 05:20:05 INFO - 'SHELL': '/bin/bash', 05:20:05 INFO - 'SHLVL': '1', 05:20:05 INFO - 'TERM': 'linux', 05:20:05 INFO - 'TMOUT': '86400', 05:20:05 INFO - 'USER': 'cltbld', 05:20:05 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:05 INFO - '_': '/tools/buildbot/bin/python'} 05:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 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)) 05:20:05 INFO - Cleaning up... 05:20:05 INFO - Return code: 0 05:20:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:05 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')]} 05:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:05 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')]} 05:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:05 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:20:05 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 05:20:05 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 05:20:05 INFO - Using env: {'DISPLAY': ':0', 05:20:05 INFO - 'HOME': '/home/cltbld', 05:20:05 INFO - 'LANG': 'en_US.UTF-8', 05:20:05 INFO - 'LANGUAGE': 'en_US:en', 05:20:05 INFO - 'LOGNAME': 'cltbld', 05:20:05 INFO - 'MAIL': '/var/mail/cltbld', 05:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:05 INFO - 'MOZ_NO_REMOTE': '1', 05:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:05 INFO - 'NO_EM_RESTART': '1', 05:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:05 INFO - 'PWD': '/builds/slave/test', 05:20:05 INFO - 'SHELL': '/bin/bash', 05:20:05 INFO - 'SHLVL': '1', 05:20:05 INFO - 'TERM': 'linux', 05:20:05 INFO - 'TMOUT': '86400', 05:20:05 INFO - 'USER': 'cltbld', 05:20:05 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:05 INFO - '_': '/tools/buildbot/bin/python'} 05:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:06 INFO - Downloading/unpacking jsonschema 05:20:06 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 05:20:06 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 05:20:06 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 05:20:06 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 05:20:06 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 05:20:06 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 05:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:08 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:08 INFO - warning: no files found matching '*.txt' 05:20:08 INFO - no previously-included directories found matching 'build' 05:20:08 INFO - no previously-included directories found matching 'dist' 05:20:08 INFO - no previously-included directories found matching '.git*' 05:20:08 INFO - Installing collected packages: jsonschema, functools32 05:20:08 INFO - Running setup.py install for functools32 05:20:08 INFO - warning: no files found matching '*.txt' 05:20:08 INFO - no previously-included directories found matching 'build' 05:20:08 INFO - no previously-included directories found matching 'dist' 05:20:08 INFO - no previously-included directories found matching '.git*' 05:20:08 INFO - Successfully installed jsonschema functools32 05:20:08 INFO - Cleaning up... 05:20:08 INFO - Return code: 0 05:20:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:08 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 0x7fa455ee4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a06770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, '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': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', '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 05:20:08 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 05:20:08 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 05:20:08 INFO - Using env: {'DISPLAY': ':0', 05:20:08 INFO - 'HOME': '/home/cltbld', 05:20:08 INFO - 'LANG': 'en_US.UTF-8', 05:20:08 INFO - 'LANGUAGE': 'en_US:en', 05:20:08 INFO - 'LOGNAME': 'cltbld', 05:20:08 INFO - 'MAIL': '/var/mail/cltbld', 05:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:08 INFO - 'MOZ_NO_REMOTE': '1', 05:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:08 INFO - 'NO_EM_RESTART': '1', 05:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:08 INFO - 'PWD': '/builds/slave/test', 05:20:08 INFO - 'SHELL': '/bin/bash', 05:20:08 INFO - 'SHLVL': '1', 05:20:08 INFO - 'TERM': 'linux', 05:20:08 INFO - 'TMOUT': '86400', 05:20:08 INFO - 'USER': 'cltbld', 05:20:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:08 INFO - '_': '/tools/buildbot/bin/python'} 05:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:08 INFO - Downloading/unpacking flake8 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:08 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 05:20:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:10 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 05:20:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:11 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 05:20:11 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 05:20:11 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 05:20:11 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 05:20:11 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 05:20:11 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 05:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:11 INFO - no previously-included directories found matching 'docs/_build' 05:20:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:11 INFO - Running setup.py install for pep8 05:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:11 INFO - no previously-included directories found matching 'docs/_build' 05:20:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:11 INFO - Cleaning up... 05:20:11 INFO - Return code: 0 05:20:11 INFO - Running post-action listener: _resource_record_post_action 05:20:11 INFO - Running post-action listener: _start_resource_monitoring 05:20:11 INFO - Starting resource monitoring. 05:20:11 INFO - ##### 05:20:11 INFO - ##### Finished create-virtualenv step (success) 05:20:11 INFO - ##### 05:20:11 INFO - ##### 05:20:11 INFO - ##### Running install step. 05:20:11 INFO - ##### 05:20:11 INFO - Running pre-action listener: _resource_record_pre_action 05:20:11 INFO - Running main action method: install 05:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:11 INFO - Reading from file tmpfile_stdout 05:20:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:12 INFO - Reading from file tmpfile_stdout 05:20:12 INFO - Output received: 05:20:12 INFO - Usage: mozinstall [options] installer 05:20:12 INFO - Options: 05:20:12 INFO - -h, --help show this help message and exit 05:20:12 INFO - -d DEST, --destination=DEST 05:20:12 INFO - Directory to install application into. [default: 05:20:12 INFO - "/builds/slave/test"] 05:20:12 INFO - --app=APP Application being installed. [default: firefox] 05:20:12 INFO - mkdir: /builds/slave/test/build/application 05:20:12 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'] 05:20:12 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 05:20:28 INFO - Reading from file tmpfile_stdout 05:20:28 INFO - Output received: 05:20:28 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:28 INFO - Running post-action listener: _resource_record_post_action 05:20:28 INFO - ##### 05:20:28 INFO - ##### Finished install step (success) 05:20:28 INFO - ##### 05:20:28 INFO - ##### 05:20:28 INFO - ##### Running run-tests step. 05:20:28 INFO - ##### 05:20:28 INFO - Running pre-action listener: _resource_record_pre_action 05:20:28 INFO - Running main action method: run_tests 05:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:28 INFO - Python 2.7.3 05:20:28 INFO - Return code: 0 05:20:28 INFO - grabbing minidump binary from tooltool 05:20:28 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')]} 05:20:28 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 0x2a959c0>, '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 0x2a968c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a96d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:28 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 05:20:28 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 05:20:28 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 05:20:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:28 INFO - Return code: 0 05:20:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:20:29 INFO - Return code: 0 05:20:29 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/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:20:29 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/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:20:29 INFO - Using env: {'DISPLAY': ':0', 05:20:29 INFO - 'HOME': '/home/cltbld', 05:20:29 INFO - 'LANG': 'en_US.UTF-8', 05:20:29 INFO - 'LANGUAGE': 'en_US:en', 05:20:29 INFO - 'LOGNAME': 'cltbld', 05:20:29 INFO - 'MAIL': '/var/mail/cltbld', 05:20:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:29 INFO - 'MOZ_NO_REMOTE': '1', 05:20:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:29 INFO - 'NO_EM_RESTART': '1', 05:20:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:29 INFO - 'PWD': '/builds/slave/test', 05:20:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:29 INFO - 'SHELL': '/bin/bash', 05:20:29 INFO - 'SHLVL': '1', 05:20:29 INFO - 'TERM': 'linux', 05:20:29 INFO - 'TMOUT': '86400', 05:20:29 INFO - 'USER': 'cltbld', 05:20:29 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028', 05:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:29 INFO - '_': '/tools/buildbot/bin/python'} 05:20:29 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/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:20:30 INFO - mozversion application_buildid: 20160526023003 05:20:30 INFO - mozversion application_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 05:20:30 INFO - mozversion application_display_name: Nightly 05:20:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:30 INFO - mozversion application_name: Firefox 05:20:30 INFO - mozversion application_remotingname: firefox 05:20:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:20:30 INFO - mozversion application_vendor: Mozilla 05:20:30 INFO - mozversion application_version: 49.0a1 05:20:30 INFO - mozversion platform_buildid: 20160526023003 05:20:30 INFO - mozversion platform_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 05:20:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:20:30 INFO - mozversion platform_version: 49.0a1 05:20:30 INFO - using testdate: 1464265230 05:20:30 INFO - actual date: 1464265230 05:20:30 INFO - starting webserver on 'localhost:43256' 05:20:30 INFO - SUITE-START | Running 2 tests 05:20:30 INFO - TEST-START | dromaeo_css 05:20:30 INFO - operating with platform_type : linux_ 05:20:30 INFO - Initialising browser for dromaeo_css test... 05:20:30 INFO - TEST-INFO | started process 3349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7meDE/profile http://localhost:43256/getInfo.html) 05:20:34 INFO - PROCESS | 3349 | __metrics Screen width/height:1600/1200 05:20:34 INFO - PROCESS | 3349 | colorDepth:24 05:20:34 INFO - PROCESS | 3349 | Browser inner width/height: 1024/697 05:20:34 INFO - PROCESS | 3349 | __metrics 05:20:37 ERROR - PROCESS | 3349 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:20:37 INFO - TEST-INFO | 3349: exit 0 05:20:37 INFO - Browser initialized. 05:20:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:20:37 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7meDE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:49 INFO - PROCESS | 3433 | RSS: Main: 155336704 05:20:49 INFO - PROCESS | 3433 | 05:21:40 INFO - PROCESS | 3433 | 1464265300647 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] 05:23:48 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43256/tests/dromaeo/cssquery-ext.html) 05:23:49 INFO - PROCESS | 3433 | RSS: Main: 260149248 05:23:49 INFO - PROCESS | 3433 | 05:26:52 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-ext.html (next: http://localhost:43256/tests/dromaeo/cssquery-jquery.html) 05:26:52 INFO - PROCESS | 3433 | RSS: Main: 228765696 05:26:52 INFO - PROCESS | 3433 | 05:29:54 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43256/tests/dromaeo/cssquery-mootools.html) 05:29:55 INFO - PROCESS | 3433 | RSS: Main: 246173696 05:29:55 INFO - PROCESS | 3433 | 05:32:57 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43256/tests/dromaeo/cssquery-prototype.html) 05:32:57 INFO - PROCESS | 3433 | RSS: Main: 239919104 05:32:57 INFO - PROCESS | 3433 | 05:36:00 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43256/tests/dromaeo/cssquery-yui.html) 05:36:01 INFO - PROCESS | 3433 | RSS: Main: 224264192 05:36:01 INFO - PROCESS | 3433 | 05:39:03 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:43256/tests/dromaeo/cssquery-yui.html (next: http://localhost:43256/tests/dromaeo/cssquery-dojo.html) 05:39:04 INFO - PROCESS | 3433 | RSS: Main: 301416448 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | __start_tp_report 05:39:04 INFO - PROCESS | 3433 | _x_x_mozilla_page_load 05:39:04 INFO - PROCESS | 3433 | _x_x_mozilla_page_load_details 05:39:04 INFO - PROCESS | 3433 | |i|pagename|runs| 05:39:04 INFO - PROCESS | 3433 | |0;dojo.html;3114.2370119320753;3116.8285744284067;3135.404273188095;3149.9842500787495;3173.111528771943;5333.066713325172;5369.5704343652515;5407.107827208506;5475.589330800191;5523.613347065712;5457.045017121997;5486.423925487817;5492.093804522259;5504.559635229182;5511.063119269724;4936.111499930011;4946.282788995593;5020.97489512552;5079.288899554065;5104.617153713468;4995.900081998358;4999.250112483121;5020.0963826511215;5046.747662616873;5060.11447996601;4876.634252431082;4916.213405855064;4954.5540901319055;4982.252662100714;4990.326305948705;4989.351384320015;4992.201247800334;5003.974980125113;5006.5494105530315;5045.848624541233;4816.783244753994;4866.148424025817;4949.480304568005;4966.776495057695;5018;5328.387235467932;5457.536109430703;5485.0949593317455;5488.286522752017;5494.1758736189495;5892.852678683067;5922.911156332659;5943;5943.613665111754;5946.286445626509;5644.548436125141;5818.5636077294375;5827.388124246978;5952.434518720715;5988.28140623128;5476.835694929158;5531.640443371209;5542.307211598551;5547.750351234205;5557.722113894289;6017.06735456005;6033.245844269466;6033.841853272682;6078.908816367758;6090.604110732788;5592.804251851166;5686.2039314496005;5715.342735585377;5751.396103409082;5824.534037277008;5881.2942446906645;5899.262592175978;5907.852303692356;5918.171455996164;5918.467337939606;5733.082706766897;5799.18811366409;5800.709964501758;5805.94194058054;5818.0981947798155;5590.217369568264;5809.564282678816;5861.120831875168;5868.589198756132;5939.613925094855;4447.777611119431;4467.664925130628;4470.128324976663;4471.038726673716;4503.662225333113;3865.1110244643887;3967.8412863485137;3974.8608798692485;4014.598540145962;4030.395440683862;5502.697351645618;5524.889502209933;5534.75093620788;5541.473560011793;5580.079286917613;5894.381089985575;5896.262967129109;5896.7936122235515;5901.321348044944;5974.9402505974385;5368.570514358842;5532.889342213214;5537.307836520435;5555;5556.16657501378;5072.847814565569;5118;5118.692878427306;5131.974340128276;5171.4311425743135;6144.2319710036245;6168.444839964335;6174.691265436711;6183.288921774054;6192.164057852222;5687.5734319927;5821.446962538552;5840.357560668408;5981.342052374148;5986.281646202484;6068.575199735976;6079.270487541523;6080.422359875804;6091.786787462417;6126.938730612816;5726.455986681259;5733.111367738007;5746.367899531132;5776.364599893925;5793.652380857162;5724.341700704473;5842.795502157574;5877.4122587740885;5884.499817515559;5898.616589921641;5758.1650660654805;5762.250907382014;5769.480746732815;5770.047942089508;5818.127280907897;5725.828225153252;5725.885482290414;5734.799282025109;5740;5741.483266506035;5433.7554810034435;5493.038718224375;5538.6399884007415;5539.695316757617;5640.633358831663;5708.4862362387585;5710.314762228559;5752.395998420273;5755.5971082025535;5762.5389968801555;5579.6652200868075;5588.385277619377;5591.245181900554;5592.944070559242;5594.216809646571 05:39:04 INFO - PROCESS | 3433 | |1;ext.html;590.0323469510005;619.5136817598185;636.980890573283;647.7927063339731;654.1724718231435;42497.15005699888;43296.567034329644;43491.78254108733;43632.345514817265;47835.52164478363;42832;43284;43372;43404;43406.565934340644;8712.869306960385;8813.911860881406;8861.999999999967;8880.333974951873;8888.244499217575;8732.12678732125;8811.515366654832;8838.072002439747;8839.911600884005;8842.646294148226;8881.822363552725;8883.733487995338;8894.24398926092;8905.732828015138;8938.776530586754;8793.472391656489;8816.69141580048;8851.690190843321;8863.069377715312;8870;8697.652093916236;8785.692500762507;8826.911730882674;8830.86753698695;8835.55822208887;40023;40384.59615403867;40434.39348409776;40447.7977610113;40492.797536012426;3497.1956450016637;3583.516225309576;3649.4708267301094;3747.4191500317493;4051.2100140472326;31312.53031204534;31596.842015790004;31749.523757143663;31769.205769855707;31947.520787188212;4204.642605378546;4229.915401691949;4266.082792199661;4280.293751530994;4302.204092242914;336837;338626;339312;339612;339945;61980.38019619746;62011.37988620056;62648.06027909585;62736.37263627397;62813.68593157005;56974;62096;64755.352446475874;64813.35186648167;64997.67501162464;16087.678246435005;17526.474205773848;17539.649207015787;17552.38566650161;17563.912180439016;12920.612381628565;13300.534481293109;13307.800382994263;13308.600741977756;13313.267770272534;17582;17623.413892749715;19550.511237219183;19978.600427991358;20036.39890803278;6757.560758550777;7129.750458733919;7293.416526677853;7296.941943418175;7570.659320330598;1018.8217062014118;1022.7596514819012;1103.6082190822303;1109.2623405435456;1149.7413082056637;31931.521027184146;32367.838160809515;32451.350972980406;32858.50712239318;33124.834375827966;1052.8789189243182;1085.9674209773718;1152.7348709796627;1179.257068047125;1242.937853107341;17126;17146.142692865305;17309;17377.3049078038;17396.47810565685;577387;582579;582945;584944;586471;56942;57885;58199;58307;58462;1334.7797613393875;1362.8023936529148;1367.1387026173645;1379.7723375643309;1400.6568390744333;30110.397792043597;31733.20666983344;31792.36415271728;31991.360172796878;32547.34905301928;51307.74346128246;51344.48655513397;51436.22845657393;51586.22620660768;51620.22569661383;344725;344872;345603;345768;346753;27478.725212747617;27936.860315699105;28057.43885122327;28170.85914570414;28405.715942840307;41397.37903931383;46744.53255467402;47677;48153;52858.471415285356;41259.587404125574;42040.579594203664;42351;42788.78605607076;43037.3544396828;41356;41608.583914160474;42514.5748542523;42693.35959960665;42823.57176428196;41051.38422923599;41785.373219401125;42195.3670694946;42254.366184506645;42287.788561057;35036.47445288374;37043.259134817694;37086;37266.6896541391;37558.248835023696;27953.44093118167;28212.71787282101;28293.747260192053;28446.857765711866;28631.42737145287 05:39:04 INFO - PROCESS | 3433 | |2;jquery.html;401.59639562239937;404.60955178253;405.23815227372535;406.577159753856;417.97387413898883;13125.994026145314;17772.733408998858;19060.904695476536;19203.61592768144;19242.615147697037;14843.480478183266;15280.617984550392;17960;17972.55068623285;18741.531461713465;5462.508374246317;5612.242347283126;5654.773809047633;5657.801976930808;5666.405027472118;5530.889382212354;5533.197686335499;5566.721663916808;5579.553635709133;5606.915896261539;5429.701366424845;5513.862153446155;5561.694106824123;5569.359523654791;5573.888522229553;5455.099908515091;5474.863128421782;5529.612927095105;5540.307461567304;5573.386927437979;4865.34317867087;4992.301077849104;5013.949860501385;5016.598672106259;5018.096742586333;18851.71722424165;19057.237710491565;20977.68533471999;21346.359609211748;21363.03866326019;2195.484061245606;2222.8777417242045;2270.205428100152;2292.4727312718;2345.906163753448;13524.12093213938;13619.931900340534;13854.515091971833;13918.791218131737;14265.429382824674;1882.218879165145;1952.492351988479;1976.7627884653934;1977.0620956858227;2045.059272734529;76266.61866690687;78867;80009.59995199987;81084;81691;9939.751506212258;10223.642172523925;10382.221333400024;10565.418901960313;10613.628523001658;14527.128372297697;14600.196989165697;14603.853961460249;14606.415743370359;14618.926905365404;7935.523868567904;8120.715774947848;8310.418270720991;8374.874376884352;8375.916240837636;7884.250996155356;8015.839683206304;8099.271065604124;8226.30076443509;8315.168483151758;5818.4763371296785;6089.908651370233;6124.816255512342;6191.690415479298;6197.504199664016;1790.9635539402525;1898.5348589595362;1915.3104882242383;1928.836048935828;1935.206565308245;946.4652471353663;960.9279304052084;979.3927764785878;1137.9374134422687;1156.8727439981594;17879.642407151783;18613.627727445648;18677.533061673294;18887.90556047211;18983.90508047451;1021.8058568871891;1024.8872624011353;1027.8509616105623;1043.2384359417667;1061.458656085402;10589.417582032907;10894.67315980522;10928.453577321103;11010.834837477445;11040.503177357039;457174;459940;461908;466660;467250;81048;81131.59434202909;81201.18798812054;81579.18420815715;83043;998.6305067125065;1006.4263369879098;1021.5556233038652;1039.740064983754;1043.1602559939322;16487;16619;16760.916195418944;16817.579560511083;16999.83000170032;28526.714732852404;37290;38110.40868136857;39699;39873.80063099666;49945.50054499409;51083.48916510787;51240.23139652834;51434.74282628563;51470.742646286526;7306.3789577884345;7687.846243074995;7921.524708517507;8282.792930176794;8664.740057798275;9297.023812499861;12247;12858.42137103814;12931;13254.53609123676;11649.126315526539;11667.824982625098;11685.76628467409;11746.060315174595;11764.35296058725;11302.830457543309;11307.604233851776;11319.264247823865;11390.658280251606;11408.714782130513;11495.195336326711;11822.172447928562;11866.644000679993;11877.346745929057;12117.485314335709;8192.18078192176;8375.623096960773;8523.48859068458;8570.700025499078;8599.65601375963;11553.768924621292;11830.290182589073;11873.584424545099;11885.940570297093;12017.09871759604 05:39:04 INFO - PROCESS | 3433 | |3;mootools.html;1346.9528566500173;1496.9775453368202;1546.3350759173554;1698.218819343102;1848.2422206895167;8589.742307730763;9002.72991810246;9025;9257.16685498305;9271.072892710725;8960.820783584324;9160.725178244664;9165.312601554893;9176.8623470648;9181.357304988653;2012.23535056679;2269.5914735347633;2310.549442858639;2349.7767712067325;2367.4199821043867;2223.5886361023263;2226.7884550967633;2239.8656080635133;2249.156566287642;2249.955000899981;2292.896819643112;2352.188494969233;2354.5526349993534;2355.046206286448;2358.457554762406;2061.917523299066;2233.463968647521;2294.9655755163517;2295.977040229593;2305.2392710405693;2177.575372802304;2216.1357070742424;2217.5786600545844;2218.9238219463546;2267.489814791659;9159.954200229024;9210.907890921071;9219.492927888963;9231.938327092403;9232.584533696;5140.177571588528;5261.079311120577;5266.34170728659;5274.5780337572905;5287.365516138049;3374.898753037413;3393.3043726036103;3438.2951494943477;3502.579690437138;3531.682148606638;967.274544091931;989.5003023473172;1082.8050950828847;1088.8911108889126;1115.263925808962;12695.93652031734;12725.30010849403;12727.618171454871;12753.936230318881;12761.872381276162;4618.468876079227;4627.1439783640135;4748.358971538867;4819.060283244734;4851.248056551241;10650.786984260427;10656.520456579472;10699.572017119228;10704.30422022566;10709.518071686793;4716.103940251342;5324.281222035053;5381.78472861089;5383.730813459311;5384.676919384771;4386.8025938832825;4426.18115648606;4482.484514280899;4489.865304040884;4880.853574392774;4033.1127152026506;4049.6760259179196;4145.958540414617;4156.397322388237;4169.228692691861;1246.1152581666936;1259.7732408166435;1261.5080118753694;1273.1533530202312;1286.8005459153846;901.589776651622;1018.8930162332997;1024.3444195714749;1032.5972870580479;1039.9792004159874;6236.532260080512;6392.360763923663;6434.8391290218115;6477.352264773485;6531.673416329165;429.8774849167972;436.8383698031749;449.7706169853333;452.38475673084577;456.7442232349895;4132.173565286895;4315.8459734011985;4377.4528183977;4402.8679139625865;4439.467263928284;11219.382933938712;11461.656150315504;11544.307341559534;11590;11598.362090085126;11146.498407571678;11293.887061129448;11362.886371136348;11459.656210313704;11478.31130132178;8372.330213582776;8383.413161078788;8419.747407577783;8517.44636598619;8560.571971401405;6219.720112594853;6293.716782744696;6309.211348581427;6337.207849018872;6391.648459334781;10332.070113689804;10470.895291046992;10487.26589138753;10553.736156596147;10598;10657.360558366523;10877.945610271898;10896.945515272373;10914.345139291669;10954.726131846768;7267.854642907218;7670;7843.137254901842;7856.685732570633;7863.921360786548;8860.689875854314;8877.955610221907;8911.420757650732;8915.286777057949;8951.060138685345;7904.051513818378;8075.636596353295;8084.39367047462;8176.46852954556;8220.83558328842;7802.648880800264;7904.367650588054;7933.880991785012;7975.202479751978;8068.07217170033;7124.3944264738075;7139.428845692436;7145.4998150128995;7157.391621712004;7167.139943206848;5360.41035486104;5376.166694162411;5378.784848606168;5426.403095659395;5500.697461639648;5376.086065368975;5393.946060539344;5626.24045753818;5708.4862362387585;5769.278840144982 05:39:04 INFO - PROCESS | 3433 | |4;prototype.html;323.3242523126665;329.62422837964715;337.72475432522486;337.8040736372904;338.0450228105602;5343.759530821113;5388.757505912234;5395.865103372413;5398.811041613544;5402.972985135074;5078.333874715776;5113.233015047745;5259.8422047338545;5324.094903866342;5331.57347412207;4105.50733911931;4113.506379234496;4144.730592511492;4159.230542349675;4162.458880345566;4108.4864391951005;4186.451013125148;4190.622843944045;4200.642945349649;4201.117765269297;3960.5643379228263;3976.7017473689443;4096.897577560555;4132.793360331986;4156.314208155651;4050.4936882889638;4108.630223279889;4113.362428823537;4116.5060192776755;4138.779060177239;3632.0556655269556;3637.7999210043436;3656.7567027210875;3664.578573464059;3667.468217108531;5012.248162775576;5102.979404119191;5117.692938423669;5183.144781111112;5187.533122019036;4734.692245004098;4743.217369134089;4749.762511874427;4751.121042607128;4772.42730872294;5507.394186639466;5523.613347065707;5526.115821468586;5527.751251193706;5534.4742249486235;3945.763254204728;4004.799760011988;4005.7796821174825;4017.6183262590007;4027.2750904837117;5739.512141467981;5741.598088133832;5770.913436298459;5788.6816225107605;5801.593888427812;4111.116110036357;4113.943028485757;4122.9381559276635;4131.760471858431;4136.296829538986;4064.837406503766;4117.464729585135;4165.354370072643;4174.373843923375;4178.874633760992;4642.767861606906;4655.51117132703;4668.039423442163;4685.437747470325;4705.341252224691;5499.422560631157;5545.639533430314;5550.139728342114;5553.278073850454;5555.361133469622;1376.7865980772997;1405.6556143744644;1437.1951707044088;1443.1918125849559;1462.90491118077;883.2889523933167;898.3262553085186;905.7871400220943;987.3236832769576;1003.3327836988321;5347.946520534745;5358.946410535923;5376.032314183484;5408.3509978802795;5423.484768946943;5577.860553486195;5723.484886360247;5748.700519792033;5765;5790.899729051467;5318.760655770499;5366.490183432567;5380.461953804666;5407.810726624549;5417.972910135503;2994.9850250748605;3018.8490575471137;3042.3154790172034;3043.5586839908087;3072.523758817387;5685.658860468302;5925.4151238500945;5941.900748361567;5945.940540594539;5966.343702192756;5684.261046063985;5758.136279558016;5759.769609215668;5787.652740835563;5835.416458354215;5872.564549738366;5891.1752354671235;5901;5909.674967876722;5917.230760001173;5497.285352904097;5794.304683438015;5798.623089499169;5829.76680932758;5864.589478736448;5714.20001199824;5736;5755.539556835527;5760.049591817471;5791.160281759037;5739.799107031234;5954.7320370582565;5967.731452084753;5976.940230597812;6041.516678665784;4173.916521669489;4184.581541845791;4205.621494065426;4211.2419764441465;4235.559909630741;5787.305523337226;5791.478766910998;5792.681402522901;5815.738291776795;5834.504067154339;5398.865028374165;5568.744658413187;5647.661140331593;5666.611680138228;5692.402297758676;5506.752196151103;5529.557635389078;5577.6653400796085;5628.409017053151;5645.68948707825;5279.340082489689;5353.116735738715;5500.367457742411;5500.779968801203;5507.228987941611;5560.833175004756;5636;5636.408177141505;5659.547236221175;5675.148727690879;5271.077561426811;5482.629342664334;5486.588505862156;5508.76052888113;5517.2275881377445 05:39:04 INFO - PROCESS | 3433 | |5;yui.html;794.7099308752305;818.5702506184249;832.737687628397;835.6949713354626;850.8340873529664;14094.506692265773;14121.435142594297;14143.363548640311;14263.786043209335;14295.714085718279;13548.729025419485;14362.281885905715;14808.555743327717;14833.851661483382;15243.695126097471;680.6664734280216;787.684926029587;798.3812545277412;800.5356893002074;801.5631480842954;795.9204079592052;799.1209669363683;801.2668408406302;801.3068695578312;801.4590151647644;847.4068152293419;848.8514509960763;849.9702510412137;850.0606829453458;850.5194565070747;712.1240873725321;716.6703316474402;719.1657677094545;810.440795850861;845.285733555148;578.9334226563957;579.1746760865791;579.1833514744233;579.2238400543292;604.2537466229203;14274.714505709828;14282.428702851874;14310.21293828839;14315.212663303515;14329.283535823168;12677.668844771351;13106.86893131066;13110.775403056063;13261.403236854365;13286.402111904987;12840.480427487302;12893;13058.869411305861;13164.144330618576;13202.339883005907;4373.934390984138;4429.71072390982;4438.134563760068;4510.864674059783;4549.181147393468;62782;64441.67779161121;64765;65085;65698.3430165697;11071.391073490875;11126.554937802559;11232.382218978035;11307.886921130848;11334.319940803578;19907.104180311922;19911.900440497993;19943.803371797738;20019.39941801748;20043.198272069247;8195.098539160688;8376.664933402595;8388.916110838936;8469.957650211833;8741.694040708671;4578.557813699023;4667.369905062841;4680.438347398334;4684.74233917131;4819.2530157825595;3317.369699757087;3448.103493091814;3449.4653328734084;3451.551298331201;3452.6892579667447;684.4148253243504;690.6615758278508;697.9685914133775;721.6499997501207;733.2960358056325;770.6532060572765;773.3851587987564;798.0622768247287;818.3943881527626;827.9461834980707;10089.293749437616;10230;10722;10738.463076846283;10847.67456976292;698.3121625199175;720.3516834848679;789.4158322841056;807.6769292283017;828.4242451496273;4785.569298763128;4939.90120197594;4946.406431228275;4953.777080031407;4965.280034395065;71681.64159179275;71903.64048179725;74804;74949.25050749532;75320.24679753243;62325;62970.37029629645;65841.34158658447;65941.67029164823;67129;56140.71929640407;56496.43503564994;57564.71217643885;58550.121748174664;60132.39867601355;8899.466032038099;8916.19754222123;8943.463392196229;9101.453912765255;9418.858717119112;34073.65926340705;34928.476072859434;35989.460158098176;37362.25275494529;39628.405573915836;49271.507284926694;49833.75083124561;49922.25116623326;50007.74996124996;50010.24984625161;12538.87461125377;12743.617691469271;12917.547885823951;13049.543265985645;13068.085234033526;14362.210078445785;14693.412263509339;15068.472603458826;15069.54791356261;15101.924490377478;12058.698532536757;12887.677808054874;13894.722105558034;13972.301384930915;14436.206008669204;13440.865591343962;13669.658258543615;13760.65598360049;14286.357113929691;14332.49836255726;12351.444185011516;12913.225206487641;13183.209007459584;13758.449662013407;13782.517611883535;10842.830468095915;11227.66317010491;11296.774064518499;11310.491027903929;11596.826047609462;11050.668479945614;11110.44447777624;11243.7751244973;11397.943010284895;11528.942355288169 05:39:04 INFO - PROCESS | 3433 | __end_tp_report 05:39:04 INFO - PROCESS | 3433 | __start_cc_report 05:39:04 INFO - PROCESS | 3433 | _x_x_mozilla_cycle_collect,844 05:39:04 INFO - PROCESS | 3433 | __end_cc_report 05:39:04 INFO - PROCESS | 3433 | __startTimestamp1464266344059__endTimestamp 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | ------- Summary: start ------- 05:39:04 INFO - PROCESS | 3433 | Number of tests: 6 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#0] dojo.html Cycles:165 Average:5442.91 Median:5591.25 stddev:628.17 (11.2%) stddev-sans-first:602.95 05:39:04 INFO - PROCESS | 3433 | Values: 3114.2 3116.8 3135.4 3150.0 3173.1 5333.1 5369.6 5407.1 5475.6 5523.6 5457.0 5486.4 5492.1 5504.6 5511.1 4936.1 4946.3 5021.0 5079.3 5104.6 4995.9 4999.3 5020.1 5046.7 5060.1 4876.6 4916.2 4954.6 4982.3 4990.3 4989.4 4992.2 5004.0 5006.5 5045.8 4816.8 4866.1 4949.5 4966.8 5018.0 5328.4 5457.5 5485.1 5488.3 5494.2 5892.9 5922.9 5943.0 5943.6 5946.3 5644.5 5818.6 5827.4 5952.4 5988.3 5476.8 5531.6 5542.3 5547.8 5557.7 6017.1 6033.2 6033.8 6078.9 6090.6 5592.8 5686.2 5715.3 5751.4 5824.5 5881.3 5899.3 5907.9 5918.2 5918.5 5733.1 5799.2 5800.7 5805.9 5818.1 5590.2 5809.6 5861.1 5868.6 5939.6 4447.8 4467.7 4470.1 4471.0 4503.7 3865.1 3967.8 3974.9 4014.6 4030.4 5502.7 5524.9 5534.8 5541.5 5580.1 5894.4 5896.3 5896.8 5901.3 5974.9 5368.6 5532.9 5537.3 5555.0 5556.2 5072.8 5118.0 5118.7 5132.0 5171.4 6144.2 6168.4 6174.7 6183.3 6192.2 5687.6 5821.4 5840.4 5981.3 5986.3 6068.6 6079.3 6080.4 6091.8 6126.9 5726.5 5733.1 5746.4 5776.4 5793.7 5724.3 5842.8 5877.4 5884.5 5898.6 5758.2 5762.3 5769.5 5770.0 5818.1 5725.8 5725.9 5734.8 5740.0 5741.5 5433.8 5493.0 5538.6 5539.7 5640.6 5708.5 5710.3 5752.4 5755.6 5762.5 5579.7 5588.4 5591.2 5592.9 5594.2 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#1] ext.html Cycles:180 Average:58962.70 Median:22995.01 stddev:116191.98 (505.3%) stddev-sans-first:116435.27 05:39:04 INFO - PROCESS | 3433 | Values: 590.0 619.5 637.0 647.8 654.2 42497.2 43296.6 43491.8 43632.3 47835.5 42832.0 43284.0 43372.0 43404.0 43406.6 8712.9 8813.9 8862.0 8880.3 8888.2 8732.1 8811.5 8838.1 8839.9 8842.6 8881.8 8883.7 8894.2 8905.7 8938.8 8793.5 8816.7 8851.7 8863.1 8870.0 8697.7 8785.7 8826.9 8830.9 8835.6 40023.0 40384.6 40434.4 40447.8 40492.8 3497.2 3583.5 3649.5 3747.4 4051.2 31312.5 31596.8 31749.5 31769.2 31947.5 4204.6 4229.9 4266.1 4280.3 4302.2 336837.0 338626.0 339312.0 339612.0 339945.0 61980.4 62011.4 62648.1 62736.4 62813.7 56974.0 62096.0 64755.4 64813.4 64997.7 16087.7 17526.5 17539.6 17552.4 17563.9 12920.6 13300.5 13307.8 13308.6 13313.3 17582.0 17623.4 19550.5 19978.6 20036.4 6757.6 7129.8 7293.4 7296.9 7570.7 1018.8 1022.8 1103.6 1109.3 1149.7 31931.5 32367.8 32451.4 32858.5 33124.8 1052.9 1086.0 1152.7 1179.3 1242.9 17126.0 17146.1 17309.0 17377.3 17396.5 577387.0 582579.0 582945.0 584944.0 586471.0 56942.0 57885.0 58199.0 58307.0 58462.0 1334.8 1362.8 1367.1 1379.8 1400.7 30110.4 31733.2 31792.4 31991.4 32547.3 51307.7 51344.5 51436.2 51586.2 51620.2 344725.0 344872.0 345603.0 345768.0 346753.0 27478.7 27936.9 28057.4 28170.9 28405.7 41397.4 46744.5 47677.0 48153.0 52858.5 41259.6 42040.6 42351.0 42788.8 43037.4 41356.0 41608.6 42514.6 42693.4 42823.6 41051.4 41785.4 42195.4 42254.4 42287.8 35036.5 37043.3 37086.0 37266.7 37558.2 27953.4 28212.7 28293.7 28446.9 28631.4 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#2] jquery.html Cycles:180 Average:27388.29 Median:2246.54 stddev:76114.92 (3388.1%) stddev-sans-first:76301.47 05:39:04 INFO - PROCESS | 3433 | Values: 401.6 404.6 405.2 406.6 418.0 13126.0 17772.7 19060.9 19203.6 19242.6 14843.5 15280.6 17960.0 17972.6 18741.5 5462.5 5612.2 5654.8 5657.8 5666.4 5530.9 5533.2 5566.7 5579.6 5606.9 5429.7 5513.9 5561.7 5569.4 5573.9 5455.1 5474.9 5529.6 5540.3 5573.4 4865.3 4992.3 5013.9 5016.6 5018.1 18851.7 19057.2 20977.7 21346.4 21363.0 2195.5 2222.9 2270.2 2292.5 2345.9 13524.1 13619.9 13854.5 13918.8 14265.4 1882.2 1952.5 1976.8 1977.1 2045.1 76266.6 78867.0 80009.6 81084.0 81691.0 9939.8 10223.6 10382.2 10565.4 10613.6 14527.1 14600.2 14603.9 14606.4 14618.9 7935.5 8120.7 8310.4 8374.9 8375.9 7884.3 8015.8 8099.3 8226.3 8315.2 5818.5 6089.9 6124.8 6191.7 6197.5 1791.0 1898.5 1915.3 1928.8 1935.2 946.5 960.9 979.4 1137.9 1156.9 17879.6 18613.6 18677.5 18887.9 18983.9 1021.8 1024.9 1027.9 1043.2 1061.5 10589.4 10894.7 10928.5 11010.8 11040.5 457174.0 459940.0 461908.0 466660.0 467250.0 81048.0 81131.6 81201.2 81579.2 83043.0 998.6 1006.4 1021.6 1039.7 1043.2 16487.0 16619.0 16760.9 16817.6 16999.8 28526.7 37290.0 38110.4 39699.0 39873.8 49945.5 51083.5 51240.2 51434.7 51470.7 7306.4 7687.8 7921.5 8282.8 8664.7 9297.0 12247.0 12858.4 12931.0 13254.5 11649.1 11667.8 11685.8 11746.1 11764.4 11302.8 11307.6 11319.3 11390.7 11408.7 11495.2 11822.2 11866.6 11877.3 12117.5 8192.2 8375.6 8523.5 8570.7 8599.7 11553.8 11830.3 11873.6 11885.9 12017.1 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#3] mootools.html Cycles:180 Average:5977.70 Median:4460.98 stddev:3493.43 (78.3%) stddev-sans-first:3485.89 05:39:04 INFO - PROCESS | 3433 | Values: 1347.0 1497.0 1546.3 1698.2 1848.2 8589.7 9002.7 9025.0 9257.2 9271.1 8960.8 9160.7 9165.3 9176.9 9181.4 2012.2 2269.6 2310.5 2349.8 2367.4 2223.6 2226.8 2239.9 2249.2 2250.0 2292.9 2352.2 2354.6 2355.0 2358.5 2061.9 2233.5 2295.0 2296.0 2305.2 2177.6 2216.1 2217.6 2218.9 2267.5 9160.0 9210.9 9219.5 9231.9 9232.6 5140.2 5261.1 5266.3 5274.6 5287.4 3374.9 3393.3 3438.3 3502.6 3531.7 967.3 989.5 1082.8 1088.9 1115.3 12695.9 12725.3 12727.6 12753.9 12761.9 4618.5 4627.1 4748.4 4819.1 4851.2 10650.8 10656.5 10699.6 10704.3 10709.5 4716.1 5324.3 5381.8 5383.7 5384.7 4386.8 4426.2 4482.5 4489.9 4880.9 4033.1 4049.7 4146.0 4156.4 4169.2 1246.1 1259.8 1261.5 1273.2 1286.8 901.6 1018.9 1024.3 1032.6 1040.0 6236.5 6392.4 6434.8 6477.4 6531.7 429.9 436.8 449.8 452.4 456.7 4132.2 4315.8 4377.5 4402.9 4439.5 11219.4 11461.7 11544.3 11590.0 11598.4 11146.5 11293.9 11362.9 11459.7 11478.3 8372.3 8383.4 8419.7 8517.4 8560.6 6219.7 6293.7 6309.2 6337.2 6391.6 10332.1 10470.9 10487.3 10553.7 10598.0 10657.4 10877.9 10896.9 10914.3 10954.7 7267.9 7670.0 7843.1 7856.7 7863.9 8860.7 8878.0 8911.4 8915.3 8951.1 7904.1 8075.6 8084.4 8176.5 8220.8 7802.6 7904.4 7933.9 7975.2 8068.1 7124.4 7139.4 7145.5 7157.4 7167.1 5360.4 5376.2 5378.8 5426.4 5500.7 5376.1 5393.9 5626.2 5708.5 5769.3 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#4] prototype.html Cycles:180 Average:4702.47 Median:5384.61 stddev:1384.35 (25.7%) stddev-sans-first:1348.65 05:39:04 INFO - PROCESS | 3433 | Values: 323.3 329.6 337.7 337.8 338.0 5343.8 5388.8 5395.9 5398.8 5403.0 5078.3 5113.2 5259.8 5324.1 5331.6 4105.5 4113.5 4144.7 4159.2 4162.5 4108.5 4186.5 4190.6 4200.6 4201.1 3960.6 3976.7 4096.9 4132.8 4156.3 4050.5 4108.6 4113.4 4116.5 4138.8 3632.1 3637.8 3656.8 3664.6 3667.5 5012.2 5103.0 5117.7 5183.1 5187.5 4734.7 4743.2 4749.8 4751.1 4772.4 5507.4 5523.6 5526.1 5527.8 5534.5 3945.8 4004.8 4005.8 4017.6 4027.3 5739.5 5741.6 5770.9 5788.7 5801.6 4111.1 4113.9 4122.9 4131.8 4136.3 4064.8 4117.5 4165.4 4174.4 4178.9 4642.8 4655.5 4668.0 4685.4 4705.3 5499.4 5545.6 5550.1 5553.3 5555.4 1376.8 1405.7 1437.2 1443.2 1462.9 883.3 898.3 905.8 987.3 1003.3 5347.9 5358.9 5376.0 5408.4 5423.5 5577.9 5723.5 5748.7 5765.0 5790.9 5318.8 5366.5 5380.5 5407.8 5418.0 2995.0 3018.8 3042.3 3043.6 3072.5 5685.7 5925.4 5941.9 5945.9 5966.3 5684.3 5758.1 5759.8 5787.7 5835.4 5872.6 5891.2 5901.0 5909.7 5917.2 5497.3 5794.3 5798.6 5829.8 5864.6 5714.2 5736.0 5755.5 5760.0 5791.2 5739.8 5954.7 5967.7 5976.9 6041.5 4173.9 4184.6 4205.6 4211.2 4235.6 5787.3 5791.5 5792.7 5815.7 5834.5 5398.9 5568.7 5647.7 5666.6 5692.4 5506.8 5529.6 5577.7 5628.4 5645.7 5279.3 5353.1 5500.4 5500.8 5507.2 5560.8 5636.0 5636.4 5659.5 5675.1 5271.1 5482.6 5486.6 5508.8 5517.2 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - PROCESS | 3433 | [#5] yui.html Cycles:180 Average:16406.00 Median:4622.96 stddev:19982.87 (432.3%) stddev-sans-first:20004.54 05:39:04 INFO - PROCESS | 3433 | Values: 794.7 818.6 832.7 835.7 850.8 14094.5 14121.4 14143.4 14263.8 14295.7 13548.7 14362.3 14808.6 14833.9 15243.7 680.7 787.7 798.4 800.5 801.6 795.9 799.1 801.3 801.3 801.5 847.4 848.9 850.0 850.1 850.5 712.1 716.7 719.2 810.4 845.3 578.9 579.2 579.2 579.2 604.3 14274.7 14282.4 14310.2 14315.2 14329.3 12677.7 13106.9 13110.8 13261.4 13286.4 12840.5 12893.0 13058.9 13164.1 13202.3 4373.9 4429.7 4438.1 4510.9 4549.2 62782.0 64441.7 64765.0 65085.0 65698.3 11071.4 11126.6 11232.4 11307.9 11334.3 19907.1 19911.9 19943.8 20019.4 20043.2 8195.1 8376.7 8388.9 8470.0 8741.7 4578.6 4667.4 4680.4 4684.7 4819.3 3317.4 3448.1 3449.5 3451.6 3452.7 684.4 690.7 698.0 721.6 733.3 770.7 773.4 798.1 818.4 827.9 10089.3 10230.0 10722.0 10738.5 10847.7 698.3 720.4 789.4 807.7 828.4 4785.6 4939.9 4946.4 4953.8 4965.3 71681.6 71903.6 74804.0 74949.3 75320.2 62325.0 62970.4 65841.3 65941.7 67129.0 56140.7 56496.4 57564.7 58550.1 60132.4 8899.5 8916.2 8943.5 9101.5 9418.9 34073.7 34928.5 35989.5 37362.3 39628.4 49271.5 49833.8 49922.3 50007.7 50010.2 12538.9 12743.6 12917.5 13049.5 13068.1 14362.2 14693.4 15068.5 15069.5 15101.9 12058.7 12887.7 13894.7 13972.3 14436.2 13440.9 13669.7 13760.7 14286.4 14332.5 12351.4 12913.2 13183.2 13758.4 13782.5 10842.8 11227.7 11296.8 11310.5 11596.8 11050.7 11110.4 11243.8 11397.9 11528.9 05:39:04 INFO - PROCESS | 3433 | -------- Summary: end -------- 05:39:04 INFO - PROCESS | 3433 | 05:39:04 INFO - TEST-INFO | 3433: exit 0 05:39:04 INFO - TEST-OK | dromaeo_css | took 1114527ms 05:39:04 INFO - TEST-START | kraken 05:39:04 INFO - operating with platform_type : linux_ 05:39:04 INFO - Initialising browser for kraken test... 05:39:04 INFO - TEST-INFO | started process 3618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfJ_IQ/profile http://localhost:43256/getInfo.html) 05:39:08 INFO - PROCESS | 3618 | __metrics Screen width/height:1600/1200 05:39:08 INFO - PROCESS | 3618 | colorDepth:24 05:39:08 INFO - PROCESS | 3618 | Browser inner width/height: 1024/697 05:39:08 INFO - PROCESS | 3618 | __metrics 05:39:09 ERROR - PROCESS | 3618 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:39:10 INFO - TEST-INFO | 3618: exit 0 05:39:10 INFO - Browser initialized. 05:39:10 INFO - Running cycle 1/1 for kraken test... 05:39:10 INFO - TEST-INFO | started process 3700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfJ_IQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:22 INFO - PROCESS | 3700 | RSS: Main: 154972160 05:39:22 INFO - PROCESS | 3700 | 05:39:24 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:25 INFO - PROCESS | 3700 | RSS: Main: 211406848 05:39:25 INFO - PROCESS | 3700 | 05:39:28 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-dft) 05:39:28 INFO - PROCESS | 3700 | RSS: Main: 200347648 05:39:28 INFO - PROCESS | 3700 | 05:39:31 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-fft) 05:39:32 INFO - PROCESS | 3700 | RSS: Main: 268169216 05:39:32 INFO - PROCESS | 3700 | 05:39:34 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator) 05:39:35 INFO - PROCESS | 3700 | RSS: Main: 177115136 05:39:35 INFO - PROCESS | 3700 | 05:39:37 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:37 INFO - PROCESS | 3700 | RSS: Main: 181620736 05:39:37 INFO - PROCESS | 3700 | 05:39:40 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:41 INFO - PROCESS | 3700 | RSS: Main: 217694208 05:39:41 INFO - PROCESS | 3700 | 05:39:44 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:45 INFO - PROCESS | 3700 | RSS: Main: 218488832 05:39:45 INFO - PROCESS | 3700 | 05:39:48 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial) 05:39:48 INFO - PROCESS | 3700 | RSS: Main: 218644480 05:39:48 INFO - PROCESS | 3700 | 05:39:50 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:51 INFO - PROCESS | 3700 | RSS: Main: 205828096 05:39:51 INFO - PROCESS | 3700 | 05:39:52 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:53 INFO - PROCESS | 3700 | RSS: Main: 208248832 05:39:53 INFO - PROCESS | 3700 | 05:39:55 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:56 INFO - PROCESS | 3700 | RSS: Main: 218869760 05:39:56 INFO - PROCESS | 3700 | 05:39:58 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:59 INFO - PROCESS | 3700 | RSS: Main: 227188736 05:39:59 INFO - PROCESS | 3700 | 05:40:02 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:02 INFO - PROCESS | 3700 | RSS: Main: 223637504 05:40:02 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | Cycle 1(1): loaded http://localhost:43256/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43256/tests/kraken/driver.html?testName=ai-astar) 05:40:04 INFO - PROCESS | 3700 | RSS: Main: 269467648 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | __start_tp_report 05:40:04 INFO - PROCESS | 3700 | _x_x_mozilla_page_load 05:40:04 INFO - PROCESS | 3700 | _x_x_mozilla_page_load_details 05:40:04 INFO - PROCESS | 3700 | |i|pagename|runs| 05:40:04 INFO - PROCESS | 3700 | |0;ai-astar;111;104;111;110;110;110;109;110;112;111 05:40:04 INFO - PROCESS | 3700 | |1;audio-beat-detection;159;123;129;178;124;126;148;122;162;124 05:40:04 INFO - PROCESS | 3700 | |2;audio-dft;159;162;159;160;160;160;160;160;160;160 05:40:04 INFO - PROCESS | 3700 | |3;audio-fft;74;75;74;111;75;76;75;73;96;75 05:40:04 INFO - PROCESS | 3700 | |4;audio-oscillator;82;82;120;83;82;83;116;82;83;119 05:40:04 INFO - PROCESS | 3700 | |5;imaging-gaussian-blur;116;117;117;117;117;116;116;116;116;117 05:40:04 INFO - PROCESS | 3700 | |6;imaging-darkroom;145;146;145;146;147;146;146;146;145;146 05:40:04 INFO - PROCESS | 3700 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;95 05:40:04 INFO - PROCESS | 3700 | |8;json-parse-financial;53;54;53;52;54;59;54;72;52;50 05:40:04 INFO - PROCESS | 3700 | |9;json-stringify-tinderbox;61;60;61;61;61;62;62;62;62;62 05:40:04 INFO - PROCESS | 3700 | |10;stanford-crypto-aes;79;85;80;78;79;87;80;81;81;85 05:40:04 INFO - PROCESS | 3700 | |11;stanford-crypto-ccm;134;120;120;119;116;119;119;134;166;128 05:40:04 INFO - PROCESS | 3700 | |12;stanford-crypto-pbkdf2;158;160;159;164;163;158;160;159;162;158 05:40:04 INFO - PROCESS | 3700 | |13;stanford-crypto-sha256-iterative;61;62;66;64;63;61;61;62;62;67 05:40:04 INFO - PROCESS | 3700 | __end_tp_report 05:40:04 INFO - PROCESS | 3700 | __start_cc_report 05:40:04 INFO - PROCESS | 3700 | _x_x_mozilla_cycle_collect,1623 05:40:04 INFO - PROCESS | 3700 | __end_cc_report 05:40:04 INFO - PROCESS | 3700 | __startTimestamp1464266404493__endTimestamp 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | ------- Summary: start ------- 05:40:04 INFO - PROCESS | 3700 | Number of tests: 14 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.20 (2.0%) stddev-sans-first:2.29 05:40:04 INFO - PROCESS | 3700 | Values: 111.0 104.0 111.0 110.0 110.0 110.0 109.0 110.0 112.0 111.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:138.50 stddev:20.53 (14.8%) stddev-sans-first:20.52 05:40:04 INFO - PROCESS | 3700 | Values: 159.0 123.0 129.0 178.0 124.0 126.0 148.0 122.0 162.0 124.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 05:40:04 INFO - PROCESS | 3700 | Values: 159.0 162.0 159.0 160.0 160.0 160.0 160.0 160.0 160.0 160.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.70 (16.9%) stddev-sans-first:13.26 05:40:04 INFO - PROCESS | 3700 | Values: 74.0 75.0 74.0 111.0 75.0 76.0 75.0 73.0 96.0 75.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:82.00 stddev:17.38 (21.2%) stddev-sans-first:17.95 05:40:04 INFO - PROCESS | 3700 | Values: 82.0 82.0 120.0 83.0 82.0 83.0 116.0 82.0 83.0 119.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:40:04 INFO - PROCESS | 3700 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 05:40:04 INFO - PROCESS | 3700 | Values: 145.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:40:04 INFO - PROCESS | 3700 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:6.31 (11.7%) stddev-sans-first:6.64 05:40:04 INFO - PROCESS | 3700 | Values: 53.0 54.0 53.0 52.0 54.0 59.0 54.0 72.0 52.0 50.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 05:40:04 INFO - PROCESS | 3700 | Values: 61.0 60.0 61.0 61.0 61.0 62.0 62.0 62.0 62.0 62.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:3.06 (3.8%) stddev-sans-first:3.11 05:40:04 INFO - PROCESS | 3700 | Values: 79.0 85.0 80.0 78.0 79.0 87.0 80.0 81.0 81.0 85.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:124.00 stddev:15.01 (12.1%) stddev-sans-first:15.74 05:40:04 INFO - PROCESS | 3700 | Values: 134.0 120.0 120.0 119.0 116.0 119.0 119.0 134.0 166.0 128.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:2.18 (1.4%) stddev-sans-first:2.18 05:40:04 INFO - PROCESS | 3700 | Values: 158.0 160.0 159.0 164.0 163.0 158.0 160.0 159.0 162.0 158.0 05:40:04 INFO - PROCESS | 3700 | 05:40:04 INFO - PROCESS | 3700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:2.13 (3.4%) stddev-sans-first:2.15 05:40:04 INFO - PROCESS | 3700 | Values: 61.0 62.0 66.0 64.0 63.0 61.0 61.0 62.0 62.0 67.0 05:40:04 INFO - PROCESS | 3700 | -------- Summary: end -------- 05:40:04 INFO - PROCESS | 3700 | 05:40:05 INFO - TEST-INFO | 3700: exit 0 05:40:05 INFO - TEST-OK | kraken | took 61120ms 05:40:05 INFO - SUITE-END | took 1175s 05:40:06 INFO - Completed test suite (00:19:35) 05:40:06 INFO - javascript benchmark 05:40:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.2370119320753, 3116.8285744284067, 3135.404273188095, 3149.9842500787495, 3173.111528771943, 5333.066713325172, 5369.5704343652515, 5407.107827208506, 5475.589330800191, 5523.613347065712, 5457.045017121997, 5486.423925487817, 5492.093804522259, 5504.559635229182, 5511.063119269724, 4936.111499930011, 4946.282788995593, 5020.97489512552, 5079.288899554065, 5104.617153713468, 4995.900081998358, 4999.250112483121, 5020.0963826511215, 5046.747662616873, 5060.11447996601, 4876.634252431082, 4916.213405855064, 4954.5540901319055, 4982.252662100714, 4990.326305948705, 4989.351384320015, 4992.201247800334, 5003.974980125113, 5006.5494105530315, 5045.848624541233, 4816.783244753994, 4866.148424025817, 4949.480304568005, 4966.776495057695, 5018.0, 5328.387235467932, 5457.536109430703, 5485.0949593317455, 5488.286522752017, 5494.1758736189495, 5892.852678683067, 5922.911156332659, 5943.0, 5943.613665111754, 5946.286445626509, 5644.548436125141, 5818.5636077294375, 5827.388124246978, 5952.434518720715, 5988.28140623128, 5476.835694929158, 5531.640443371209, 5542.307211598551, 5547.750351234205, 5557.722113894289, 6017.06735456005, 6033.245844269466, 6033.841853272682, 6078.908816367758, 6090.604110732788, 5592.804251851166, 5686.2039314496005, 5715.342735585377, 5751.396103409082, 5824.534037277008, 5881.2942446906645, 5899.262592175978, 5907.852303692356, 5918.171455996164, 5918.467337939606, 5733.082706766897, 5799.18811366409, 5800.709964501758, 5805.94194058054, 5818.0981947798155, 5590.217369568264, 5809.564282678816, 5861.120831875168, 5868.589198756132, 5939.613925094855, 4447.777611119431, 4467.664925130628, 4470.128324976663, 4471.038726673716, 4503.662225333113, 3865.1110244643887, 3967.8412863485137, 3974.8608798692485, 4014.598540145962, 4030.395440683862, 5502.697351645618, 5524.889502209933, 5534.75093620788, 5541.473560011793, 5580.079286917613, 5894.381089985575, 5896.262967129109, 5896.7936122235515, 5901.321348044944, 5974.9402505974385, 5368.570514358842, 5532.889342213214, 5537.307836520435, 5555.0, 5556.16657501378, 5072.847814565569, 5118.0, 5118.692878427306, 5131.974340128276, 5171.4311425743135, 6144.2319710036245, 6168.444839964335, 6174.691265436711, 6183.288921774054, 6192.164057852222, 5687.5734319927, 5821.446962538552, 5840.357560668408, 5981.342052374148, 5986.281646202484, 6068.575199735976, 6079.270487541523, 6080.422359875804, 6091.786787462417, 6126.938730612816, 5726.455986681259, 5733.111367738007, 5746.367899531132, 5776.364599893925, 5793.652380857162, 5724.341700704473, 5842.795502157574, 5877.4122587740885, 5884.499817515559, 5898.616589921641, 5758.1650660654805, 5762.250907382014, 5769.480746732815, 5770.047942089508, 5818.127280907897, 5725.828225153252, 5725.885482290414, 5734.799282025109, 5740.0, 5741.483266506035, 5433.7554810034435, 5493.038718224375, 5538.6399884007415, 5539.695316757617, 5640.633358831663, 5708.4862362387585, 5710.314762228559, 5752.395998420273, 5755.5971082025535, 5762.5389968801555, 5579.6652200868075, 5588.385277619377, 5591.245181900554, 5592.944070559242, 5594.216809646571], "value": 5399.7238649418005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.0323469510005, 619.5136817598185, 636.980890573283, 647.7927063339731, 654.1724718231435, 42497.15005699888, 43296.567034329644, 43491.78254108733, 43632.345514817265, 47835.52164478363, 42832.0, 43284.0, 43372.0, 43404.0, 43406.565934340644, 8712.869306960385, 8813.911860881406, 8861.999999999967, 8880.333974951873, 8888.244499217575, 8732.12678732125, 8811.515366654832, 8838.072002439747, 8839.911600884005, 8842.646294148226, 8881.822363552725, 8883.733487995338, 8894.24398926092, 8905.732828015138, 8938.776530586754, 8793.472391656489, 8816.69141580048, 8851.690190843321, 8863.069377715312, 8870.0, 8697.652093916236, 8785.692500762507, 8826.911730882674, 8830.86753698695, 8835.55822208887, 40023.0, 40384.59615403867, 40434.39348409776, 40447.7977610113, 40492.797536012426, 3497.1956450016637, 3583.516225309576, 3649.4708267301094, 3747.4191500317493, 4051.2100140472326, 31312.53031204534, 31596.842015790004, 31749.523757143663, 31769.205769855707, 31947.520787188212, 4204.642605378546, 4229.915401691949, 4266.082792199661, 4280.293751530994, 4302.204092242914, 336837.0, 338626.0, 339312.0, 339612.0, 339945.0, 61980.38019619746, 62011.37988620056, 62648.06027909585, 62736.37263627397, 62813.68593157005, 56974.0, 62096.0, 64755.352446475874, 64813.35186648167, 64997.67501162464, 16087.678246435005, 17526.474205773848, 17539.649207015787, 17552.38566650161, 17563.912180439016, 12920.612381628565, 13300.534481293109, 13307.800382994263, 13308.600741977756, 13313.267770272534, 17582.0, 17623.413892749715, 19550.511237219183, 19978.600427991358, 20036.39890803278, 6757.560758550777, 7129.750458733919, 7293.416526677853, 7296.941943418175, 7570.659320330598, 1018.8217062014118, 1022.7596514819012, 1103.6082190822303, 1109.2623405435456, 1149.7413082056637, 31931.521027184146, 32367.838160809515, 32451.350972980406, 32858.50712239318, 33124.834375827966, 1052.8789189243182, 1085.9674209773718, 1152.7348709796627, 1179.257068047125, 1242.937853107341, 17126.0, 17146.142692865305, 17309.0, 17377.3049078038, 17396.47810565685, 577387.0, 582579.0, 582945.0, 584944.0, 586471.0, 56942.0, 57885.0, 58199.0, 58307.0, 58462.0, 1334.7797613393875, 1362.8023936529148, 1367.1387026173645, 1379.7723375643309, 1400.6568390744333, 30110.397792043597, 31733.20666983344, 31792.36415271728, 31991.360172796878, 32547.34905301928, 51307.74346128246, 51344.48655513397, 51436.22845657393, 51586.22620660768, 51620.22569661383, 344725.0, 344872.0, 345603.0, 345768.0, 346753.0, 27478.725212747617, 27936.860315699105, 28057.43885122327, 28170.85914570414, 28405.715942840307, 41397.37903931383, 46744.53255467402, 47677.0, 48153.0, 52858.471415285356, 41259.587404125574, 42040.579594203664, 42351.0, 42788.78605607076, 43037.3544396828, 41356.0, 41608.583914160474, 42514.5748542523, 42693.35959960665, 42823.57176428196, 41051.38422923599, 41785.373219401125, 42195.3670694946, 42254.366184506645, 42287.788561057, 35036.47445288374, 37043.259134817694, 37086.0, 37266.6896541391, 37558.248835023696, 27953.44093118167, 28212.71787282101, 28293.747260192053, 28446.857765711866, 28631.42737145287], "value": 20217.32901533503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.59639562239937, 404.60955178253, 405.23815227372535, 406.577159753856, 417.97387413898883, 13125.994026145314, 17772.733408998858, 19060.904695476536, 19203.61592768144, 19242.615147697037, 14843.480478183266, 15280.617984550392, 17960.0, 17972.55068623285, 18741.531461713465, 5462.508374246317, 5612.242347283126, 5654.773809047633, 5657.801976930808, 5666.405027472118, 5530.889382212354, 5533.197686335499, 5566.721663916808, 5579.553635709133, 5606.915896261539, 5429.701366424845, 5513.862153446155, 5561.694106824123, 5569.359523654791, 5573.888522229553, 5455.099908515091, 5474.863128421782, 5529.612927095105, 5540.307461567304, 5573.386927437979, 4865.34317867087, 4992.301077849104, 5013.949860501385, 5016.598672106259, 5018.096742586333, 18851.71722424165, 19057.237710491565, 20977.68533471999, 21346.359609211748, 21363.03866326019, 2195.484061245606, 2222.8777417242045, 2270.205428100152, 2292.4727312718, 2345.906163753448, 13524.12093213938, 13619.931900340534, 13854.515091971833, 13918.791218131737, 14265.429382824674, 1882.218879165145, 1952.492351988479, 1976.7627884653934, 1977.0620956858227, 2045.059272734529, 76266.61866690687, 78867.0, 80009.59995199987, 81084.0, 81691.0, 9939.751506212258, 10223.642172523925, 10382.221333400024, 10565.418901960313, 10613.628523001658, 14527.128372297697, 14600.196989165697, 14603.853961460249, 14606.415743370359, 14618.926905365404, 7935.523868567904, 8120.715774947848, 8310.418270720991, 8374.874376884352, 8375.916240837636, 7884.250996155356, 8015.839683206304, 8099.271065604124, 8226.30076443509, 8315.168483151758, 5818.4763371296785, 6089.908651370233, 6124.816255512342, 6191.690415479298, 6197.504199664016, 1790.9635539402525, 1898.5348589595362, 1915.3104882242383, 1928.836048935828, 1935.206565308245, 946.4652471353663, 960.9279304052084, 979.3927764785878, 1137.9374134422687, 1156.8727439981594, 17879.642407151783, 18613.627727445648, 18677.533061673294, 18887.90556047211, 18983.90508047451, 1021.8058568871891, 1024.8872624011353, 1027.8509616105623, 1043.2384359417667, 1061.458656085402, 10589.417582032907, 10894.67315980522, 10928.453577321103, 11010.834837477445, 11040.503177357039, 457174.0, 459940.0, 461908.0, 466660.0, 467250.0, 81048.0, 81131.59434202909, 81201.18798812054, 81579.18420815715, 83043.0, 998.6305067125065, 1006.4263369879098, 1021.5556233038652, 1039.740064983754, 1043.1602559939322, 16487.0, 16619.0, 16760.916195418944, 16817.579560511083, 16999.83000170032, 28526.714732852404, 37290.0, 38110.40868136857, 39699.0, 39873.80063099666, 49945.50054499409, 51083.48916510787, 51240.23139652834, 51434.74282628563, 51470.742646286526, 7306.3789577884345, 7687.846243074995, 7921.524708517507, 8282.792930176794, 8664.740057798275, 9297.023812499861, 12247.0, 12858.42137103814, 12931.0, 13254.53609123676, 11649.126315526539, 11667.824982625098, 11685.76628467409, 11746.060315174595, 11764.35296058725, 11302.830457543309, 11307.604233851776, 11319.264247823865, 11390.658280251606, 11408.714782130513, 11495.195336326711, 11822.172447928562, 11866.644000679993, 11877.346745929057, 12117.485314335709, 8192.18078192176, 8375.623096960773, 8523.48859068458, 8570.700025499078, 8599.65601375963, 11553.768924621292, 11830.290182589073, 11873.584424545099, 11885.940570297093, 12017.09871759604], "value": 9044.345269805852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.9528566500173, 1496.9775453368202, 1546.3350759173554, 1698.218819343102, 1848.2422206895167, 8589.742307730763, 9002.72991810246, 9025.0, 9257.16685498305, 9271.072892710725, 8960.820783584324, 9160.725178244664, 9165.312601554893, 9176.8623470648, 9181.357304988653, 2012.23535056679, 2269.5914735347633, 2310.549442858639, 2349.7767712067325, 2367.4199821043867, 2223.5886361023263, 2226.7884550967633, 2239.8656080635133, 2249.156566287642, 2249.955000899981, 2292.896819643112, 2352.188494969233, 2354.5526349993534, 2355.046206286448, 2358.457554762406, 2061.917523299066, 2233.463968647521, 2294.9655755163517, 2295.977040229593, 2305.2392710405693, 2177.575372802304, 2216.1357070742424, 2217.5786600545844, 2218.9238219463546, 2267.489814791659, 9159.954200229024, 9210.907890921071, 9219.492927888963, 9231.938327092403, 9232.584533696, 5140.177571588528, 5261.079311120577, 5266.34170728659, 5274.5780337572905, 5287.365516138049, 3374.898753037413, 3393.3043726036103, 3438.2951494943477, 3502.579690437138, 3531.682148606638, 967.274544091931, 989.5003023473172, 1082.8050950828847, 1088.8911108889126, 1115.263925808962, 12695.93652031734, 12725.30010849403, 12727.618171454871, 12753.936230318881, 12761.872381276162, 4618.468876079227, 4627.1439783640135, 4748.358971538867, 4819.060283244734, 4851.248056551241, 10650.786984260427, 10656.520456579472, 10699.572017119228, 10704.30422022566, 10709.518071686793, 4716.103940251342, 5324.281222035053, 5381.78472861089, 5383.730813459311, 5384.676919384771, 4386.8025938832825, 4426.18115648606, 4482.484514280899, 4489.865304040884, 4880.853574392774, 4033.1127152026506, 4049.6760259179196, 4145.958540414617, 4156.397322388237, 4169.228692691861, 1246.1152581666936, 1259.7732408166435, 1261.5080118753694, 1273.1533530202312, 1286.8005459153846, 901.589776651622, 1018.8930162332997, 1024.3444195714749, 1032.5972870580479, 1039.9792004159874, 6236.532260080512, 6392.360763923663, 6434.8391290218115, 6477.352264773485, 6531.673416329165, 429.8774849167972, 436.8383698031749, 449.7706169853333, 452.38475673084577, 456.7442232349895, 4132.173565286895, 4315.8459734011985, 4377.4528183977, 4402.8679139625865, 4439.467263928284, 11219.382933938712, 11461.656150315504, 11544.307341559534, 11590.0, 11598.362090085126, 11146.498407571678, 11293.887061129448, 11362.886371136348, 11459.656210313704, 11478.31130132178, 8372.330213582776, 8383.413161078788, 8419.747407577783, 8517.44636598619, 8560.571971401405, 6219.720112594853, 6293.716782744696, 6309.211348581427, 6337.207849018872, 6391.648459334781, 10332.070113689804, 10470.895291046992, 10487.26589138753, 10553.736156596147, 10598.0, 10657.360558366523, 10877.945610271898, 10896.945515272373, 10914.345139291669, 10954.726131846768, 7267.854642907218, 7670.0, 7843.137254901842, 7856.685732570633, 7863.921360786548, 8860.689875854314, 8877.955610221907, 8911.420757650732, 8915.286777057949, 8951.060138685345, 7904.051513818378, 8075.636596353295, 8084.39367047462, 8176.46852954556, 8220.83558328842, 7802.648880800264, 7904.367650588054, 7933.880991785012, 7975.202479751978, 8068.07217170033, 7124.3944264738075, 7139.428845692436, 7145.4998150128995, 7157.391621712004, 7167.139943206848, 5360.41035486104, 5376.166694162411, 5378.784848606168, 5426.403095659395, 5500.697461639648, 5376.086065368975, 5393.946060539344, 5626.24045753818, 5708.4862362387585, 5769.278840144982], "value": 4641.96175888452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.3242523126665, 329.62422837964715, 337.72475432522486, 337.8040736372904, 338.0450228105602, 5343.759530821113, 5388.757505912234, 5395.865103372413, 5398.811041613544, 5402.972985135074, 5078.333874715776, 5113.233015047745, 5259.8422047338545, 5324.094903866342, 5331.57347412207, 4105.50733911931, 4113.506379234496, 4144.730592511492, 4159.230542349675, 4162.458880345566, 4108.4864391951005, 4186.451013125148, 4190.622843944045, 4200.642945349649, 4201.117765269297, 3960.5643379228263, 3976.7017473689443, 4096.897577560555, 4132.793360331986, 4156.314208155651, 4050.4936882889638, 4108.630223279889, 4113.362428823537, 4116.5060192776755, 4138.779060177239, 3632.0556655269556, 3637.7999210043436, 3656.7567027210875, 3664.578573464059, 3667.468217108531, 5012.248162775576, 5102.979404119191, 5117.692938423669, 5183.144781111112, 5187.533122019036, 4734.692245004098, 4743.217369134089, 4749.762511874427, 4751.121042607128, 4772.42730872294, 5507.394186639466, 5523.613347065707, 5526.115821468586, 5527.751251193706, 5534.4742249486235, 3945.763254204728, 4004.799760011988, 4005.7796821174825, 4017.6183262590007, 4027.2750904837117, 5739.512141467981, 5741.598088133832, 5770.913436298459, 5788.6816225107605, 5801.593888427812, 4111.116110036357, 4113.943028485757, 4122.9381559276635, 4131.760471858431, 4136.296829538986, 4064.837406503766, 4117.464729585135, 4165.354370072643, 4174.373843923375, 4178.874633760992, 4642.767861606906, 4655.51117132703, 4668.039423442163, 4685.437747470325, 4705.341252224691, 5499.422560631157, 5545.639533430314, 5550.139728342114, 5553.278073850454, 5555.361133469622, 1376.7865980772997, 1405.6556143744644, 1437.1951707044088, 1443.1918125849559, 1462.90491118077, 883.2889523933167, 898.3262553085186, 905.7871400220943, 987.3236832769576, 1003.3327836988321, 5347.946520534745, 5358.946410535923, 5376.032314183484, 5408.3509978802795, 5423.484768946943, 5577.860553486195, 5723.484886360247, 5748.700519792033, 5765.0, 5790.899729051467, 5318.760655770499, 5366.490183432567, 5380.461953804666, 5407.810726624549, 5417.972910135503, 2994.9850250748605, 3018.8490575471137, 3042.3154790172034, 3043.5586839908087, 3072.523758817387, 5685.658860468302, 5925.4151238500945, 5941.900748361567, 5945.940540594539, 5966.343702192756, 5684.261046063985, 5758.136279558016, 5759.769609215668, 5787.652740835563, 5835.416458354215, 5872.564549738366, 5891.1752354671235, 5901.0, 5909.674967876722, 5917.230760001173, 5497.285352904097, 5794.304683438015, 5798.623089499169, 5829.76680932758, 5864.589478736448, 5714.20001199824, 5736.0, 5755.539556835527, 5760.049591817471, 5791.160281759037, 5739.799107031234, 5954.7320370582565, 5967.731452084753, 5976.940230597812, 6041.516678665784, 4173.916521669489, 4184.581541845791, 4205.621494065426, 4211.2419764441465, 4235.559909630741, 5787.305523337226, 5791.478766910998, 5792.681402522901, 5815.738291776795, 5834.504067154339, 5398.865028374165, 5568.744658413187, 5647.661140331593, 5666.611680138228, 5692.402297758676, 5506.752196151103, 5529.557635389078, 5577.6653400796085, 5628.409017053151, 5645.68948707825, 5279.340082489689, 5353.116735738715, 5500.367457742411, 5500.779968801203, 5507.228987941611, 5560.833175004756, 5636.0, 5636.408177141505, 5659.547236221175, 5675.148727690879, 5271.077561426811, 5482.629342664334, 5486.588505862156, 5508.76052888113, 5517.2275881377445], "value": 4259.665475093673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.7099308752305, 818.5702506184249, 832.737687628397, 835.6949713354626, 850.8340873529664, 14094.506692265773, 14121.435142594297, 14143.363548640311, 14263.786043209335, 14295.714085718279, 13548.729025419485, 14362.281885905715, 14808.555743327717, 14833.851661483382, 15243.695126097471, 680.6664734280216, 787.684926029587, 798.3812545277412, 800.5356893002074, 801.5631480842954, 795.9204079592052, 799.1209669363683, 801.2668408406302, 801.3068695578312, 801.4590151647644, 847.4068152293419, 848.8514509960763, 849.9702510412137, 850.0606829453458, 850.5194565070747, 712.1240873725321, 716.6703316474402, 719.1657677094545, 810.440795850861, 845.285733555148, 578.9334226563957, 579.1746760865791, 579.1833514744233, 579.2238400543292, 604.2537466229203, 14274.714505709828, 14282.428702851874, 14310.21293828839, 14315.212663303515, 14329.283535823168, 12677.668844771351, 13106.86893131066, 13110.775403056063, 13261.403236854365, 13286.402111904987, 12840.480427487302, 12893.0, 13058.869411305861, 13164.144330618576, 13202.339883005907, 4373.934390984138, 4429.71072390982, 4438.134563760068, 4510.864674059783, 4549.181147393468, 62782.0, 64441.67779161121, 64765.0, 65085.0, 65698.3430165697, 11071.391073490875, 11126.554937802559, 11232.382218978035, 11307.886921130848, 11334.319940803578, 19907.104180311922, 19911.900440497993, 19943.803371797738, 20019.39941801748, 20043.198272069247, 8195.098539160688, 8376.664933402595, 8388.916110838936, 8469.957650211833, 8741.694040708671, 4578.557813699023, 4667.369905062841, 4680.438347398334, 4684.74233917131, 4819.2530157825595, 3317.369699757087, 3448.103493091814, 3449.4653328734084, 3451.551298331201, 3452.6892579667447, 684.4148253243504, 690.6615758278508, 697.9685914133775, 721.6499997501207, 733.2960358056325, 770.6532060572765, 773.3851587987564, 798.0622768247287, 818.3943881527626, 827.9461834980707, 10089.293749437616, 10230.0, 10722.0, 10738.463076846283, 10847.67456976292, 698.3121625199175, 720.3516834848679, 789.4158322841056, 807.6769292283017, 828.4242451496273, 4785.569298763128, 4939.90120197594, 4946.406431228275, 4953.777080031407, 4965.280034395065, 71681.64159179275, 71903.64048179725, 74804.0, 74949.25050749532, 75320.24679753243, 62325.0, 62970.37029629645, 65841.34158658447, 65941.67029164823, 67129.0, 56140.71929640407, 56496.43503564994, 57564.71217643885, 58550.121748174664, 60132.39867601355, 8899.466032038099, 8916.19754222123, 8943.463392196229, 9101.453912765255, 9418.858717119112, 34073.65926340705, 34928.476072859434, 35989.460158098176, 37362.25275494529, 39628.405573915836, 49271.507284926694, 49833.75083124561, 49922.25116623326, 50007.74996124996, 50010.24984625161, 12538.87461125377, 12743.617691469271, 12917.547885823951, 13049.543265985645, 13068.085234033526, 14362.210078445785, 14693.412263509339, 15068.472603458826, 15069.54791356261, 15101.924490377478, 12058.698532536757, 12887.677808054874, 13894.722105558034, 13972.301384930915, 14436.206008669204, 13440.865591343962, 13669.658258543615, 13760.65598360049, 14286.357113929691, 14332.49836255726, 12351.444185011516, 12913.225206487641, 13183.209007459584, 13758.449662013407, 13782.517611883535, 10842.830468095915, 11227.66317010491, 11296.774064518499, 11310.491027903929, 11596.826047609462, 11050.668479945614, 11110.44447777624, 11243.7751244973, 11397.943010284895, 11528.942355288169], "value": 7132.263542449375, "unit": "score"}], "name": "dromaeo_css", "value": 7199.520078642162, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 112.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 129.0, 178.0, 124.0, 126.0, 148.0, 122.0, 162.0, 124.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 111.0, 75.0, 76.0, 75.0, 73.0, 96.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 120.0, 83.0, 82.0, 83.0, 116.0, 82.0, 83.0, 119.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 54.0, 59.0, 54.0, 72.0, 52.0, 50.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 80.0, 78.0, 79.0, 87.0, 80.0, 81.0, 81.0, 85.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 120.0, 120.0, 119.0, 116.0, 119.0, 119.0, 134.0, 166.0, 128.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 164.0, 163.0, 158.0, 160.0, 159.0, 162.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 66.0, 64.0, 63.0, 61.0, 61.0, 62.0, 62.0, 67.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1489.2, "alertThreshold": 2.0}]} 05:40:06 INFO - Return code: 0 05:40:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:40:06 ERROR - # TBPL SUCCESS # 05:40:06 INFO - Running post-action listener: _resource_record_post_action 05:40:06 INFO - ##### 05:40:06 INFO - ##### Finished run-tests step (success) 05:40:06 INFO - ##### 05:40:06 INFO - Running post-run listener: _resource_record_post_run 05:40:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8073216; Write bytes: 479424512; Read time: 1976; Write time: 392604 05:40:06 INFO - TinderboxPrint: CPU usage
13.1% 05:40:06 INFO - TinderboxPrint: I/O read bytes / time
8,073,216 / 1,976 05:40:06 INFO - TinderboxPrint: I/O write bytes / time
479,424,512 / 392,604 05:40:06 INFO - TinderboxPrint: CPU idle
8,283.0 (86.9%) 05:40:06 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 05:40:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 25190400; Read time: 0; Write time: 31540 05:40:06 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6209536; Write bytes: 454234112; Read time: 1804; Write time: 361064 05:40:06 INFO - Running post-run listener: _upload_blobber_files 05:40:06 INFO - Blob upload gear active. 05:40:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:06 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 05:40:06 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'] 05:40:06 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 05:40:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:08 INFO - (blobuploader) - INFO - Done attempting. 05:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:12 INFO - (blobuploader) - INFO - Done attempting. 05:40:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:40:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:40:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:13 INFO - (blobuploader) - INFO - Done attempting. 05:40:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:13 INFO - Return code: 0 05:40:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71970280e88ce98a92834c8c030f1876d7e1a780d3c59945eb79f467d8cdc3c563898a9bf89511228fd2b99d2b63456858a2eb37894c9bff677dffee1681cf01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca0873a068458dc1cbc2ebffaf0df2ceb16da2797c47d23760ffb5636167e62c84f3d843ab54efc3749820d53e6242fc686974eace9e6473fcab9c7d6b9ccf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69da10adac2c24eab0794a6838784fc350b09a0675d48b578802a94c1f22ae7136cf791ac7dfc83abd8627ff2834e162a681c76367d73253c6bfb22799ce4de"} 05:40:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:13 INFO - Contents: 05:40:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71970280e88ce98a92834c8c030f1876d7e1a780d3c59945eb79f467d8cdc3c563898a9bf89511228fd2b99d2b63456858a2eb37894c9bff677dffee1681cf01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca0873a068458dc1cbc2ebffaf0df2ceb16da2797c47d23760ffb5636167e62c84f3d843ab54efc3749820d53e6242fc686974eace9e6473fcab9c7d6b9ccf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69da10adac2c24eab0794a6838784fc350b09a0675d48b578802a94c1f22ae7136cf791ac7dfc83abd8627ff2834e162a681c76367d73253c6bfb22799ce4de"} 05:40:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:13 INFO - Copying logs to upload dir... 05:40:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.325631 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-26 05:40:13.273365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 05:40:13.276954) ========= 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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 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/71970280e88ce98a92834c8c030f1876d7e1a780d3c59945eb79f467d8cdc3c563898a9bf89511228fd2b99d2b63456858a2eb37894c9bff677dffee1681cf01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca0873a068458dc1cbc2ebffaf0df2ceb16da2797c47d23760ffb5636167e62c84f3d843ab54efc3749820d53e6242fc686974eace9e6473fcab9c7d6b9ccf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69da10adac2c24eab0794a6838784fc350b09a0675d48b578802a94c1f22ae7136cf791ac7dfc83abd8627ff2834e162a681c76367d73253c6bfb22799ce4de"} build_url:https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/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/71970280e88ce98a92834c8c030f1876d7e1a780d3c59945eb79f467d8cdc3c563898a9bf89511228fd2b99d2b63456858a2eb37894c9bff677dffee1681cf01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca0873a068458dc1cbc2ebffaf0df2ceb16da2797c47d23760ffb5636167e62c84f3d843ab54efc3749820d53e6242fc686974eace9e6473fcab9c7d6b9ccf52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69da10adac2c24eab0794a6838784fc350b09a0675d48b578802a94c1f22ae7136cf791ac7dfc83abd8627ff2834e162a681c76367d73253c6bfb22799ce4de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 05:40:13.302048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:40:13.302388) ========= 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=574dc5aafe09851ec43d388c000001b6-1464263805.734866-459134028 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:40:13.387519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 05:40:13.387844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 05:40:13.388140) ========= ========= Total master_lag: 0.18 =========