builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1464642617.77 results: success (0) buildid: 20160530113034 builduid: cbe9927550dc4d91a2e49809ea7a2845 revision: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.773644) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.774309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.774609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.808283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.808553) ========= 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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 14:10:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-05-30 14:10:19 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.954260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:17.954591) ========= 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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019839 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.007245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.007610) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c8f09493cadc33fc6aa05f52cabbabb15b9593a --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 5c8f09493cadc33fc6aa05f52cabbabb15b9593a --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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 14:10:19,856 truncating revision to first 12 chars 2016-05-30 14:10:19,856 Setting DEBUG logging. 2016-05-30 14:10:19,856 attempt 1/10 2016-05-30 14:10:19,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c8f09493cad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 14:10:20,147 unpacking tar archive at: fx-team-5c8f09493cad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.634794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.635121) ========= script_repo_revision: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.635527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.635890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:10:18.647467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-30 14:10:18.647750) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:20 INFO - MultiFileLogger online at 20160530 14:10:20 in /builds/slave/test 14:10:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:10:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:20 INFO - {'append_to_log': False, 14:10:20 INFO - 'base_work_dir': '/builds/slave/test', 14:10:20 INFO - 'blob_upload_branch': 'Fx-Team', 14:10:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:20 INFO - 'branch': 'Fx-Team', 14:10:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:20 INFO - 'config_files': ('talos/linux_config.py',), 14:10:20 INFO - 'default_actions': ('clobber', 14:10:20 INFO - 'read-buildbot-config', 14:10:20 INFO - 'download-and-extract', 14:10:20 INFO - 'populate-webroot', 14:10:20 INFO - 'create-virtualenv', 14:10:20 INFO - 'install', 14:10:20 INFO - 'run-tests'), 14:10:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:20 INFO - 'download_minidump_stackwalk': True, 14:10:20 INFO - 'download_symbols': 'ondemand', 14:10:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:20 INFO - 'installer_path': 'installer.exe', 14:10:20 INFO - 'log_level': 'info', 14:10:20 INFO - 'log_name': 'talos', 14:10:20 INFO - 'log_to_console': True, 14:10:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:20 INFO - 'opt_config_files': (), 14:10:20 INFO - 'pip_index': False, 14:10:20 INFO - 'sps_profile': False, 14:10:20 INFO - 'sps_profile_interval': 0, 14:10:20 INFO - 'suite': 'dromaeojs-e10s', 14:10:20 INFO - 'system_bits': '32', 14:10:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:20 INFO - 'title': 'talos-linux64-ix-056', 14:10:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:20 INFO - 'use_talos_json': True, 14:10:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:20 INFO - 'work_dir': 'build'} 14:10:20 INFO - ##### 14:10:20 INFO - ##### Running clobber step. 14:10:20 INFO - ##### 14:10:20 INFO - Running pre-action listener: _resource_record_pre_action 14:10:20 INFO - Running main action method: clobber 14:10:20 INFO - rmtree: /builds/slave/test/build 14:10:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:21 INFO - Running post-action listener: _resource_record_post_action 14:10:21 INFO - ##### 14:10:21 INFO - ##### Finished clobber step (success) 14:10:21 INFO - ##### 14:10:21 INFO - ##### 14:10:21 INFO - ##### Running read-buildbot-config step. 14:10:21 INFO - ##### 14:10:21 INFO - Running pre-action listener: _resource_record_pre_action 14:10:21 INFO - Running main action method: read_buildbot_config 14:10:21 INFO - Using buildbot properties: 14:10:21 INFO - { 14:10:21 INFO - "project": "", 14:10:21 INFO - "product": "firefox", 14:10:21 INFO - "script_repo_revision": "production", 14:10:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:10:21 INFO - "repository": "", 14:10:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:10:21 INFO - "buildid": "20160530113034", 14:10:21 INFO - "pgo_build": "True", 14:10:21 INFO - "basedir": "/builds/slave/test", 14:10:21 INFO - "buildnumber": 393, 14:10:21 INFO - "slavename": "talos-linux64-ix-056", 14:10:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:10:21 INFO - "platform": "ubuntu64_hw", 14:10:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:10:21 INFO - "branch": "fx-team", 14:10:21 INFO - "repo_path": "integration/fx-team", 14:10:21 INFO - "revision": "5c8f09493cadc33fc6aa05f52cabbabb15b9593a", 14:10:21 INFO - "stage_platform": "linux64-pgo", 14:10:21 INFO - "builduid": "cbe9927550dc4d91a2e49809ea7a2845", 14:10:21 INFO - "slavebuilddir": "test" 14:10:21 INFO - } 14:10:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:10:21 INFO - Running post-action listener: _resource_record_post_action 14:10:21 INFO - ##### 14:10:21 INFO - ##### Finished read-buildbot-config step (success) 14:10:21 INFO - ##### 14:10:21 INFO - ##### 14:10:21 INFO - ##### Running download-and-extract step. 14:10:21 INFO - ##### 14:10:21 INFO - Running pre-action listener: _resource_record_pre_action 14:10:21 INFO - Running main action method: download_and_extract 14:10:21 INFO - mkdir: /builds/slave/test/build/tests 14:10: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')]} 14:10:21 INFO - https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:22 INFO - Downloaded 1361 bytes. 14:10:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:22 INFO - Using the following test package requirements: 14:10:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'jsshell-linux-x86_64.zip'], 14:10:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:22 INFO - https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:23 INFO - Downloaded 24410718 bytes. 14:10:23 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'] 14:10:23 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 14:10:24 INFO - Return code: 0 14:10:24 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 14:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:24 INFO - https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:25 INFO - Downloaded 24410718 bytes. 14:10:25 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'] 14:10:25 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 14:10:27 INFO - Return code: 0 14:10:27 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')]} 14:10:27 INFO - https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:28 INFO - Downloaded 10834055 bytes. 14:10:28 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'] 14:10:28 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 14:10:29 INFO - Return code: 0 14:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:29 INFO - https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bjyDzc2BRn2JymllQNFuew/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 14:10:30 INFO - Downloaded 58935643 bytes. 14:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:30 INFO - mkdir: /builds/slave/test/properties 14:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:30 INFO - Contents: 14:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:31 INFO - Running post-action listener: _resource_record_post_action 14:10:31 INFO - Running post-action listener: set_extra_try_arguments 14:10:31 INFO - ##### 14:10:31 INFO - ##### Finished download-and-extract step (success) 14:10:31 INFO - ##### 14:10:31 INFO - ##### 14:10:31 INFO - ##### Running populate-webroot step. 14:10:31 INFO - ##### 14:10:31 INFO - Running pre-action listener: _resource_record_pre_action 14:10:31 INFO - Running main action method: populate_webroot 14:10:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:31 INFO - '--tppagecycles', 14:10:31 INFO - '7'], 14:10:31 INFO - 'tests': ['tsvgm']}}, 14:10:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['damp', 'tps']}, 14:10:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'tests': ['damp', 'tps']}, 14:10:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['dromaeo_dom']}, 14:10:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['a11yr', 14:10:31 INFO - 'ts_paint', 14:10:31 INFO - 'tpaint', 14:10:31 INFO - 'sessionrestore', 14:10:31 INFO - 'sessionrestore_no_auto_restore', 14:10:31 INFO - 'tabpaint']}, 14:10:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['tsvgx', 14:10:31 INFO - 'tsvgr_opacity', 14:10:31 INFO - 'tart', 14:10:31 INFO - 'tscrollx', 14:10:31 INFO - 'cart']}, 14:10:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:31 INFO - 'tsvgr_opacity', 14:10:31 INFO - 'tart', 14:10:31 INFO - 'tscrollx', 14:10:31 INFO - 'cart']}, 14:10:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'talos_options': ['--disable-e10s'], 14:10:31 INFO - 'tests': ['tp5o']}, 14:10:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'tests': ['tp5o']}, 14:10:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'talos_options': ['--disable-e10s', 14:10:31 INFO - '--xperf_path', 14:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:31 INFO - 'tests': ['tp5n']}, 14:10:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:31 INFO - 'talos_options': ['--xperf_path', 14:10:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:31 INFO - 'tests': ['tp5n']}}, 14:10:31 INFO - 'talos.zip': {'path': '', 14:10:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:31 INFO - Running post-action listener: _resource_record_post_action 14:10:31 INFO - ##### 14:10:31 INFO - ##### Finished populate-webroot step (success) 14:10:31 INFO - ##### 14:10:31 INFO - ##### 14:10:31 INFO - ##### Running create-virtualenv step. 14:10:31 INFO - ##### 14:10:31 INFO - Running pre-action listener: _resource_record_pre_action 14:10:31 INFO - Running main action method: create_virtualenv 14:10:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:31 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 14:10:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:31 INFO - Using real prefix '/usr' 14:10:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:34 INFO - Installing pip.................done. 14:10:34 INFO - Return code: 0 14:10:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:34 INFO - Using env: {'DISPLAY': ':0', 14:10:34 INFO - 'HOME': '/home/cltbld', 14:10:34 INFO - 'LANG': 'en_US.UTF-8', 14:10:34 INFO - 'LANGUAGE': 'en_US:en', 14:10:34 INFO - 'LOGNAME': 'cltbld', 14:10:34 INFO - 'MAIL': '/var/mail/cltbld', 14:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:34 INFO - 'MOZ_NO_REMOTE': '1', 14:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:34 INFO - 'NO_EM_RESTART': '1', 14:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:34 INFO - 'PWD': '/builds/slave/test', 14:10:34 INFO - 'SHELL': '/bin/bash', 14:10:34 INFO - 'SHLVL': '1', 14:10:34 INFO - 'TERM': 'linux', 14:10:34 INFO - 'TMOUT': '86400', 14:10:34 INFO - 'USER': 'cltbld', 14:10:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:34 INFO - '_': '/tools/buildbot/bin/python'} 14:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:34 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 14:10:34 INFO - Cleaning up... 14:10:34 INFO - Return code: 0 14:10:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:10:34 INFO - Using env: {'DISPLAY': ':0', 14:10:34 INFO - 'HOME': '/home/cltbld', 14:10:34 INFO - 'LANG': 'en_US.UTF-8', 14:10:34 INFO - 'LANGUAGE': 'en_US:en', 14:10:34 INFO - 'LOGNAME': 'cltbld', 14:10:34 INFO - 'MAIL': '/var/mail/cltbld', 14:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:34 INFO - 'MOZ_NO_REMOTE': '1', 14:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:34 INFO - 'NO_EM_RESTART': '1', 14:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:34 INFO - 'PWD': '/builds/slave/test', 14:10:34 INFO - 'SHELL': '/bin/bash', 14:10:34 INFO - 'SHLVL': '1', 14:10:34 INFO - 'TERM': 'linux', 14:10:34 INFO - 'TMOUT': '86400', 14:10:34 INFO - 'USER': 'cltbld', 14:10:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:34 INFO - '_': '/tools/buildbot/bin/python'} 14:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:34 INFO - Downloading/unpacking psutil>=3.1.1 14:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:36 INFO - Installing collected packages: psutil 14:10:36 INFO - Running setup.py install for psutil 14:10:36 INFO - building 'psutil._psutil_linux' extension 14:10:36 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 14:10:36 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 14:10:36 INFO - building 'psutil._psutil_posix' extension 14:10:36 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 14:10:36 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 14:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:36 INFO - Successfully installed psutil 14:10:36 INFO - Cleaning up... 14:10:37 INFO - Return code: 0 14:10:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:10:37 INFO - Using env: {'DISPLAY': ':0', 14:10:37 INFO - 'HOME': '/home/cltbld', 14:10:37 INFO - 'LANG': 'en_US.UTF-8', 14:10:37 INFO - 'LANGUAGE': 'en_US:en', 14:10:37 INFO - 'LOGNAME': 'cltbld', 14:10:37 INFO - 'MAIL': '/var/mail/cltbld', 14:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:37 INFO - 'MOZ_NO_REMOTE': '1', 14:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:37 INFO - 'NO_EM_RESTART': '1', 14:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:37 INFO - 'PWD': '/builds/slave/test', 14:10:37 INFO - 'SHELL': '/bin/bash', 14:10:37 INFO - 'SHLVL': '1', 14:10:37 INFO - 'TERM': 'linux', 14:10:37 INFO - 'TMOUT': '86400', 14:10:37 INFO - 'USER': 'cltbld', 14:10:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:37 INFO - '_': '/tools/buildbot/bin/python'} 14:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:39 INFO - Installing collected packages: mozsystemmonitor 14:10:39 INFO - Running setup.py install for mozsystemmonitor 14:10:39 INFO - Successfully installed mozsystemmonitor 14:10:39 INFO - Cleaning up... 14:10:39 INFO - Return code: 0 14:10:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:39 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 14:10:39 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 14:10:39 INFO - Using env: {'DISPLAY': ':0', 14:10:39 INFO - 'HOME': '/home/cltbld', 14:10:39 INFO - 'LANG': 'en_US.UTF-8', 14:10:39 INFO - 'LANGUAGE': 'en_US:en', 14:10:39 INFO - 'LOGNAME': 'cltbld', 14:10:39 INFO - 'MAIL': '/var/mail/cltbld', 14:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:39 INFO - 'MOZ_NO_REMOTE': '1', 14:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:39 INFO - 'NO_EM_RESTART': '1', 14:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:39 INFO - 'PWD': '/builds/slave/test', 14:10:39 INFO - 'SHELL': '/bin/bash', 14:10:39 INFO - 'SHLVL': '1', 14:10:39 INFO - 'TERM': 'linux', 14:10:39 INFO - 'TMOUT': '86400', 14:10:39 INFO - 'USER': 'cltbld', 14:10:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:39 INFO - '_': '/tools/buildbot/bin/python'} 14:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:39 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:39 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 14:10:39 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 14:10:39 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 14:10:39 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 14:10:39 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 14:10:39 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 14:10:41 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:41 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 14:10:42 INFO - Downloading docopt-0.6.1.tar.gz 14:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:42 INFO - Running setup.py install for blobuploader 14:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:42 INFO - Running setup.py install for requests 14:10:42 INFO - Running setup.py install for docopt 14:10:42 INFO - Successfully installed blobuploader requests docopt 14:10:42 INFO - Cleaning up... 14:10:42 INFO - Return code: 0 14:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:42 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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:42 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 14:10:42 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 14:10:42 INFO - Using env: {'DISPLAY': ':0', 14:10:42 INFO - 'HOME': '/home/cltbld', 14:10:42 INFO - 'LANG': 'en_US.UTF-8', 14:10:42 INFO - 'LANGUAGE': 'en_US:en', 14:10:42 INFO - 'LOGNAME': 'cltbld', 14:10:42 INFO - 'MAIL': '/var/mail/cltbld', 14:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:42 INFO - 'MOZ_NO_REMOTE': '1', 14:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:42 INFO - 'NO_EM_RESTART': '1', 14:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:42 INFO - 'PWD': '/builds/slave/test', 14:10:42 INFO - 'SHELL': '/bin/bash', 14:10:42 INFO - 'SHLVL': '1', 14:10:42 INFO - 'TERM': 'linux', 14:10:42 INFO - 'TMOUT': '86400', 14:10:42 INFO - 'USER': 'cltbld', 14:10:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:42 INFO - '_': '/tools/buildbot/bin/python'} 14:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:42 INFO - Running setup.py (path:/tmp/pip-Lp_nPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:43 INFO - Running setup.py (path:/tmp/pip-37__0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:43 INFO - Running setup.py (path:/tmp/pip-w5Q4xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:43 INFO - Running setup.py (path:/tmp/pip-X5ZZEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:43 INFO - Running setup.py (path:/tmp/pip-0dXg3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:43 INFO - Running setup.py (path:/tmp/pip-5DY1v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:43 INFO - Running setup.py (path:/tmp/pip-lJ6Ehk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:43 INFO - Running setup.py (path:/tmp/pip-1f4KmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:43 INFO - Running setup.py (path:/tmp/pip-xgA8KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:43 INFO - Running setup.py (path:/tmp/pip-ykjc3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:43 INFO - Running setup.py (path:/tmp/pip-XAHn2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:43 INFO - Running setup.py (path:/tmp/pip-dKterF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:43 INFO - Running setup.py (path:/tmp/pip-pyRWnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:43 INFO - Running setup.py (path:/tmp/pip-EtoZGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:43 INFO - Running setup.py (path:/tmp/pip-X2wJwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:44 INFO - Running setup.py (path:/tmp/pip-iaSxY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:44 INFO - Running setup.py (path:/tmp/pip-LmKmXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:44 INFO - Running setup.py install for manifestparser 14:10:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozcrash 14:10:44 INFO - Running setup.py install for mozdebug 14:10:44 INFO - Running setup.py install for mozdevice 14:10:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozfile 14:10:44 INFO - Running setup.py install for mozhttpd 14:10:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozinfo 14:10:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozInstall 14:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:44 INFO - Running setup.py install for mozleak 14:10:45 INFO - Running setup.py install for mozlog 14:10:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for moznetwork 14:10:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozprocess 14:10:45 INFO - Running setup.py install for mozprofile 14:10:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozrunner 14:10:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Running setup.py install for mozscreenshot 14:10:45 INFO - Running setup.py install for moztest 14:10:45 INFO - Running setup.py install for mozversion 14:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:45 INFO - Cleaning up... 14:10:45 INFO - Return code: 0 14:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:45 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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:45 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 14:10:45 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 14:10:45 INFO - Using env: {'DISPLAY': ':0', 14:10:45 INFO - 'HOME': '/home/cltbld', 14:10:45 INFO - 'LANG': 'en_US.UTF-8', 14:10:45 INFO - 'LANGUAGE': 'en_US:en', 14:10:45 INFO - 'LOGNAME': 'cltbld', 14:10:45 INFO - 'MAIL': '/var/mail/cltbld', 14:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:45 INFO - 'MOZ_NO_REMOTE': '1', 14:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:45 INFO - 'NO_EM_RESTART': '1', 14:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:45 INFO - 'PWD': '/builds/slave/test', 14:10:45 INFO - 'SHELL': '/bin/bash', 14:10:45 INFO - 'SHLVL': '1', 14:10:45 INFO - 'TERM': 'linux', 14:10:45 INFO - 'TMOUT': '86400', 14:10:45 INFO - 'USER': 'cltbld', 14:10:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:46 INFO - '_': '/tools/buildbot/bin/python'} 14:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:46 INFO - Running setup.py (path:/tmp/pip-64Wixq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:46 INFO - Running setup.py (path:/tmp/pip-_INZH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:46 INFO - Running setup.py (path:/tmp/pip-1wehuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:46 INFO - Running setup.py (path:/tmp/pip-Q1dO_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:46 INFO - Running setup.py (path:/tmp/pip-9Ayst1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:46 INFO - Running setup.py (path:/tmp/pip-BX9QV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:46 INFO - Running setup.py (path:/tmp/pip-90YHFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:46 INFO - Running setup.py (path:/tmp/pip-rNnaj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:46 INFO - Running setup.py (path:/tmp/pip-xqQKsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:46 INFO - Running setup.py (path:/tmp/pip-_W7Oxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:46 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)) 14:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:46 INFO - Running setup.py (path:/tmp/pip-tZUhsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:47 INFO - Running setup.py (path:/tmp/pip-D6ACKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:47 INFO - Running setup.py (path:/tmp/pip-rk9l0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:47 INFO - Running setup.py (path:/tmp/pip-nYRC15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:47 INFO - Running setup.py (path:/tmp/pip-2i_V3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:47 INFO - Running setup.py (path:/tmp/pip-_eWX1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:47 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)) 14:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:47 INFO - Running setup.py (path:/tmp/pip-oH6Nrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:47 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)) 14:10:47 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)) 14:10:47 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)) 14:10:47 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)) 14:10:47 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)) 14:10:47 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)) 14:10:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - Downloading blessings-1.6.tar.gz 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:49 INFO - Installing collected packages: blessings 14:10:49 INFO - Running setup.py install for blessings 14:10:49 INFO - Successfully installed blessings 14:10:49 INFO - Cleaning up... 14:10:49 INFO - Return code: 0 14:10:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:49 INFO - Reading from file tmpfile_stdout 14:10:49 INFO - Current package versions: 14:10:49 INFO - argparse == 1.2.1 14:10:49 INFO - blessings == 1.6 14:10:49 INFO - blobuploader == 1.2.4 14:10:49 INFO - docopt == 0.6.1 14:10:49 INFO - manifestparser == 1.1 14:10:49 INFO - mozInstall == 1.12 14:10:49 INFO - mozcrash == 0.17 14:10:49 INFO - mozdebug == 0.1 14:10:49 INFO - mozdevice == 0.48 14:10:49 INFO - mozfile == 1.2 14:10:49 INFO - mozhttpd == 0.7 14:10:49 INFO - mozinfo == 0.9 14:10:49 INFO - mozleak == 0.1 14:10:49 INFO - mozlog == 3.2 14:10:49 INFO - moznetwork == 0.27 14:10:49 INFO - mozprocess == 0.22 14:10:49 INFO - mozprofile == 0.28 14:10:49 INFO - mozrunner == 6.11 14:10:49 INFO - mozscreenshot == 0.1 14:10:49 INFO - mozsystemmonitor == 0.3 14:10:49 INFO - moztest == 0.7 14:10:49 INFO - mozversion == 1.4 14:10:49 INFO - psutil == 3.1.1 14:10:49 INFO - requests == 1.2.3 14:10:49 INFO - wsgiref == 0.1.2 14:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:49 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')]} 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 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')]} 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:49 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 14:10:49 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 14:10:49 INFO - Using env: {'DISPLAY': ':0', 14:10:49 INFO - 'HOME': '/home/cltbld', 14:10:49 INFO - 'LANG': 'en_US.UTF-8', 14:10:49 INFO - 'LANGUAGE': 'en_US:en', 14:10:49 INFO - 'LOGNAME': 'cltbld', 14:10:49 INFO - 'MAIL': '/var/mail/cltbld', 14:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:49 INFO - 'MOZ_NO_REMOTE': '1', 14:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:49 INFO - 'NO_EM_RESTART': '1', 14:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:49 INFO - 'PWD': '/builds/slave/test', 14:10:49 INFO - 'SHELL': '/bin/bash', 14:10:49 INFO - 'SHLVL': '1', 14:10:49 INFO - 'TERM': 'linux', 14:10:49 INFO - 'TMOUT': '86400', 14:10:49 INFO - 'USER': 'cltbld', 14:10:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:49 INFO - '_': '/tools/buildbot/bin/python'} 14:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 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)) 14:10:50 INFO - Cleaning up... 14:10:50 INFO - Return code: 0 14:10:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:50 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')]} 14:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:50 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')]} 14:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:50 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 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10:50 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 14:10:50 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 14:10:50 INFO - Using env: {'DISPLAY': ':0', 14:10:50 INFO - 'HOME': '/home/cltbld', 14:10:50 INFO - 'LANG': 'en_US.UTF-8', 14:10:50 INFO - 'LANGUAGE': 'en_US:en', 14:10:50 INFO - 'LOGNAME': 'cltbld', 14:10:50 INFO - 'MAIL': '/var/mail/cltbld', 14:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:50 INFO - 'MOZ_NO_REMOTE': '1', 14:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:50 INFO - 'NO_EM_RESTART': '1', 14:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:50 INFO - 'PWD': '/builds/slave/test', 14:10:50 INFO - 'SHELL': '/bin/bash', 14:10:50 INFO - 'SHLVL': '1', 14:10:50 INFO - 'TERM': 'linux', 14:10:50 INFO - 'TMOUT': '86400', 14:10:50 INFO - 'USER': 'cltbld', 14:10:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:50 INFO - '_': '/tools/buildbot/bin/python'} 14:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:50 INFO - Downloading/unpacking jsonschema 14:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:52 INFO - Downloading/unpacking functools32 (from jsonschema) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:52 INFO - warning: no files found matching '*.txt' 14:10:52 INFO - no previously-included directories found matching 'build' 14:10:52 INFO - no previously-included directories found matching 'dist' 14:10:52 INFO - no previously-included directories found matching '.git*' 14:10:52 INFO - Installing collected packages: jsonschema, functools32 14:10:52 INFO - Running setup.py install for functools32 14:10:52 INFO - warning: no files found matching '*.txt' 14:10:52 INFO - no previously-included directories found matching 'build' 14:10:52 INFO - no previously-included directories found matching 'dist' 14:10:52 INFO - no previously-included directories found matching '.git*' 14:10:52 INFO - Successfully installed jsonschema functools32 14:10:52 INFO - Cleaning up... 14:10:52 INFO - Return code: 0 14:10:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b7e91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1164770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, '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': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', '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 14:10: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', 'flake8'] in /builds/slave/test/build 14:10: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 flake8 14:10:52 INFO - Using env: {'DISPLAY': ':0', 14:10:52 INFO - 'HOME': '/home/cltbld', 14:10:52 INFO - 'LANG': 'en_US.UTF-8', 14:10:52 INFO - 'LANGUAGE': 'en_US:en', 14:10:52 INFO - 'LOGNAME': 'cltbld', 14:10:52 INFO - 'MAIL': '/var/mail/cltbld', 14:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:52 INFO - 'MOZ_NO_REMOTE': '1', 14:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:52 INFO - 'NO_EM_RESTART': '1', 14:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:52 INFO - 'PWD': '/builds/slave/test', 14:10:52 INFO - 'SHELL': '/bin/bash', 14:10:52 INFO - 'SHLVL': '1', 14:10:52 INFO - 'TERM': 'linux', 14:10:52 INFO - 'TMOUT': '86400', 14:10:52 INFO - 'USER': 'cltbld', 14:10:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:52 INFO - '_': '/tools/buildbot/bin/python'} 14:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:52 INFO - Downloading/unpacking flake8 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:10:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:10:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:10:55 INFO - no previously-included directories found matching 'docs/_build' 14:10:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:10:55 INFO - Running setup.py install for pep8 14:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:10:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:10:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:10:55 INFO - no previously-included directories found matching 'docs/_build' 14:10:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:10:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:10:55 INFO - Cleaning up... 14:10:55 INFO - Return code: 0 14:10:55 INFO - Running post-action listener: _resource_record_post_action 14:10:55 INFO - Running post-action listener: _start_resource_monitoring 14:10:55 INFO - Starting resource monitoring. 14:10:55 INFO - ##### 14:10:55 INFO - ##### Finished create-virtualenv step (success) 14:10:55 INFO - ##### 14:10:55 INFO - ##### 14:10:55 INFO - ##### Running install step. 14:10:55 INFO - ##### 14:10:55 INFO - Running pre-action listener: _resource_record_pre_action 14:10:55 INFO - Running main action method: install 14:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:55 INFO - Reading from file tmpfile_stdout 14:10:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:56 INFO - Reading from file tmpfile_stdout 14:10:56 INFO - Output received: 14:10:56 INFO - Usage: mozinstall [options] installer 14:10:56 INFO - Options: 14:10:56 INFO - -h, --help show this help message and exit 14:10:56 INFO - -d DEST, --destination=DEST 14:10:56 INFO - Directory to install application into. [default: 14:10:56 INFO - "/builds/slave/test"] 14:10:56 INFO - --app=APP Application being installed. [default: firefox] 14:10:56 INFO - mkdir: /builds/slave/test/build/application 14:10:56 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'] 14:10:56 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 14:11:12 INFO - Reading from file tmpfile_stdout 14:11:12 INFO - Output received: 14:11:12 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:12 INFO - Running post-action listener: _resource_record_post_action 14:11:12 INFO - ##### 14:11:12 INFO - ##### Finished install step (success) 14:11:12 INFO - ##### 14:11:12 INFO - ##### 14:11:12 INFO - ##### Running run-tests step. 14:11:12 INFO - ##### 14:11:12 INFO - Running pre-action listener: _resource_record_pre_action 14:11:12 INFO - Running main action method: run_tests 14:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:12 INFO - Python 2.7.3 14:11:12 INFO - Return code: 0 14:11:12 INFO - grabbing minidump binary from tooltool 14:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:12 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 0x11f39c0>, '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 0x11f48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:12 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 14:11:12 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 14:11:12 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 14:11:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:12 INFO - Return code: 0 14:11:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:13 INFO - Return code: 0 14:11:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:11:13 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1464642079.241830-978779595', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:11:13 INFO - mozversion application_buildid: 20160530113034 14:11:13 INFO - mozversion application_changeset: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a 14:11:13 INFO - mozversion application_display_name: Nightly 14:11:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:13 INFO - mozversion application_name: Firefox 14:11:13 INFO - mozversion application_remotingname: firefox 14:11:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:13 INFO - mozversion application_vendor: Mozilla 14:11:13 INFO - mozversion application_version: 49.0a1 14:11:13 INFO - mozversion platform_buildid: 20160530113034 14:11:13 INFO - mozversion platform_changeset: 5c8f09493cadc33fc6aa05f52cabbabb15b9593a 14:11:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:13 INFO - mozversion platform_version: 49.0a1 14:11:13 INFO - using testdate: 1464642673 14:11:13 INFO - actual date: 1464642673 14:11:13 INFO - starting webserver on 'localhost:35761' 14:11:13 INFO - SUITE-START | Running 2 tests 14:11:13 INFO - TEST-START | dromaeo_css 14:11:13 INFO - operating with platform_type : linux_ 14:11:13 INFO - Initialising browser for dromaeo_css test... 14:11:14 INFO - TEST-INFO | started process 22137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGnOwA/profile http://localhost:35761/getInfo.html) 14:11:18 INFO - PROCESS | 22137 | __metrics Screen width/height:1600/1200 14:11:18 INFO - PROCESS | 22137 | colorDepth:24 14:11:18 INFO - PROCESS | 22137 | Browser inner width/height: 1024/697 14:11:18 INFO - PROCESS | 22137 | __metrics 14:11:19 ERROR - PROCESS | 22137 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:11:20 INFO - TEST-INFO | 22137: exit 0 14:11:20 INFO - Browser initialized. 14:11:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:20 INFO - TEST-INFO | started process 22258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGnOwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:32 INFO - PROCESS | 22258 | RSS: Main: 166883328 14:11:32 INFO - PROCESS | 22258 | 14:12:21 INFO - PROCESS | 22258 | 1464642741665 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] 14:14:28 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35761/tests/dromaeo/cssquery-ext.html) 14:14:30 INFO - PROCESS | 22258 | RSS: Main: 171384832 14:14:30 INFO - PROCESS | 22258 | 14:17:32 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-ext.html (next: http://localhost:35761/tests/dromaeo/cssquery-jquery.html) 14:17:32 INFO - PROCESS | 22258 | RSS: Main: 169607168 14:17:32 INFO - PROCESS | 22258 | 14:20:34 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35761/tests/dromaeo/cssquery-mootools.html) 14:20:35 INFO - PROCESS | 22258 | RSS: Main: 171044864 14:20:35 INFO - PROCESS | 22258 | 14:23:37 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35761/tests/dromaeo/cssquery-prototype.html) 14:23:37 INFO - PROCESS | 22258 | RSS: Main: 168300544 14:23:37 INFO - PROCESS | 22258 | 14:26:40 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35761/tests/dromaeo/cssquery-yui.html) 14:26:40 INFO - PROCESS | 22258 | RSS: Main: 170127360 14:26:40 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | Cycle 1(1): loaded http://localhost:35761/tests/dromaeo/cssquery-yui.html (next: http://localhost:35761/tests/dromaeo/cssquery-dojo.html) 14:29:43 INFO - PROCESS | 22258 | RSS: Main: 171970560 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | __start_tp_report 14:29:43 INFO - PROCESS | 22258 | _x_x_mozilla_page_load 14:29:43 INFO - PROCESS | 22258 | _x_x_mozilla_page_load_details 14:29:43 INFO - PROCESS | 22258 | |i|pagename|runs| 14:29:43 INFO - PROCESS | 22258 | |0;dojo.html;3074.2775447769773;3138.027211564415;3144.103930379842;3154.684531546845;3175;5339.866503337418;5380.677159370441;5411.188321751734;5463.2078348639425;5522.944770552303;5220.738963051851;5377.763114483671;5394.298741163643;5433.293671822667;5563.165525171226;4845.588125009378;4874.341963834872;4950.925736113961;4952.108620448318;5020;802.1416959567287;4784.1149387363275;4879.634027447955;4915.213565829468;4931.852044438655;4903.239997800329;4963.925541116868;4971.080350135237;4979.775910084055;4992.750362481879;4990.3762029746285;4996.200607902718;5009.949900501021;5022.1211288024815;5039.09296326661;4841.951580484185;4890.5109489051165;4893.510648935114;4924.679895806761;4927.630427717935;5291.85055015276;5322.308099947021;5356.035913535562;5386.8383948481605;5387.838364849061;5535.529479994206;5746.425357464262;5751.741171647286;5769.480746732815;5800.361960184377;5838.766449342022;5883.23517942669;5900.291964964189;5925.940740592582;5996.880062398727;5455.863603409907;5480.068388373946;5486.670799751988;5512.972435137839;5543.057680194336;5678.176664383724;5903.616264942765;5972.343042265347;5981.5214782817275;5992.460678538952;5678.261825962599;5692.6299790513485;5704.4295570443455;5704.857378565569;5717.313922329347;5773.5958482906635;5774.2782152230975;5783.797567085132;5809;5813.709314534256;5590.580706447033;5749.195112684228;5769.249997500298;5839.357670656224;5865.325487568899;5755.827325180251;5786.739596718157;5817.185594016841;5821.359650438449;5821.941780582225;4308.159908817751;4312.913741725148;4372.540883207281;4392;4417.690761646718;3777.338965680995;3811.9237615248094;3844.058205739556;3868.129670824042;3935.114599215211;5520.089185284463;5570.972145139248;5614.29821272341;5650.039493286151;5651.971740141273;5879.3826648202175;5902.1146827976145;5928.407159284037;5936.347001829795;5948.405159484017;5362.892742145214;5480.177973303957;5513.062779327524;5557.972210139004;5567.721613919288;5000.874978125576;5011.6241281904;5019.899602007939;5031.371078615173;5058.317127187783;5795.362510123883;6027.156198132265;6039.7282122304605;6051.213342265477;6061.696915154224;5752.712364381848;5774.624649397776;5782.5373970081455;5847.1229315603;5850.063989761617;6019.87960240784;6038.758449661965;6050.062240352752;6056.757729690763;6103.6032657877095;5538.809156031472;5631.943680563306;5770.913436298543;5779.739911703899;5780.479756821906;5806.390329015392;5823.912641310299;5903.498202652822;5912.260967379078;5993.700314984146;5723.656580605177;5738.053221218453;5748.597598168088;5791.449812267828;5792.855178620568;5497.175423686479;5638.746256418389;5687;5756.683382414008;5770.5095066919785;5621.971890140523;5654.660720356792;5658.490735833795;5683.943160568341;5706.029974904193;5746.454086861741;5771.278590176228;5784.595078344644;5814.360420353673;5821.912671309849;5434.347878254634;5442.292501974718;5524.033294173423;5558.305211848519;5635.605507614591 14:29:43 INFO - PROCESS | 22258 | |1;ext.html;583.6877270660198;611.3794498583937;621.4717490133387;624.5191202773863;652.399792191184;38194.427083593735;42648.78675606621;42754.35868461976;42804.14391712164;42824.929376765554;43922.12155756883;44148.11703765931;44402.333964990474;44425.55574444254;44452;8648.35137364697;8782.38523303369;8808;8810.471371717686;8833.514156721378;8454.87317690235;8583.828323433527;8680.262177714902;8709.782255443633;8722.30221582275;8683.175098365646;8700.086490918457;8712.912870871274;8728.650853965833;8730.650773969033;8696.478211307342;8731.170538798804;8732.956335218316;8770.210681038674;8802.64789408423;8673.176048275403;8684.956575217147;8743.868841967376;8788.736337909873;8794.956025219833;39955.40066898999;40188.196236075404;40293.59706402928;40412.59587404118;40477.595224047975;2934.444744285532;3161.715445609906;3194.2014496375905;3251.3497300539752;3363.461846104636;28412.431751365064;28625.14124576266;30706.692933070608;31131.37737245265;31689.04932852018;4064.6748260139416;4068.7151899367054;4085.673146148301;4089.5297040840387;4223.64099051581;289593;291732;293912;295593.99999999785;296230;34210.14474638154;34645.480317795256;34655.653443465744;34778.82610586931;34821.82589087039;35569.64430355663;35700;36596.08509787277;36677.44983825245;37855.81072094622;16679.24943377551;16862.915685421496;16890.239939202766;16926.91536542334;16928.40750573724;12851.614451566282;12930.353482326034;12936.611901642966;12956.740865182643;12962.675933101747;19648.70526942097;19668.131527504866;19744;19819.603607927762;19845.106970186378;7238.167610724834;7325.450591205681;7389.66746496409;7405.703771849174;7568.3945284378215;943.5706753427174;978.3933960944117;1097.846301517788;1103.6523495099018;1119.7424592343643;32503.674963250538;32904.67095329064;32969;33107.172320692174;33418.49872251918;1101.3997371432588;1119;1120.4789772755707;1141.5490881102085;1212.763511115324;16761.83238167627;17240.65518689619;17308.221130049176;17330.133493325284;17413.129343533026;534862;541479;544367;544561;545074;58760.7061964696;59436;59447.702761486784;61850;63742.6812865942;1388.9166650001032;1428.2144820348767;1434.4405681784112;1438.467766926223;1438.6187660269827;31541.36917261596;33292.33415331631;33315.83342083274;33362.66637333693;33458.832705836314;48001.51998479971;48020.27969580529;48059.27911081407;48229.75885120552;48657;498963;510411;510451;514330;517620;27892.860535697193;27978.720212797612;28130.2967425816;28150;28330.433391331644;46227.76886115548;46467;47600.523994759606;48452.273215902496;48600.270995935796;39534.40698389469;40892.38661420141;41522.584774151874;41869.79065104655;42917;41038.79480602578;41048.79475602603;41054;41353.379699303936;41403;39708.60291397049;40705.38941915814;40769;41549.1690166201;41702;34168.658313417545;36650.633493664725;36742;36904.63095369012;37144.442833358065;27710.44579108447;28042.756579473185;28374.290642734097;28381.716182837907;28385.85807071034 14:29:43 INFO - PROCESS | 22258 | |2;jquery.html;364.32963347440705;380.6480878843463;400.96591789697874;402.6859049941046;412.06461332774586;17923.103844807756;19066.42800715977;19368.418947431564;19403.12685929133;19447.31934382297;18220;18231.27074917005;18538.53653658659;19240.134193961272;19342.742721723112;5512.751926163312;5514.531264842493;5620.57845661575;5709.714514274269;5716.1711551824965;5633.042382794914;5640.887182256373;5643.943560564403;5647.068233741448;5713.514351280146;5637.661740295595;5652.689102099383;6620.3710647488415;7009.474289428288;7052.118485189351;6925.37671609555;6936.861262774742;7058.505904586681;7394.852102957964;7489.9251007489775;6872.244053154149;7117.75087871922;7136.3220494052985;7181.712731490734;7203.963980180118;25395.492090158277;25584.10455634044;25959.610605840928;27063.45873082547;27251.182464526097;2265.2071774878827;2326.3951372643064;2342.5666251743482;2512.5477414065463;2555.3739333863136;15698.450554230547;15978.840211597852;16180.838191618051;16309.51071467846;16310.83689163105;2044.9386518404472;2147.6349020666526;2184.0936011555186;2225.721784776903;2253.740819805727;97130;102807.48596256971;102889.48555257176;102889.94220115556;104272;14136.166253101832;17536.29854805819;18554.44336669902;18575.72136417955;18610.720839187423;33350.66649333476;33818.830905845316;33968.49047264293;33981.32037359239;34208.48687269693;10019;10039.598416063422;10169.389836609827;10183.745406364753;10431.11335536488;8584.828303433897;8608.956955215184;8612.698555550525;8644;8751.474911505331;9025.774355641162;9027.14242146995;9070.18368346852;9293;9384.343095983215;3298.5546951161764;3315.3523247350095;3477.9677484917415;3497.283056973365;3646.872359467406;884.6682494064726;997.3467378866709;1010.9183174003746;1051.9894801052044;1085.647164671485;18454.723179152323;18892.244310227437;19234.519137021685;19247.711284330748;19346.709799353022;952.2667545989549;972.7713987212999;997.6607953295915;999.2905037423366;1110.3781882146025;10508.842367364496;10854.29447085937;10873.619423320304;10928.672139835817;10931.890681093088;361129;366041;366135;498119;498388;72243;97725;100127.49936250273;102056.48971755094;107107;468.8312207605259;489.67191981373276;492.58622756884387;493.52621483375646;494.9356583644175;10969.561217551209;11285.871412858649;11456.656300311004;11562.190646654653;11584.536618535165;40980.38529422002;42943.78528107465;43023.35464968091;43250.78374608107;44327.11345773131;57206.56983575444;57210.71394643;58130;58269.70865145647;58366;8548.829023419621;8556.358273129665;8701.695440659547;8816.955915220382;8884.156005179497;9513.66702165421;13090.410931507915;13169.275689837152;13379.464821407424;13447.103739072329;6586.80239592813;8451.408401411842;11548.364839933884;11599.362035088152;11863.881361186277;11421.14341424413;11480.712982175512;11598;11785.351805650429;11980.341081240615;11945.940270298594;11985.400729963641;12101.394930253276;12180.390980451119;12215.450304736485;8872.556372181236;8911.777205569913;9001.594928228114;9011.819763604823;9244.630214791334;11585.304881707125;11741.882581174079;11924.224925379822;11968.880311196777;12021.639350819489 14:29:43 INFO - PROCESS | 22258 | |3;mootools.html;1451.2816156002773;1498.0637101811367;1599.9040057596544;1820.217306558181;1856.7214917762326;7849;8605.268552173073;8769.56152192391;9347.906520934781;9359.6256149754;8580.270676992448;8620.051794302637;8818.91181088189;8824.60289286982;8847.159519845605;2312.4103353644796;2318.814494840417;2340.3330050935488;2348.542034303303;2355.9057637694473;2229;2235.418791114314;2263.309690544383;2285.565742508918;2286.1769762885347;2353.329301149173;2354.376090336062;2368.846025008369;2374.988125059372;2386.713594368678;2216.257553719498;2234.8994295256753;2253.0424569558036;2255.7180352456026;2266.6033444147292;2320.709911261092;2342.0280583557974;2352;2360.0795689680867;2369.3958040699686;8746.300295976307;8872.11278872114;8884.289256859436;8890.333225008086;8903.10968903111;5307.734613269321;5463.071277882769;5516.9448305516835;5517.2551705519645;5518.420565840609;3128.749700023993;3289.1283809790425;3339.699427051577;3351.5140304655934;3361;1057.5822550092748;1094.688013916038;1111.6160380326464;1112.2214449885032;1122.4724379541683;12809.743805123846;12905.870941290561;12916.160449570842;12925.418356173996;12934.611961641165;4750.738709371018;4752.669252609275;4756.505220374944;4806.158922188673;4833.371661683958;10743.677689669323;10849.67450976472;10870.456477176109;10888.455577221108;10904.78190436187;5432.619716619878;5459.563234941195;5512.751926163332;5513.9448605514235;5516.724163791794;4300.677449191323;4743.644226683013;4849.2726091085915;4907.975460122677;4950.752462376867;3795.9240815184094;3944.3097457944746;4078.225137223918;4097.467329247238;4100.487439070116;1231.2858542045592;1244.4524409260077;1245.1781823996118;1248.843894513186;1257.0509265504668;889.954303693158;895.7088946092546;957.2916042128913;995.8207522645848;1023.0638965346625;5847.239858818326;5975.103734439869;5993.910091348634;6088.014439713239;6131.233595800525;908.922741566961;941.6939494664261;947.1664934857281;975.512243878061;1005.8239808033564;4156.25187466259;4203.180379825904;4228;4247.915041699149;4262.680298977589;11284.32294062359;11647.41762911868;11648.88351116495;11736.530538778525;11758.706032349088;11476.655700329004;11537.942310288563;11548.364839933716;11554.711132221593;11565.710857228636;7977.680892764224;8187.71343002992;8476.321894248445;8514.361422893184;8526.360522960802;5857.297124345106;5867.20792692998;5939.762409503572;5950.6132101415005;6052.303985041776;10424.374537527772;10488.528016239135;10582.417967011888;10583.206259530412;10625.468726563486;10515.57937682484;10617.628383006559;10617.840732389175;10765.3540787553;10769;7264.636768161677;7822.178671239438;7965.402594805529;8010.758332458478;8148.674053037812;8688.565571721263;8743.519106448952;8786.209241168326;8859.06979767115;8883.200511953955;7506.437017223621;7511;7631;7633.465657403928;7860.253275938777;7524.849503010018;7599.506032107895;7604.277593628596;7646.655900484603;7710.036245469317;7013.649317534205;7079.787606371817;7083.645817709197;7157.642117894188;7168.749093781693;5068.417132029864;5121.308623335951;5145.92281115776;5286.709230992333;5340.092184328596;5175.792968281377;5242.449542797951;5259.8422047338645;5304.469553044664;5308.548773354308 14:29:43 INFO - PROCESS | 22258 | |4;prototype.html;314.1737231082255;321.8680341060164;331.8854995026715;334.50827283892676;335.54198519021537;5524.806631767879;5586.608937374385;5675.943240567593;5680.9431905680985;5744.7989320373745;5534.501894829465;5554.750036248369;5572.746132120271;5594.636348637336;5599.916001259984;4263.126059157865;4269.530351661315;4279.7218180818145;4284.764337961411;4311.590398912098;4062.512498500184;4253.595908388698;4284.7429154250685;4288.185244803493;4300.956990430102;4159.188958153161;4184.28867092595;4246.363045543162;4256.872293831175;4258.5954334338185;4231.767252801094;4235.661147108255;4241.34259189826;4250.979764856443;4258.574142585748;3666.9083272918124;3672.8347224374966;3678.6873115785193;3714.5542534895717;3757.981210093932;5341.359036915556;5418.211990043315;5426.8914621707345;5434.891302173974;5448.618596698233;5008.6744361616375;5022.221555658879;5026.346574945271;5027.899442011176;5042.445331013586;5521.1442226454965;5854.736536855852;5870.706464676792;5878.354060862923;5894.764209431618;4147.564505726886;4156.8129434175235;4162.937555936664;4179.373094035888;4182.581741825793;5893.5579831512805;6103.56566206941;6157.692115394212;6177.505799536027;6198.016634676906;4193.685473589493;4201.2017716633745;4210.242156411875;4213.052063285736;4221.936670949938;4234.915301694011;4244.38456423823;4268.65537355732;4282.329891342379;4297.3768803523935;4801.479223407739;4873.837849637332;4889.217725163957;4908.214685650279;4965.435887695365;5872.265966754156;5874.647521148745;5885.411458854081;5897.496138484659;5902;1519.688463864905;1531.4257153567412;1543.6295289130528;1544.6910617876244;1544.7451170556733;929.5723966975268;975.9167324270054;982.6708052802248;986.5461887531673;988.3822610868208;5029.82395616159;5038.823641172541;5093.414257360451;5098.286239926413;5174.6119041071315;5341.278927344836;5385.976664433823;5407.432219616883;5467.917981230285;5477.45225477457;4969.180085285887;5048.138174296666;5162.870928226825;5170.1986192140275;5193.39004908472;2904.968736098697;2919.489089409345;2934.383779406306;2952.641784779026;2962.859299169835;5585.609007369445;5635.886542546545;5640.774369025193;5653.378128405872;5667.838093190886;5181.766820493087;5399.352077750695;5476.247600767796;5517.834464966058;5524.640898341595;5527.032769265363;5536.252605898152;5551.500364967173;5585.273914391184;5604.41153678866;5196.870078248074;5289.259503669567;5339.958708052048;5351.384590772111;5459.863503412446;5365.658585353505;5366.182754053997;5394.865128371822;5413.7834486620095;5430.755615997368;6086.452219300284;6115.235595550556;6260.561760676891;6288.717007734572;6297.244330680348;4345.934810977775;4363.847265345697;4389.18800021997;4391.956080439282;4411.426514553087;5936.766395284847;5982.940170598413;6000.609960352563;6092.725827337869;6129.816105516842;5862.824115276549;5900.757712069386;5930.673812940157;5947.6431414115295;5958.493528049991;5878.970605147118;5906.468417842415;5922.55580831448;5952.315483719428;5955.285365756137;5600.831975040755;5808.535317174531;5817.621854579439;5827.650340979555;5835.79574714883;5976.402359763989;5987.910181347196;6008.939910600838;6024.789132380346;6087.604305720114;5728.598998070095;5765.423457654201;5774.509166720875;5870.853228669147;5908.143319218775 14:29:43 INFO - PROCESS | 22258 | |5;yui.html;752.7929819299692;777.9222077792219;781.1641543548403;844.0841686769854;845.4631309118707;14197.503087391944;14808.777868331958;14966.176860272693;14977.47578834741;14987.175705336202;13552.932235338809;13600.659983500418;13601.863981360184;13619.727605447884;13625.727485450285;668.8194187569353;786.9842603147948;788.8225149341409;794.7695168401157;803.6423791412824;810.7527204202715;813.4102775487784;814.3851392198882;815.2703330519182;817.2930415190847;863.5250612163317;866.8526350520426;868.4658934755143;869.9608517616722;871.1419252036738;840.6007146605375;854.9572521373907;855.9914400855974;856.1780690537092;859.179483593167;617.882602305565;620.1008537620469;621.3382747374033;622.1569772957668;623.5759683415275;14212.360443779951;14261.572152835432;14353.067050641675;14378.568642940729;14430.20633865137;14016.299185040707;14085.718285634332;14151.575452736435;14279.57161285163;14300;11815.446740032172;11902.694177422403;11973.820392694117;11987.94006029973;12164.330961797097;3757.755745876537;3859.9421008684894;3863.7102217333813;3895.7857317847506;3953.743006704584;63060;66473.66763166153;67071.66464167697;67131;68275.65862170658;10484.790304194026;10786.137109031259;10831.891681083089;10995.230333876552;10995.780084398428;16461.753073703905;17014.31942722302;17015.65968680644;17458.738118928228;17652;8440.155984401634;8555.657773688983;8566.400351975302;8623.655053797904;8704.869426958474;4726.172919739032;4727.503612120747;4730.905381892412;4764.927891224516;4822.927656085161;3267.4118658641673;3367.71374433171;3464.1685995361436;3470.5314782504543;3472.871316822043;657.1522735671026;666.4435196610788;667.7495939022866;676.6887231873295;684.2948401004625;692.2143367278176;713.3223437734173;718.3750137380408;737.7971057959104;743.6690672650618;9261.212796912203;9868.753281168028;9960.252981026451;10220.488975551192;10285.948570257251;726.9345758881726;732.7765031665286;736.2048987093925;748.6256871564218;762.4624639629048;4855.368802055781;4901.730404827697;4929.112759703288;4954.256861470808;4961.131801934647;69061;72258.2774172262;73055.26944730485;77396;79163;59222.703886481155;60517;62208.377916221165;62521.68739156275;66017.6699116511;51528.74235628873;56935;58054;58155;59046.40953590409;9711.805763884824;9964.302498825013;10055.798884022131;10172.490490780669;10307.793844122925;37306.440403393426;37471.812640937715;37666.43500347442;37730.62269377271;37879;46808.53191468042;50301.496985031146;50315.496845031084;50815.237771432716;51137.744311278206;13247.403866825824;13337.399817008452;13367.197968121944;13368.331583420984;13459.865401345862;14008.229547374993;14320.57038288853;14368.856311436752;14435.422583096559;14963.850361496246;13529.18824870511;13752.724945501233;13879.583612491642;14007.159570425807;14152.716945661236;13253;13505;13631.727365452438;13700.93149534246;13776.173429594257;13412.865871341162;13442.663933401744;13558.796618050934;13717.725645487233;13879.791803123164;10547.789044219226;10870.248507012204;10874.510647020745;10932.781344372908;11377.772444551229;10313.639022634172;10582.841257380991;10949;10979.945100274448;11462.656120316404 14:29:43 INFO - PROCESS | 22258 | __end_tp_report 14:29:43 INFO - PROCESS | 22258 | __start_cc_report 14:29:43 INFO - PROCESS | 22258 | _x_x_mozilla_cycle_collect,337 14:29:43 INFO - PROCESS | 22258 | __end_cc_report 14:29:43 INFO - PROCESS | 22258 | __startTimestamp1464643783390__endTimestamp 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | ------- Summary: start ------- 14:29:43 INFO - PROCESS | 22258 | Number of tests: 6 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#0] dojo.html Cycles:165 Average:5373.98 Median:5635.61 stddev:726.44 (12.9%) stddev-sans-first:705.91 14:29:43 INFO - PROCESS | 22258 | Values: 3074.3 3138.0 3144.1 3154.7 3175.0 5339.9 5380.7 5411.2 5463.2 5522.9 5220.7 5377.8 5394.3 5433.3 5563.2 4845.6 4874.3 4950.9 4952.1 5020.0 802.1 4784.1 4879.6 4915.2 4931.9 4903.2 4963.9 4971.1 4979.8 4992.8 4990.4 4996.2 5009.9 5022.1 5039.1 4842.0 4890.5 4893.5 4924.7 4927.6 5291.9 5322.3 5356.0 5386.8 5387.8 5535.5 5746.4 5751.7 5769.5 5800.4 5838.8 5883.2 5900.3 5925.9 5996.9 5455.9 5480.1 5486.7 5513.0 5543.1 5678.2 5903.6 5972.3 5981.5 5992.5 5678.3 5692.6 5704.4 5704.9 5717.3 5773.6 5774.3 5783.8 5809.0 5813.7 5590.6 5749.2 5769.2 5839.4 5865.3 5755.8 5786.7 5817.2 5821.4 5821.9 4308.2 4312.9 4372.5 4392.0 4417.7 3777.3 3811.9 3844.1 3868.1 3935.1 5520.1 5571.0 5614.3 5650.0 5652.0 5879.4 5902.1 5928.4 5936.3 5948.4 5362.9 5480.2 5513.1 5558.0 5567.7 5000.9 5011.6 5019.9 5031.4 5058.3 5795.4 6027.2 6039.7 6051.2 6061.7 5752.7 5774.6 5782.5 5847.1 5850.1 6019.9 6038.8 6050.1 6056.8 6103.6 5538.8 5631.9 5770.9 5779.7 5780.5 5806.4 5823.9 5903.5 5912.3 5993.7 5723.7 5738.1 5748.6 5791.4 5792.9 5497.2 5638.7 5687.0 5756.7 5770.5 5622.0 5654.7 5658.5 5683.9 5706.0 5746.5 5771.3 5784.6 5814.4 5821.9 5434.3 5442.3 5524.0 5558.3 5635.6 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#1] ext.html Cycles:180 Average:59471.56 Median:22271.14 stddev:123034.42 (552.4%) stddev-sans-first:123300.12 14:29:43 INFO - PROCESS | 22258 | Values: 583.7 611.4 621.5 624.5 652.4 38194.4 42648.8 42754.4 42804.1 42824.9 43922.1 44148.1 44402.3 44425.6 44452.0 8648.4 8782.4 8808.0 8810.5 8833.5 8454.9 8583.8 8680.3 8709.8 8722.3 8683.2 8700.1 8712.9 8728.7 8730.7 8696.5 8731.2 8733.0 8770.2 8802.6 8673.2 8685.0 8743.9 8788.7 8795.0 39955.4 40188.2 40293.6 40412.6 40477.6 2934.4 3161.7 3194.2 3251.3 3363.5 28412.4 28625.1 30706.7 31131.4 31689.0 4064.7 4068.7 4085.7 4089.5 4223.6 289593.0 291732.0 293912.0 295594.0 296230.0 34210.1 34645.5 34655.7 34778.8 34821.8 35569.6 35700.0 36596.1 36677.4 37855.8 16679.2 16862.9 16890.2 16926.9 16928.4 12851.6 12930.4 12936.6 12956.7 12962.7 19648.7 19668.1 19744.0 19819.6 19845.1 7238.2 7325.5 7389.7 7405.7 7568.4 943.6 978.4 1097.8 1103.7 1119.7 32503.7 32904.7 32969.0 33107.2 33418.5 1101.4 1119.0 1120.5 1141.5 1212.8 16761.8 17240.7 17308.2 17330.1 17413.1 534862.0 541479.0 544367.0 544561.0 545074.0 58760.7 59436.0 59447.7 61850.0 63742.7 1388.9 1428.2 1434.4 1438.5 1438.6 31541.4 33292.3 33315.8 33362.7 33458.8 48001.5 48020.3 48059.3 48229.8 48657.0 498963.0 510411.0 510451.0 514330.0 517620.0 27892.9 27978.7 28130.3 28150.0 28330.4 46227.8 46467.0 47600.5 48452.3 48600.3 39534.4 40892.4 41522.6 41869.8 42917.0 41038.8 41048.8 41054.0 41353.4 41403.0 39708.6 40705.4 40769.0 41549.2 41702.0 34168.7 36650.6 36742.0 36904.6 37144.4 27710.4 28042.8 28374.3 28381.7 28385.9 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#2] jquery.html Cycles:180 Average:28774.09 Median:33584.75 stddev:70747.03 (210.7%) stddev-sans-first:70913.34 14:29:43 INFO - PROCESS | 22258 | Values: 364.3 380.6 401.0 402.7 412.1 17923.1 19066.4 19368.4 19403.1 19447.3 18220.0 18231.3 18538.5 19240.1 19342.7 5512.8 5514.5 5620.6 5709.7 5716.2 5633.0 5640.9 5643.9 5647.1 5713.5 5637.7 5652.7 6620.4 7009.5 7052.1 6925.4 6936.9 7058.5 7394.9 7489.9 6872.2 7117.8 7136.3 7181.7 7204.0 25395.5 25584.1 25959.6 27063.5 27251.2 2265.2 2326.4 2342.6 2512.5 2555.4 15698.5 15978.8 16180.8 16309.5 16310.8 2044.9 2147.6 2184.1 2225.7 2253.7 97130.0 102807.5 102889.5 102889.9 104272.0 14136.2 17536.3 18554.4 18575.7 18610.7 33350.7 33818.8 33968.5 33981.3 34208.5 10019.0 10039.6 10169.4 10183.7 10431.1 8584.8 8609.0 8612.7 8644.0 8751.5 9025.8 9027.1 9070.2 9293.0 9384.3 3298.6 3315.4 3478.0 3497.3 3646.9 884.7 997.3 1010.9 1052.0 1085.6 18454.7 18892.2 19234.5 19247.7 19346.7 952.3 972.8 997.7 999.3 1110.4 10508.8 10854.3 10873.6 10928.7 10931.9 361129.0 366041.0 366135.0 498119.0 498388.0 72243.0 97725.0 100127.5 102056.5 107107.0 468.8 489.7 492.6 493.5 494.9 10969.6 11285.9 11456.7 11562.2 11584.5 40980.4 42943.8 43023.4 43250.8 44327.1 57206.6 57210.7 58130.0 58269.7 58366.0 8548.8 8556.4 8701.7 8817.0 8884.2 9513.7 13090.4 13169.3 13379.5 13447.1 6586.8 8451.4 11548.4 11599.4 11863.9 11421.1 11480.7 11598.0 11785.4 11980.3 11945.9 11985.4 12101.4 12180.4 12215.5 8872.6 8911.8 9001.6 9011.8 9244.6 11585.3 11741.9 11924.2 11968.9 12021.6 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#3] mootools.html Cycles:180 Average:5934.61 Median:4754.59 stddev:3451.80 (72.6%) stddev-sans-first:3445.04 14:29:43 INFO - PROCESS | 22258 | Values: 1451.3 1498.1 1599.9 1820.2 1856.7 7849.0 8605.3 8769.6 9347.9 9359.6 8580.3 8620.1 8818.9 8824.6 8847.2 2312.4 2318.8 2340.3 2348.5 2355.9 2229.0 2235.4 2263.3 2285.6 2286.2 2353.3 2354.4 2368.8 2375.0 2386.7 2216.3 2234.9 2253.0 2255.7 2266.6 2320.7 2342.0 2352.0 2360.1 2369.4 8746.3 8872.1 8884.3 8890.3 8903.1 5307.7 5463.1 5516.9 5517.3 5518.4 3128.7 3289.1 3339.7 3351.5 3361.0 1057.6 1094.7 1111.6 1112.2 1122.5 12809.7 12905.9 12916.2 12925.4 12934.6 4750.7 4752.7 4756.5 4806.2 4833.4 10743.7 10849.7 10870.5 10888.5 10904.8 5432.6 5459.6 5512.8 5513.9 5516.7 4300.7 4743.6 4849.3 4908.0 4950.8 3795.9 3944.3 4078.2 4097.5 4100.5 1231.3 1244.5 1245.2 1248.8 1257.1 890.0 895.7 957.3 995.8 1023.1 5847.2 5975.1 5993.9 6088.0 6131.2 908.9 941.7 947.2 975.5 1005.8 4156.3 4203.2 4228.0 4247.9 4262.7 11284.3 11647.4 11648.9 11736.5 11758.7 11476.7 11537.9 11548.4 11554.7 11565.7 7977.7 8187.7 8476.3 8514.4 8526.4 5857.3 5867.2 5939.8 5950.6 6052.3 10424.4 10488.5 10582.4 10583.2 10625.5 10515.6 10617.6 10617.8 10765.4 10769.0 7264.6 7822.2 7965.4 8010.8 8148.7 8688.6 8743.5 8786.2 8859.1 8883.2 7506.4 7511.0 7631.0 7633.5 7860.3 7524.8 7599.5 7604.3 7646.7 7710.0 7013.6 7079.8 7083.6 7157.6 7168.7 5068.4 5121.3 5145.9 5286.7 5340.1 5175.8 5242.4 5259.8 5304.5 5308.5 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#4] prototype.html Cycles:180 Average:4790.25 Median:5397.11 stddev:1403.44 (26.0%) stddev-sans-first:1366.57 14:29:43 INFO - PROCESS | 22258 | Values: 314.2 321.9 331.9 334.5 335.5 5524.8 5586.6 5675.9 5680.9 5744.8 5534.5 5554.8 5572.7 5594.6 5599.9 4263.1 4269.5 4279.7 4284.8 4311.6 4062.5 4253.6 4284.7 4288.2 4301.0 4159.2 4184.3 4246.4 4256.9 4258.6 4231.8 4235.7 4241.3 4251.0 4258.6 3666.9 3672.8 3678.7 3714.6 3758.0 5341.4 5418.2 5426.9 5434.9 5448.6 5008.7 5022.2 5026.3 5027.9 5042.4 5521.1 5854.7 5870.7 5878.4 5894.8 4147.6 4156.8 4162.9 4179.4 4182.6 5893.6 6103.6 6157.7 6177.5 6198.0 4193.7 4201.2 4210.2 4213.1 4221.9 4234.9 4244.4 4268.7 4282.3 4297.4 4801.5 4873.8 4889.2 4908.2 4965.4 5872.3 5874.6 5885.4 5897.5 5902.0 1519.7 1531.4 1543.6 1544.7 1544.7 929.6 975.9 982.7 986.5 988.4 5029.8 5038.8 5093.4 5098.3 5174.6 5341.3 5386.0 5407.4 5467.9 5477.5 4969.2 5048.1 5162.9 5170.2 5193.4 2905.0 2919.5 2934.4 2952.6 2962.9 5585.6 5635.9 5640.8 5653.4 5667.8 5181.8 5399.4 5476.2 5517.8 5524.6 5527.0 5536.3 5551.5 5585.3 5604.4 5196.9 5289.3 5340.0 5351.4 5459.9 5365.7 5366.2 5394.9 5413.8 5430.8 6086.5 6115.2 6260.6 6288.7 6297.2 4345.9 4363.8 4389.2 4392.0 4411.4 5936.8 5982.9 6000.6 6092.7 6129.8 5862.8 5900.8 5930.7 5947.6 5958.5 5879.0 5906.5 5922.6 5952.3 5955.3 5600.8 5808.5 5817.6 5827.7 5835.8 5976.4 5987.9 6008.9 6024.8 6087.6 5728.6 5765.4 5774.5 5870.9 5908.1 14:29:43 INFO - PROCESS | 22258 | 14:29:43 INFO - PROCESS | 22258 | [#5] yui.html Cycles:180 Average:16295.78 Median:25767.35 stddev:19960.13 (77.5%) stddev-sans-first:19982.00 14:29:43 INFO - PROCESS | 22258 | Values: 752.8 777.9 781.2 844.1 845.5 14197.5 14808.8 14966.2 14977.5 14987.2 13552.9 13600.7 13601.9 13619.7 13625.7 668.8 787.0 788.8 794.8 803.6 810.8 813.4 814.4 815.3 817.3 863.5 866.9 868.5 870.0 871.1 840.6 855.0 856.0 856.2 859.2 617.9 620.1 621.3 622.2 623.6 14212.4 14261.6 14353.1 14378.6 14430.2 14016.3 14085.7 14151.6 14279.6 14300.0 11815.4 11902.7 11973.8 11987.9 12164.3 3757.8 3859.9 3863.7 3895.8 3953.7 63060.0 66473.7 67071.7 67131.0 68275.7 10484.8 10786.1 10831.9 10995.2 10995.8 16461.8 17014.3 17015.7 17458.7 17652.0 8440.2 8555.7 8566.4 8623.7 8704.9 4726.2 4727.5 4730.9 4764.9 4822.9 3267.4 3367.7 3464.2 3470.5 3472.9 657.2 666.4 667.7 676.7 684.3 692.2 713.3 718.4 737.8 743.7 9261.2 9868.8 9960.3 10220.5 10285.9 726.9 732.8 736.2 748.6 762.5 4855.4 4901.7 4929.1 4954.3 4961.1 69061.0 72258.3 73055.3 77396.0 79163.0 59222.7 60517.0 62208.4 62521.7 66017.7 51528.7 56935.0 58054.0 58155.0 59046.4 9711.8 9964.3 10055.8 10172.5 10307.8 37306.4 37471.8 37666.4 37730.6 37879.0 46808.5 50301.5 50315.5 50815.2 51137.7 13247.4 13337.4 13367.2 13368.3 13459.9 14008.2 14320.6 14368.9 14435.4 14963.9 13529.2 13752.7 13879.6 14007.2 14152.7 13253.0 13505.0 13631.7 13700.9 13776.2 13412.9 13442.7 13558.8 13717.7 13879.8 10547.8 10870.2 10874.5 10932.8 11377.8 10313.6 10582.8 10949.0 10979.9 11462.7 14:29:43 INFO - PROCESS | 22258 | -------- Summary: end -------- 14:29:43 INFO - PROCESS | 22258 | 14:29:44 INFO - TEST-INFO | 22258: exit 0 14:29:44 INFO - TEST-OK | dromaeo_css | took 1110132ms 14:29:44 INFO - TEST-START | kraken 14:29:44 INFO - operating with platform_type : linux_ 14:29:44 INFO - Initialising browser for kraken test... 14:29:44 INFO - TEST-INFO | started process 22493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2iq3f/profile http://localhost:35761/getInfo.html) 14:29:48 INFO - PROCESS | 22493 | __metrics Screen width/height:1600/1200 14:29:48 INFO - PROCESS | 22493 | colorDepth:24 14:29:48 INFO - PROCESS | 22493 | Browser inner width/height: 1024/697 14:29:48 INFO - PROCESS | 22493 | __metrics 14:29:49 ERROR - PROCESS | 22493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:29:50 INFO - TEST-INFO | 22493: exit 0 14:29:50 INFO - Browser initialized. 14:29:50 INFO - Running cycle 1/1 for kraken test... 14:29:50 INFO - TEST-INFO | started process 22611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2iq3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:02 INFO - PROCESS | 22611 | RSS: Main: 166940672 14:30:02 INFO - PROCESS | 22611 | 14:30:04 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35761/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:05 INFO - PROCESS | 22611 | RSS: Main: 171393024 14:30:05 INFO - PROCESS | 22611 | 14:30:08 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35761/tests/kraken/driver.html?testName=audio-dft) 14:30:08 INFO - PROCESS | 22611 | RSS: Main: 171532288 14:30:08 INFO - PROCESS | 22611 | 14:30:11 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35761/tests/kraken/driver.html?testName=audio-fft) 14:30:12 INFO - PROCESS | 22611 | RSS: Main: 166416384 14:30:12 INFO - PROCESS | 22611 | 14:30:14 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35761/tests/kraken/driver.html?testName=audio-oscillator) 14:30:15 INFO - PROCESS | 22611 | RSS: Main: 167178240 14:30:15 INFO - PROCESS | 22611 | 14:30:17 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:18 INFO - PROCESS | 22611 | RSS: Main: 167600128 14:30:18 INFO - PROCESS | 22611 | 14:30:21 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35761/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:21 INFO - PROCESS | 22611 | RSS: Main: 168431616 14:30:21 INFO - PROCESS | 22611 | 14:30:25 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35761/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:25 INFO - PROCESS | 22611 | RSS: Main: 165093376 14:30:25 INFO - PROCESS | 22611 | 14:30:28 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35761/tests/kraken/driver.html?testName=json-parse-financial) 14:30:29 INFO - PROCESS | 22611 | RSS: Main: 167059456 14:30:29 INFO - PROCESS | 22611 | 14:30:31 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:31 INFO - PROCESS | 22611 | RSS: Main: 167079936 14:30:31 INFO - PROCESS | 22611 | 14:30:33 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:34 INFO - PROCESS | 22611 | RSS: Main: 166563840 14:30:34 INFO - PROCESS | 22611 | 14:30:36 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:36 INFO - PROCESS | 22611 | RSS: Main: 167084032 14:30:36 INFO - PROCESS | 22611 | 14:30:39 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:40 INFO - PROCESS | 22611 | RSS: Main: 167350272 14:30:40 INFO - PROCESS | 22611 | 14:30:42 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:43 INFO - PROCESS | 22611 | RSS: Main: 167481344 14:30:43 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | Cycle 1(1): loaded http://localhost:35761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35761/tests/kraken/driver.html?testName=ai-astar) 14:30:45 INFO - PROCESS | 22611 | RSS: Main: 168390656 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | __start_tp_report 14:30:45 INFO - PROCESS | 22611 | _x_x_mozilla_page_load 14:30:45 INFO - PROCESS | 22611 | _x_x_mozilla_page_load_details 14:30:45 INFO - PROCESS | 22611 | |i|pagename|runs| 14:30:45 INFO - PROCESS | 22611 | |0;ai-astar;111;106;111;111;111;114;111;110;110;112 14:30:45 INFO - PROCESS | 22611 | |1;audio-beat-detection;161;124;149;172;132;151;161;130;184;125 14:30:45 INFO - PROCESS | 22611 | |2;audio-dft;165;163;165;162;165;180;162;165;168;163 14:30:45 INFO - PROCESS | 22611 | |3;audio-fft;76;79;76;157;77;86;77;76;169;76 14:30:45 INFO - PROCESS | 22611 | |4;audio-oscillator;84;88;152;85;87;85;142;87;84;131 14:30:45 INFO - PROCESS | 22611 | |5;imaging-gaussian-blur;117;118;119;118;118;118;117;119;117;117 14:30:45 INFO - PROCESS | 22611 | |6;imaging-darkroom;147;149;147;149;149;149;146;147;147;147 14:30:45 INFO - PROCESS | 22611 | |7;imaging-desaturate;98;97;96;96;96;97;96;96;96;95 14:30:45 INFO - PROCESS | 22611 | |8;json-parse-financial;54;55;54;54;57;53;58;54;54;53 14:30:45 INFO - PROCESS | 22611 | |9;json-stringify-tinderbox;60;61;61;61;61;64;61;62;61;62 14:30:45 INFO - PROCESS | 22611 | |10;stanford-crypto-aes;79;84;80;80;80;83;81;82;110;80 14:30:45 INFO - PROCESS | 22611 | |11;stanford-crypto-ccm;132;123;126;126;132;122;133;133;133;121 14:30:45 INFO - PROCESS | 22611 | |12;stanford-crypto-pbkdf2;161;160;159;167;165;159;166;160;165;158 14:30:45 INFO - PROCESS | 22611 | |13;stanford-crypto-sha256-iterative;62;65;70;63;64;66;65;65;62;67 14:30:45 INFO - PROCESS | 22611 | __end_tp_report 14:30:45 INFO - PROCESS | 22611 | __start_cc_report 14:30:45 INFO - PROCESS | 22611 | _x_x_mozilla_cycle_collect,912 14:30:45 INFO - PROCESS | 22611 | __end_cc_report 14:30:45 INFO - PROCESS | 22611 | __startTimestamp1464643845342__endTimestamp 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | ------- Summary: start ------- 14:30:45 INFO - PROCESS | 22611 | Number of tests: 14 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.12 14:30:45 INFO - PROCESS | 22611 | Values: 111.0 106.0 111.0 111.0 111.0 114.0 111.0 110.0 110.0 112.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:20.81 (13.3%) stddev-sans-first:21.61 14:30:45 INFO - PROCESS | 22611 | Values: 161.0 124.0 149.0 172.0 132.0 151.0 161.0 130.0 184.0 125.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:5.31 (3.2%) stddev-sans-first:5.62 14:30:45 INFO - PROCESS | 22611 | Values: 165.0 163.0 165.0 162.0 165.0 180.0 162.0 165.0 168.0 163.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:36.13 (47.2%) stddev-sans-first:37.67 14:30:45 INFO - PROCESS | 22611 | Values: 76.0 79.0 76.0 157.0 77.0 86.0 77.0 76.0 169.0 76.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.51 (32.4%) stddev-sans-first:28.35 14:30:45 INFO - PROCESS | 22611 | Values: 84.0 88.0 152.0 85.0 87.0 85.0 142.0 87.0 84.0 131.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 14:30:45 INFO - PROCESS | 22611 | Values: 117.0 118.0 119.0 118.0 118.0 118.0 117.0 119.0 117.0 117.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 14:30:45 INFO - PROCESS | 22611 | Values: 147.0 149.0 147.0 149.0 149.0 149.0 146.0 147.0 147.0 147.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.60 14:30:45 INFO - PROCESS | 22611 | Values: 98.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:1.65 (3.0%) stddev-sans-first:1.73 14:30:45 INFO - PROCESS | 22611 | Values: 54.0 55.0 54.0 54.0 57.0 53.0 58.0 54.0 54.0 53.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.01 14:30:45 INFO - PROCESS | 22611 | Values: 60.0 61.0 61.0 61.0 61.0 64.0 61.0 62.0 61.0 62.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.50 stddev:9.30 (11.6%) stddev-sans-first:9.70 14:30:45 INFO - PROCESS | 22611 | Values: 79.0 84.0 80.0 80.0 80.0 83.0 81.0 82.0 110.0 80.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:132.00 stddev:5.00 (3.8%) stddev-sans-first:5.10 14:30:45 INFO - PROCESS | 22611 | Values: 132.0 123.0 126.0 126.0 132.0 122.0 133.0 133.0 133.0 121.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.00 stddev:3.37 (2.1%) stddev-sans-first:3.55 14:30:45 INFO - PROCESS | 22611 | Values: 161.0 160.0 159.0 167.0 165.0 159.0 166.0 160.0 165.0 158.0 14:30:45 INFO - PROCESS | 22611 | 14:30:45 INFO - PROCESS | 22611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:2.33 14:30:45 INFO - PROCESS | 22611 | Values: 62.0 65.0 70.0 63.0 64.0 66.0 65.0 65.0 62.0 67.0 14:30:45 INFO - PROCESS | 22611 | -------- Summary: end -------- 14:30:45 INFO - PROCESS | 22611 | 14:30:46 INFO - TEST-INFO | 22611: exit 0 14:30:46 INFO - TEST-OK | kraken | took 62222ms 14:30:46 INFO - SUITE-END | took 1172s 14:30:46 INFO - Completed test suite (00:19:32) 14:30:46 INFO - javascript benchmark 14:30:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.303055793485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.2775447769773, 3138.027211564415, 3144.103930379842, 3154.684531546845, 3175.0, 5339.866503337418, 5380.677159370441, 5411.188321751734, 5463.2078348639425, 5522.944770552303, 5220.738963051851, 5377.763114483671, 5394.298741163643, 5433.293671822667, 5563.165525171226, 4845.588125009378, 4874.341963834872, 4950.925736113961, 4952.108620448318, 5020.0, 802.1416959567287, 4784.1149387363275, 4879.634027447955, 4915.213565829468, 4931.852044438655, 4903.239997800329, 4963.925541116868, 4971.080350135237, 4979.775910084055, 4992.750362481879, 4990.3762029746285, 4996.200607902718, 5009.949900501021, 5022.1211288024815, 5039.09296326661, 4841.951580484185, 4890.5109489051165, 4893.510648935114, 4924.679895806761, 4927.630427717935, 5291.85055015276, 5322.308099947021, 5356.035913535562, 5386.8383948481605, 5387.838364849061, 5535.529479994206, 5746.425357464262, 5751.741171647286, 5769.480746732815, 5800.361960184377, 5838.766449342022, 5883.23517942669, 5900.291964964189, 5925.940740592582, 5996.880062398727, 5455.863603409907, 5480.068388373946, 5486.670799751988, 5512.972435137839, 5543.057680194336, 5678.176664383724, 5903.616264942765, 5972.343042265347, 5981.5214782817275, 5992.460678538952, 5678.261825962599, 5692.6299790513485, 5704.4295570443455, 5704.857378565569, 5717.313922329347, 5773.5958482906635, 5774.2782152230975, 5783.797567085132, 5809.0, 5813.709314534256, 5590.580706447033, 5749.195112684228, 5769.249997500298, 5839.357670656224, 5865.325487568899, 5755.827325180251, 5786.739596718157, 5817.185594016841, 5821.359650438449, 5821.941780582225, 4308.159908817751, 4312.913741725148, 4372.540883207281, 4392.0, 4417.690761646718, 3777.338965680995, 3811.9237615248094, 3844.058205739556, 3868.129670824042, 3935.114599215211, 5520.089185284463, 5570.972145139248, 5614.29821272341, 5650.039493286151, 5651.971740141273, 5879.3826648202175, 5902.1146827976145, 5928.407159284037, 5936.347001829795, 5948.405159484017, 5362.892742145214, 5480.177973303957, 5513.062779327524, 5557.972210139004, 5567.721613919288, 5000.874978125576, 5011.6241281904, 5019.899602007939, 5031.371078615173, 5058.317127187783, 5795.362510123883, 6027.156198132265, 6039.7282122304605, 6051.213342265477, 6061.696915154224, 5752.712364381848, 5774.624649397776, 5782.5373970081455, 5847.1229315603, 5850.063989761617, 6019.87960240784, 6038.758449661965, 6050.062240352752, 6056.757729690763, 6103.6032657877095, 5538.809156031472, 5631.943680563306, 5770.913436298543, 5779.739911703899, 5780.479756821906, 5806.390329015392, 5823.912641310299, 5903.498202652822, 5912.260967379078, 5993.700314984146, 5723.656580605177, 5738.053221218453, 5748.597598168088, 5791.449812267828, 5792.855178620568, 5497.175423686479, 5638.746256418389, 5687.0, 5756.683382414008, 5770.5095066919785, 5621.971890140523, 5654.660720356792, 5658.490735833795, 5683.943160568341, 5706.029974904193, 5746.454086861741, 5771.278590176228, 5784.595078344644, 5814.360420353673, 5821.912671309849, 5434.347878254634, 5442.292501974718, 5524.033294173423, 5558.305211848519, 5635.605507614591], "value": 5324.945055917789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6877270660198, 611.3794498583937, 621.4717490133387, 624.5191202773863, 652.399792191184, 38194.427083593735, 42648.78675606621, 42754.35868461976, 42804.14391712164, 42824.929376765554, 43922.12155756883, 44148.11703765931, 44402.333964990474, 44425.55574444254, 44452.0, 8648.35137364697, 8782.38523303369, 8808.0, 8810.471371717686, 8833.514156721378, 8454.87317690235, 8583.828323433527, 8680.262177714902, 8709.782255443633, 8722.30221582275, 8683.175098365646, 8700.086490918457, 8712.912870871274, 8728.650853965833, 8730.650773969033, 8696.478211307342, 8731.170538798804, 8732.956335218316, 8770.210681038674, 8802.64789408423, 8673.176048275403, 8684.956575217147, 8743.868841967376, 8788.736337909873, 8794.956025219833, 39955.40066898999, 40188.196236075404, 40293.59706402928, 40412.59587404118, 40477.595224047975, 2934.444744285532, 3161.715445609906, 3194.2014496375905, 3251.3497300539752, 3363.461846104636, 28412.431751365064, 28625.14124576266, 30706.692933070608, 31131.37737245265, 31689.04932852018, 4064.6748260139416, 4068.7151899367054, 4085.673146148301, 4089.5297040840387, 4223.64099051581, 289593.0, 291732.0, 293912.0, 295593.99999999785, 296230.0, 34210.14474638154, 34645.480317795256, 34655.653443465744, 34778.82610586931, 34821.82589087039, 35569.64430355663, 35700.0, 36596.08509787277, 36677.44983825245, 37855.81072094622, 16679.24943377551, 16862.915685421496, 16890.239939202766, 16926.91536542334, 16928.40750573724, 12851.614451566282, 12930.353482326034, 12936.611901642966, 12956.740865182643, 12962.675933101747, 19648.70526942097, 19668.131527504866, 19744.0, 19819.603607927762, 19845.106970186378, 7238.167610724834, 7325.450591205681, 7389.66746496409, 7405.703771849174, 7568.3945284378215, 943.5706753427174, 978.3933960944117, 1097.846301517788, 1103.6523495099018, 1119.7424592343643, 32503.674963250538, 32904.67095329064, 32969.0, 33107.172320692174, 33418.49872251918, 1101.3997371432588, 1119.0, 1120.4789772755707, 1141.5490881102085, 1212.763511115324, 16761.83238167627, 17240.65518689619, 17308.221130049176, 17330.133493325284, 17413.129343533026, 534862.0, 541479.0, 544367.0, 544561.0, 545074.0, 58760.7061964696, 59436.0, 59447.702761486784, 61850.0, 63742.6812865942, 1388.9166650001032, 1428.2144820348767, 1434.4405681784112, 1438.467766926223, 1438.6187660269827, 31541.36917261596, 33292.33415331631, 33315.83342083274, 33362.66637333693, 33458.832705836314, 48001.51998479971, 48020.27969580529, 48059.27911081407, 48229.75885120552, 48657.0, 498963.0, 510411.0, 510451.0, 514330.0, 517620.0, 27892.860535697193, 27978.720212797612, 28130.2967425816, 28150.0, 28330.433391331644, 46227.76886115548, 46467.0, 47600.523994759606, 48452.273215902496, 48600.270995935796, 39534.40698389469, 40892.38661420141, 41522.584774151874, 41869.79065104655, 42917.0, 41038.79480602578, 41048.79475602603, 41054.0, 41353.379699303936, 41403.0, 39708.60291397049, 40705.38941915814, 40769.0, 41549.1690166201, 41702.0, 34168.658313417545, 36650.633493664725, 36742.0, 36904.63095369012, 37144.442833358065, 27710.44579108447, 28042.756579473185, 28374.290642734097, 28381.716182837907, 28385.85807071034], "value": 19478.225188410288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.32963347440705, 380.6480878843463, 400.96591789697874, 402.6859049941046, 412.06461332774586, 17923.103844807756, 19066.42800715977, 19368.418947431564, 19403.12685929133, 19447.31934382297, 18220.0, 18231.27074917005, 18538.53653658659, 19240.134193961272, 19342.742721723112, 5512.751926163312, 5514.531264842493, 5620.57845661575, 5709.714514274269, 5716.1711551824965, 5633.042382794914, 5640.887182256373, 5643.943560564403, 5647.068233741448, 5713.514351280146, 5637.661740295595, 5652.689102099383, 6620.3710647488415, 7009.474289428288, 7052.118485189351, 6925.37671609555, 6936.861262774742, 7058.505904586681, 7394.852102957964, 7489.9251007489775, 6872.244053154149, 7117.75087871922, 7136.3220494052985, 7181.712731490734, 7203.963980180118, 25395.492090158277, 25584.10455634044, 25959.610605840928, 27063.45873082547, 27251.182464526097, 2265.2071774878827, 2326.3951372643064, 2342.5666251743482, 2512.5477414065463, 2555.3739333863136, 15698.450554230547, 15978.840211597852, 16180.838191618051, 16309.51071467846, 16310.83689163105, 2044.9386518404472, 2147.6349020666526, 2184.0936011555186, 2225.721784776903, 2253.740819805727, 97130.0, 102807.48596256971, 102889.48555257176, 102889.94220115556, 104272.0, 14136.166253101832, 17536.29854805819, 18554.44336669902, 18575.72136417955, 18610.720839187423, 33350.66649333476, 33818.830905845316, 33968.49047264293, 33981.32037359239, 34208.48687269693, 10019.0, 10039.598416063422, 10169.389836609827, 10183.745406364753, 10431.11335536488, 8584.828303433897, 8608.956955215184, 8612.698555550525, 8644.0, 8751.474911505331, 9025.774355641162, 9027.14242146995, 9070.18368346852, 9293.0, 9384.343095983215, 3298.5546951161764, 3315.3523247350095, 3477.9677484917415, 3497.283056973365, 3646.872359467406, 884.6682494064726, 997.3467378866709, 1010.9183174003746, 1051.9894801052044, 1085.647164671485, 18454.723179152323, 18892.244310227437, 19234.519137021685, 19247.711284330748, 19346.709799353022, 952.2667545989549, 972.7713987212999, 997.6607953295915, 999.2905037423366, 1110.3781882146025, 10508.842367364496, 10854.29447085937, 10873.619423320304, 10928.672139835817, 10931.890681093088, 361129.0, 366041.0, 366135.0, 498119.0, 498388.0, 72243.0, 97725.0, 100127.49936250273, 102056.48971755094, 107107.0, 468.8312207605259, 489.67191981373276, 492.58622756884387, 493.52621483375646, 494.9356583644175, 10969.561217551209, 11285.871412858649, 11456.656300311004, 11562.190646654653, 11584.536618535165, 40980.38529422002, 42943.78528107465, 43023.35464968091, 43250.78374608107, 44327.11345773131, 57206.56983575444, 57210.71394643, 58130.0, 58269.70865145647, 58366.0, 8548.829023419621, 8556.358273129665, 8701.695440659547, 8816.955915220382, 8884.156005179497, 9513.66702165421, 13090.410931507915, 13169.275689837152, 13379.464821407424, 13447.103739072329, 6586.80239592813, 8451.408401411842, 11548.364839933884, 11599.362035088152, 11863.881361186277, 11421.14341424413, 11480.712982175512, 11598.0, 11785.351805650429, 11980.341081240615, 11945.940270298594, 11985.400729963641, 12101.394930253276, 12180.390980451119, 12215.450304736485, 8872.556372181236, 8911.777205569913, 9001.594928228114, 9011.819763604823, 9244.630214791334, 11585.304881707125, 11741.882581174079, 11924.224925379822, 11968.880311196777, 12021.639350819489], "value": 10002.947176481317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.2816156002773, 1498.0637101811367, 1599.9040057596544, 1820.217306558181, 1856.7214917762326, 7849.0, 8605.268552173073, 8769.56152192391, 9347.906520934781, 9359.6256149754, 8580.270676992448, 8620.051794302637, 8818.91181088189, 8824.60289286982, 8847.159519845605, 2312.4103353644796, 2318.814494840417, 2340.3330050935488, 2348.542034303303, 2355.9057637694473, 2229.0, 2235.418791114314, 2263.309690544383, 2285.565742508918, 2286.1769762885347, 2353.329301149173, 2354.376090336062, 2368.846025008369, 2374.988125059372, 2386.713594368678, 2216.257553719498, 2234.8994295256753, 2253.0424569558036, 2255.7180352456026, 2266.6033444147292, 2320.709911261092, 2342.0280583557974, 2352.0, 2360.0795689680867, 2369.3958040699686, 8746.300295976307, 8872.11278872114, 8884.289256859436, 8890.333225008086, 8903.10968903111, 5307.734613269321, 5463.071277882769, 5516.9448305516835, 5517.2551705519645, 5518.420565840609, 3128.749700023993, 3289.1283809790425, 3339.699427051577, 3351.5140304655934, 3361.0, 1057.5822550092748, 1094.688013916038, 1111.6160380326464, 1112.2214449885032, 1122.4724379541683, 12809.743805123846, 12905.870941290561, 12916.160449570842, 12925.418356173996, 12934.611961641165, 4750.738709371018, 4752.669252609275, 4756.505220374944, 4806.158922188673, 4833.371661683958, 10743.677689669323, 10849.67450976472, 10870.456477176109, 10888.455577221108, 10904.78190436187, 5432.619716619878, 5459.563234941195, 5512.751926163332, 5513.9448605514235, 5516.724163791794, 4300.677449191323, 4743.644226683013, 4849.2726091085915, 4907.975460122677, 4950.752462376867, 3795.9240815184094, 3944.3097457944746, 4078.225137223918, 4097.467329247238, 4100.487439070116, 1231.2858542045592, 1244.4524409260077, 1245.1781823996118, 1248.843894513186, 1257.0509265504668, 889.954303693158, 895.7088946092546, 957.2916042128913, 995.8207522645848, 1023.0638965346625, 5847.239858818326, 5975.103734439869, 5993.910091348634, 6088.014439713239, 6131.233595800525, 908.922741566961, 941.6939494664261, 947.1664934857281, 975.512243878061, 1005.8239808033564, 4156.25187466259, 4203.180379825904, 4228.0, 4247.915041699149, 4262.680298977589, 11284.32294062359, 11647.41762911868, 11648.88351116495, 11736.530538778525, 11758.706032349088, 11476.655700329004, 11537.942310288563, 11548.364839933716, 11554.711132221593, 11565.710857228636, 7977.680892764224, 8187.71343002992, 8476.321894248445, 8514.361422893184, 8526.360522960802, 5857.297124345106, 5867.20792692998, 5939.762409503572, 5950.6132101415005, 6052.303985041776, 10424.374537527772, 10488.528016239135, 10582.417967011888, 10583.206259530412, 10625.468726563486, 10515.57937682484, 10617.628383006559, 10617.840732389175, 10765.3540787553, 10769.0, 7264.636768161677, 7822.178671239438, 7965.402594805529, 8010.758332458478, 8148.674053037812, 8688.565571721263, 8743.519106448952, 8786.209241168326, 8859.06979767115, 8883.200511953955, 7506.437017223621, 7511.0, 7631.0, 7633.465657403928, 7860.253275938777, 7524.849503010018, 7599.506032107895, 7604.277593628596, 7646.655900484603, 7710.036245469317, 7013.649317534205, 7079.787606371817, 7083.645817709197, 7157.642117894188, 7168.749093781693, 5068.417132029864, 5121.308623335951, 5145.92281115776, 5286.709230992333, 5340.092184328596, 5175.792968281377, 5242.449542797951, 5259.8422047338645, 5304.469553044664, 5308.548773354308], "value": 4710.394205231526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.1737231082255, 321.8680341060164, 331.8854995026715, 334.50827283892676, 335.54198519021537, 5524.806631767879, 5586.608937374385, 5675.943240567593, 5680.9431905680985, 5744.7989320373745, 5534.501894829465, 5554.750036248369, 5572.746132120271, 5594.636348637336, 5599.916001259984, 4263.126059157865, 4269.530351661315, 4279.7218180818145, 4284.764337961411, 4311.590398912098, 4062.512498500184, 4253.595908388698, 4284.7429154250685, 4288.185244803493, 4300.956990430102, 4159.188958153161, 4184.28867092595, 4246.363045543162, 4256.872293831175, 4258.5954334338185, 4231.767252801094, 4235.661147108255, 4241.34259189826, 4250.979764856443, 4258.574142585748, 3666.9083272918124, 3672.8347224374966, 3678.6873115785193, 3714.5542534895717, 3757.981210093932, 5341.359036915556, 5418.211990043315, 5426.8914621707345, 5434.891302173974, 5448.618596698233, 5008.6744361616375, 5022.221555658879, 5026.346574945271, 5027.899442011176, 5042.445331013586, 5521.1442226454965, 5854.736536855852, 5870.706464676792, 5878.354060862923, 5894.764209431618, 4147.564505726886, 4156.8129434175235, 4162.937555936664, 4179.373094035888, 4182.581741825793, 5893.5579831512805, 6103.56566206941, 6157.692115394212, 6177.505799536027, 6198.016634676906, 4193.685473589493, 4201.2017716633745, 4210.242156411875, 4213.052063285736, 4221.936670949938, 4234.915301694011, 4244.38456423823, 4268.65537355732, 4282.329891342379, 4297.3768803523935, 4801.479223407739, 4873.837849637332, 4889.217725163957, 4908.214685650279, 4965.435887695365, 5872.265966754156, 5874.647521148745, 5885.411458854081, 5897.496138484659, 5902.0, 1519.688463864905, 1531.4257153567412, 1543.6295289130528, 1544.6910617876244, 1544.7451170556733, 929.5723966975268, 975.9167324270054, 982.6708052802248, 986.5461887531673, 988.3822610868208, 5029.82395616159, 5038.823641172541, 5093.414257360451, 5098.286239926413, 5174.6119041071315, 5341.278927344836, 5385.976664433823, 5407.432219616883, 5467.917981230285, 5477.45225477457, 4969.180085285887, 5048.138174296666, 5162.870928226825, 5170.1986192140275, 5193.39004908472, 2904.968736098697, 2919.489089409345, 2934.383779406306, 2952.641784779026, 2962.859299169835, 5585.609007369445, 5635.886542546545, 5640.774369025193, 5653.378128405872, 5667.838093190886, 5181.766820493087, 5399.352077750695, 5476.247600767796, 5517.834464966058, 5524.640898341595, 5527.032769265363, 5536.252605898152, 5551.500364967173, 5585.273914391184, 5604.41153678866, 5196.870078248074, 5289.259503669567, 5339.958708052048, 5351.384590772111, 5459.863503412446, 5365.658585353505, 5366.182754053997, 5394.865128371822, 5413.7834486620095, 5430.755615997368, 6086.452219300284, 6115.235595550556, 6260.561760676891, 6288.717007734572, 6297.244330680348, 4345.934810977775, 4363.847265345697, 4389.18800021997, 4391.956080439282, 4411.426514553087, 5936.766395284847, 5982.940170598413, 6000.609960352563, 6092.725827337869, 6129.816105516842, 5862.824115276549, 5900.757712069386, 5930.673812940157, 5947.6431414115295, 5958.493528049991, 5878.970605147118, 5906.468417842415, 5922.55580831448, 5952.315483719428, 5955.285365756137, 5600.831975040755, 5808.535317174531, 5817.621854579439, 5827.650340979555, 5835.79574714883, 5976.402359763989, 5987.910181347196, 6008.939910600838, 6024.789132380346, 6087.604305720114, 5728.598998070095, 5765.423457654201, 5774.509166720875, 5870.853228669147, 5908.143319218775], "value": 4341.530381692711, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.7929819299692, 777.9222077792219, 781.1641543548403, 844.0841686769854, 845.4631309118707, 14197.503087391944, 14808.777868331958, 14966.176860272693, 14977.47578834741, 14987.175705336202, 13552.932235338809, 13600.659983500418, 13601.863981360184, 13619.727605447884, 13625.727485450285, 668.8194187569353, 786.9842603147948, 788.8225149341409, 794.7695168401157, 803.6423791412824, 810.7527204202715, 813.4102775487784, 814.3851392198882, 815.2703330519182, 817.2930415190847, 863.5250612163317, 866.8526350520426, 868.4658934755143, 869.9608517616722, 871.1419252036738, 840.6007146605375, 854.9572521373907, 855.9914400855974, 856.1780690537092, 859.179483593167, 617.882602305565, 620.1008537620469, 621.3382747374033, 622.1569772957668, 623.5759683415275, 14212.360443779951, 14261.572152835432, 14353.067050641675, 14378.568642940729, 14430.20633865137, 14016.299185040707, 14085.718285634332, 14151.575452736435, 14279.57161285163, 14300.0, 11815.446740032172, 11902.694177422403, 11973.820392694117, 11987.94006029973, 12164.330961797097, 3757.755745876537, 3859.9421008684894, 3863.7102217333813, 3895.7857317847506, 3953.743006704584, 63060.0, 66473.66763166153, 67071.66464167697, 67131.0, 68275.65862170658, 10484.790304194026, 10786.137109031259, 10831.891681083089, 10995.230333876552, 10995.780084398428, 16461.753073703905, 17014.31942722302, 17015.65968680644, 17458.738118928228, 17652.0, 8440.155984401634, 8555.657773688983, 8566.400351975302, 8623.655053797904, 8704.869426958474, 4726.172919739032, 4727.503612120747, 4730.905381892412, 4764.927891224516, 4822.927656085161, 3267.4118658641673, 3367.71374433171, 3464.1685995361436, 3470.5314782504543, 3472.871316822043, 657.1522735671026, 666.4435196610788, 667.7495939022866, 676.6887231873295, 684.2948401004625, 692.2143367278176, 713.3223437734173, 718.3750137380408, 737.7971057959104, 743.6690672650618, 9261.212796912203, 9868.753281168028, 9960.252981026451, 10220.488975551192, 10285.948570257251, 726.9345758881726, 732.7765031665286, 736.2048987093925, 748.6256871564218, 762.4624639629048, 4855.368802055781, 4901.730404827697, 4929.112759703288, 4954.256861470808, 4961.131801934647, 69061.0, 72258.2774172262, 73055.26944730485, 77396.0, 79163.0, 59222.703886481155, 60517.0, 62208.377916221165, 62521.68739156275, 66017.6699116511, 51528.74235628873, 56935.0, 58054.0, 58155.0, 59046.40953590409, 9711.805763884824, 9964.302498825013, 10055.798884022131, 10172.490490780669, 10307.793844122925, 37306.440403393426, 37471.812640937715, 37666.43500347442, 37730.62269377271, 37879.0, 46808.53191468042, 50301.496985031146, 50315.496845031084, 50815.237771432716, 51137.744311278206, 13247.403866825824, 13337.399817008452, 13367.197968121944, 13368.331583420984, 13459.865401345862, 14008.229547374993, 14320.57038288853, 14368.856311436752, 14435.422583096559, 14963.850361496246, 13529.18824870511, 13752.724945501233, 13879.583612491642, 14007.159570425807, 14152.716945661236, 13253.0, 13505.0, 13631.727365452438, 13700.93149534246, 13776.173429594257, 13412.865871341162, 13442.663933401744, 13558.796618050934, 13717.725645487233, 13879.791803123164, 10547.789044219226, 10870.248507012204, 10874.510647020745, 10932.781344372908, 11377.772444551229, 10313.639022634172, 10582.841257380991, 10949.0, 10979.945100274448, 11462.656120316404], "value": 7069.358484728656, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 111.0, 114.0, 111.0, 110.0, 110.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 149.0, 172.0, 132.0, 151.0, 161.0, 130.0, 184.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 162.0, 165.0, 180.0, 162.0, 165.0, 168.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 157.0, 77.0, 86.0, 77.0, 76.0, 169.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 152.0, 85.0, 87.0, 85.0, 142.0, 87.0, 84.0, 131.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 149.0, 149.0, 149.0, 146.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 57.0, 53.0, 58.0, 54.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 64.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 80.0, 80.0, 80.0, 83.0, 81.0, 82.0, 110.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 126.0, 126.0, 132.0, 122.0, 133.0, 133.0, 133.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 167.0, 165.0, 159.0, 166.0, 160.0, 165.0, 158.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 70.0, 63.0, 64.0, 66.0, 65.0, 65.0, 62.0, 67.0], "value": 64.9, "unit": "score"}]}]} 14:30:46 INFO - Return code: 0 14:30:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:30:46 ERROR - # TBPL SUCCESS # 14:30:46 INFO - Running post-action listener: _resource_record_post_action 14:30:46 INFO - ##### 14:30:46 INFO - ##### Finished run-tests step (success) 14:30:46 INFO - ##### 14:30:46 INFO - Running post-run listener: _resource_record_post_run 14:30:46 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 551272448; Read time: 0; Write time: 647376 14:30:46 INFO - TinderboxPrint: CPU usage
13.6% 14:30:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:30:46 INFO - TinderboxPrint: I/O write bytes / time
551,272,448 / 647,376 14:30:46 INFO - TinderboxPrint: CPU idle
8,200.0 (86.4%) 14:30:46 INFO - TinderboxPrint: CPU user
1,229.7 (13.0%) 14:30:46 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:46 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 260390912; Read time: 0; Write time: 412044 14:30:46 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 290881536; Read time: 0; Write time: 235332 14:30:47 INFO - Running post-run listener: _upload_blobber_files 14:30:47 INFO - Blob upload gear active. 14:30:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:48 INFO - (blobuploader) - INFO - Done attempting. 14:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:53 INFO - (blobuploader) - INFO - Done attempting. 14:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:53 INFO - (blobuploader) - INFO - Done attempting. 14:30:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:53 INFO - Return code: 0 14:30:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5e60dc986cfdc4613760880fab0e943b5725ca19fecd35ea4fb9e71ce93885419c2fbc49e59e0f3df415b674317b540261b37565419853b256f6e4edcc4b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e53517324687f6c4bdd0e27e7a4c559d054d7654fc3d5fbf4de2bbf6161a5597811642d4a9df4c6b01fd1ddb063fbe2d582250aa13c5f10983349e1d1587745", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1d1bd08eb0da8e5a45926b16926d1df5940afad1491525d63dc9b6b3e2c2f8e5c2f75dcb5f83e20ba6e8f037ce67cde515d6bfb233c65e482d3c63683eb020"} 14:30:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:53 INFO - Contents: 14:30:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5e60dc986cfdc4613760880fab0e943b5725ca19fecd35ea4fb9e71ce93885419c2fbc49e59e0f3df415b674317b540261b37565419853b256f6e4edcc4b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e53517324687f6c4bdd0e27e7a4c559d054d7654fc3d5fbf4de2bbf6161a5597811642d4a9df4c6b01fd1ddb063fbe2d582250aa13c5f10983349e1d1587745", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1d1bd08eb0da8e5a45926b16926d1df5940afad1491525d63dc9b6b3e2c2f8e5c2f75dcb5f83e20ba6e8f037ce67cde515d6bfb233c65e482d3c63683eb020"} 14:30:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:53 INFO - Copying logs to upload dir... 14:30:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.419842 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-30 14:30:52.064290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 14:30:52.067967) ========= 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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5e60dc986cfdc4613760880fab0e943b5725ca19fecd35ea4fb9e71ce93885419c2fbc49e59e0f3df415b674317b540261b37565419853b256f6e4edcc4b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e53517324687f6c4bdd0e27e7a4c559d054d7654fc3d5fbf4de2bbf6161a5597811642d4a9df4c6b01fd1ddb063fbe2d582250aa13c5f10983349e1d1587745", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1d1bd08eb0da8e5a45926b16926d1df5940afad1491525d63dc9b6b3e2c2f8e5c2f75dcb5f83e20ba6e8f037ce67cde515d6bfb233c65e482d3c63683eb020"} build_url:https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/bjyDzc2BRn2JymllQNFuew/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a5e60dc986cfdc4613760880fab0e943b5725ca19fecd35ea4fb9e71ce93885419c2fbc49e59e0f3df415b674317b540261b37565419853b256f6e4edcc4b06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e53517324687f6c4bdd0e27e7a4c559d054d7654fc3d5fbf4de2bbf6161a5597811642d4a9df4c6b01fd1ddb063fbe2d582250aa13c5f10983349e1d1587745", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1d1bd08eb0da8e5a45926b16926d1df5940afad1491525d63dc9b6b3e2c2f8e5c2f75dcb5f83e20ba6e8f037ce67cde515d6bfb233c65e482d3c63683eb020"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 14:30:52.096335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:30:52.096729) ========= 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=52faae308a556c440401f8e5000001e8-1464642079.241830-978779595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:30:52.181473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 14:30:52.181825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 14:30:52.182134) ========= ========= Total master_lag: 0.16 =========