builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1464038503.96 results: success (0) buildid: 20160523113040 builduid: 4e69fb01ef474d7cbde166aea1c14fa9 revision: 60435b82caee3a0c05466ff2249a574df57214e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:43.956280) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:43.956784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:43.957128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:43.976692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:43.977004) ========= 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=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 14:21:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.48M=0.001s 2016-05-23 14:21:44 (8.48 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.076009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.076397) ========= 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=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021559 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.125454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.128886) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60435b82caee3a0c05466ff2249a574df57214e6 --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 60435b82caee3a0c05466ff2249a574df57214e6 --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=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 14:21:44,714 truncating revision to first 12 chars 2016-05-23 14:21:44,714 Setting DEBUG logging. 2016-05-23 14:21:44,714 attempt 1/10 2016-05-23 14:21:44,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60435b82caee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 14:21:44,976 unpacking tar archive at: fx-team-60435b82caee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.685330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.685696) ========= script_repo_revision: 60435b82caee3a0c05466ff2249a574df57214e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.686133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.686439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:21:44.696528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-23 14:21:44.696843) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:21:45 INFO - MultiFileLogger online at 20160523 14:21:45 in /builds/slave/test 14:21:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:21:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:45 INFO - {'append_to_log': False, 14:21:45 INFO - 'base_work_dir': '/builds/slave/test', 14:21:45 INFO - 'blob_upload_branch': 'Fx-Team', 14:21:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:45 INFO - 'branch': 'Fx-Team', 14:21:45 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:45 INFO - 'config_files': ('talos/linux_config.py',), 14:21:45 INFO - 'default_actions': ('clobber', 14:21:45 INFO - 'read-buildbot-config', 14:21:45 INFO - 'download-and-extract', 14:21:45 INFO - 'populate-webroot', 14:21:45 INFO - 'create-virtualenv', 14:21:45 INFO - 'install', 14:21:45 INFO - 'run-tests'), 14:21:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:45 INFO - 'download_minidump_stackwalk': True, 14:21:45 INFO - 'download_symbols': 'ondemand', 14:21:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:45 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:45 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:45 INFO - 'installer_path': 'installer.exe', 14:21:45 INFO - 'log_level': 'info', 14:21:45 INFO - 'log_name': 'talos', 14:21:45 INFO - 'log_to_console': True, 14:21:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:21:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:21:45 INFO - 'opt_config_files': (), 14:21:45 INFO - 'pip_index': False, 14:21:45 INFO - 'sps_profile': False, 14:21:45 INFO - 'sps_profile_interval': 0, 14:21:45 INFO - 'suite': 'dromaeojs', 14:21:45 INFO - 'system_bits': '32', 14:21:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:45 INFO - 'title': 'talos-linux64-ix-021', 14:21:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:45 INFO - 'use_talos_json': True, 14:21:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:45 INFO - 'work_dir': 'build'} 14:21:45 INFO - ##### 14:21:45 INFO - ##### Running clobber step. 14:21:45 INFO - ##### 14:21:45 INFO - Running pre-action listener: _resource_record_pre_action 14:21:45 INFO - Running main action method: clobber 14:21:45 INFO - rmtree: /builds/slave/test/build 14:21:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:46 INFO - Running post-action listener: _resource_record_post_action 14:21:46 INFO - ##### 14:21:46 INFO - ##### Finished clobber step (success) 14:21:46 INFO - ##### 14:21:46 INFO - ##### 14:21:46 INFO - ##### Running read-buildbot-config step. 14:21:46 INFO - ##### 14:21:46 INFO - Running pre-action listener: _resource_record_pre_action 14:21:46 INFO - Running main action method: read_buildbot_config 14:21:46 INFO - Using buildbot properties: 14:21:46 INFO - { 14:21:46 INFO - "project": "", 14:21:46 INFO - "product": "firefox", 14:21:46 INFO - "script_repo_revision": "production", 14:21:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:21:46 INFO - "repository": "", 14:21:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:21:46 INFO - "buildid": "20160523113040", 14:21:46 INFO - "pgo_build": "True", 14:21:46 INFO - "basedir": "/builds/slave/test", 14:21:46 INFO - "buildnumber": 116, 14:21:46 INFO - "slavename": "talos-linux64-ix-021", 14:21:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:21:46 INFO - "platform": "ubuntu64_hw", 14:21:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:21:46 INFO - "branch": "fx-team", 14:21:46 INFO - "repo_path": "integration/fx-team", 14:21:46 INFO - "revision": "60435b82caee3a0c05466ff2249a574df57214e6", 14:21:46 INFO - "stage_platform": "linux64-pgo", 14:21:46 INFO - "builduid": "4e69fb01ef474d7cbde166aea1c14fa9", 14:21:46 INFO - "slavebuilddir": "test" 14:21:46 INFO - } 14:21:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:21:46 INFO - Running post-action listener: _resource_record_post_action 14:21:46 INFO - ##### 14:21:46 INFO - ##### Finished read-buildbot-config step (success) 14:21:46 INFO - ##### 14:21:46 INFO - ##### 14:21:46 INFO - ##### Running download-and-extract step. 14:21:46 INFO - ##### 14:21:46 INFO - Running pre-action listener: _resource_record_pre_action 14:21:46 INFO - Running main action method: download_and_extract 14:21:46 INFO - mkdir: /builds/slave/test/build/tests 14:21:46 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:21:46 INFO - https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:46 INFO - Downloaded 1361 bytes. 14:21:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:21:46 INFO - Using the following test package requirements: 14:21:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:21:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:21:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:21:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'jsshell-linux-x86_64.zip'], 14:21:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:21:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:21:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:21:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:21:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:21:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:21:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:21:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:21:46 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:21:46 INFO - https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:48 INFO - Downloaded 24388634 bytes. 14:21:48 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:21:48 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:21:49 INFO - Return code: 0 14:21:49 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:21: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:21:49 INFO - https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:50 INFO - Downloaded 24388634 bytes. 14:21:50 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:21:50 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:21:52 INFO - Return code: 0 14:21: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:21:52 INFO - https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:21:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:21:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:21:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:53 INFO - Downloaded 10840359 bytes. 14:21:53 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:21:53 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:21:53 INFO - Return code: 0 14:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:53 INFO - https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nyfavs0YSpaczh6H9ZQzPw/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:21:54 INFO - Downloaded 58618484 bytes. 14:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:21:54 INFO - mkdir: /builds/slave/test/properties 14:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:54 INFO - Contents: 14:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:21:55 INFO - Running post-action listener: _resource_record_post_action 14:21:55 INFO - Running post-action listener: set_extra_try_arguments 14:21:55 INFO - ##### 14:21:55 INFO - ##### Finished download-and-extract step (success) 14:21:55 INFO - ##### 14:21:55 INFO - ##### 14:21:55 INFO - ##### Running populate-webroot step. 14:21:55 INFO - ##### 14:21:55 INFO - Running pre-action listener: _resource_record_pre_action 14:21:55 INFO - Running main action method: populate_webroot 14:21:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:55 INFO - '--tppagecycles', 14:21:55 INFO - '7'], 14:21:55 INFO - 'tests': ['tsvgm']}}, 14:21:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['damp', 'tps']}, 14:21:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['damp', 'tps']}, 14:21:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['dromaeo_dom']}, 14:21:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['a11yr', 14:21:55 INFO - 'ts_paint', 14:21:55 INFO - 'tpaint', 14:21:55 INFO - 'sessionrestore', 14:21:55 INFO - 'sessionrestore_no_auto_restore', 14:21:55 INFO - 'tabpaint']}, 14:21:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['tsvgx', 14:21:55 INFO - 'tsvgr_opacity', 14:21:55 INFO - 'tart', 14:21:55 INFO - 'tscrollx', 14:21:55 INFO - 'cart']}, 14:21:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:55 INFO - 'tsvgr_opacity', 14:21:55 INFO - 'tart', 14:21:55 INFO - 'tscrollx', 14:21:55 INFO - 'cart']}, 14:21:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--disable-e10s'], 14:21:55 INFO - 'tests': ['tp5o']}, 14:21:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'tests': ['tp5o']}, 14:21:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--disable-e10s', 14:21:55 INFO - '--xperf_path', 14:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:55 INFO - 'tests': ['tp5n']}, 14:21:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:55 INFO - 'talos_options': ['--xperf_path', 14:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:55 INFO - 'tests': ['tp5n']}}, 14:21:55 INFO - 'talos.zip': {'path': '', 14:21:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:55 INFO - Running post-action listener: _resource_record_post_action 14:21:55 INFO - ##### 14:21:55 INFO - ##### Finished populate-webroot step (success) 14:21:55 INFO - ##### 14:21:55 INFO - ##### 14:21:55 INFO - ##### Running create-virtualenv step. 14:21:55 INFO - ##### 14:21:55 INFO - Running pre-action listener: _resource_record_pre_action 14:21:55 INFO - Running main action method: create_virtualenv 14:21:55 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:55 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:21:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:55 INFO - Using real prefix '/usr' 14:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:58 INFO - Installing pip.................done. 14:21:58 INFO - Return code: 0 14:21:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:58 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:21:58 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:21:58 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:21:58 INFO - Using env: {'DISPLAY': ':0', 14:21:58 INFO - 'HOME': '/home/cltbld', 14:21:58 INFO - 'LANG': 'en_US.UTF-8', 14:21:58 INFO - 'LANGUAGE': 'en_US:en', 14:21:58 INFO - 'LOGNAME': 'cltbld', 14:21:58 INFO - 'MAIL': '/var/mail/cltbld', 14:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:58 INFO - 'MOZ_NO_REMOTE': '1', 14:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:58 INFO - 'NO_EM_RESTART': '1', 14:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:58 INFO - 'PWD': '/builds/slave/test', 14:21:58 INFO - 'SHELL': '/bin/bash', 14:21:58 INFO - 'SHLVL': '1', 14:21:58 INFO - 'TERM': 'linux', 14:21:58 INFO - 'TMOUT': '86400', 14:21:58 INFO - 'USER': 'cltbld', 14:21:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:58 INFO - '_': '/tools/buildbot/bin/python'} 14:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:58 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:21:58 INFO - Cleaning up... 14:21:58 INFO - Return code: 0 14:21:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:58 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:21:58 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:21:58 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:21:58 INFO - Using env: {'DISPLAY': ':0', 14:21:58 INFO - 'HOME': '/home/cltbld', 14:21:58 INFO - 'LANG': 'en_US.UTF-8', 14:21:58 INFO - 'LANGUAGE': 'en_US:en', 14:21:58 INFO - 'LOGNAME': 'cltbld', 14:21:58 INFO - 'MAIL': '/var/mail/cltbld', 14:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:58 INFO - 'MOZ_NO_REMOTE': '1', 14:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:58 INFO - 'NO_EM_RESTART': '1', 14:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:58 INFO - 'PWD': '/builds/slave/test', 14:21:58 INFO - 'SHELL': '/bin/bash', 14:21:58 INFO - 'SHLVL': '1', 14:21:58 INFO - 'TERM': 'linux', 14:21:58 INFO - 'TMOUT': '86400', 14:21:58 INFO - 'USER': 'cltbld', 14:21:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:58 INFO - '_': '/tools/buildbot/bin/python'} 14:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:58 INFO - Downloading/unpacking psutil>=3.1.1 14:21:58 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:21:58 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:21:58 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:21:58 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:21:58 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:21:58 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:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:00 INFO - Installing collected packages: psutil 14:22:00 INFO - Running setup.py install for psutil 14:22:00 INFO - building 'psutil._psutil_linux' extension 14:22:00 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:22:00 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:22:00 INFO - building 'psutil._psutil_posix' extension 14:22:00 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:22:01 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:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:01 INFO - Successfully installed psutil 14:22:01 INFO - Cleaning up... 14:22:01 INFO - Return code: 0 14:22:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:01 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:01 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:22:01 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:22:01 INFO - Using env: {'DISPLAY': ':0', 14:22:01 INFO - 'HOME': '/home/cltbld', 14:22:01 INFO - 'LANG': 'en_US.UTF-8', 14:22:01 INFO - 'LANGUAGE': 'en_US:en', 14:22:01 INFO - 'LOGNAME': 'cltbld', 14:22:01 INFO - 'MAIL': '/var/mail/cltbld', 14:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:01 INFO - 'MOZ_NO_REMOTE': '1', 14:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:01 INFO - 'NO_EM_RESTART': '1', 14:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:01 INFO - 'PWD': '/builds/slave/test', 14:22:01 INFO - 'SHELL': '/bin/bash', 14:22:01 INFO - 'SHLVL': '1', 14:22:01 INFO - 'TERM': 'linux', 14:22:01 INFO - 'TMOUT': '86400', 14:22:01 INFO - 'USER': 'cltbld', 14:22:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:01 INFO - '_': '/tools/buildbot/bin/python'} 14:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:01 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:22:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:03 INFO - Installing collected packages: mozsystemmonitor 14:22:03 INFO - Running setup.py install for mozsystemmonitor 14:22:03 INFO - Successfully installed mozsystemmonitor 14:22:03 INFO - Cleaning up... 14:22:03 INFO - Return code: 0 14:22:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:03 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:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:03 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:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:03 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:03 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:22:03 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:22:03 INFO - Using env: {'DISPLAY': ':0', 14:22:03 INFO - 'HOME': '/home/cltbld', 14:22:03 INFO - 'LANG': 'en_US.UTF-8', 14:22:03 INFO - 'LANGUAGE': 'en_US:en', 14:22:03 INFO - 'LOGNAME': 'cltbld', 14:22:03 INFO - 'MAIL': '/var/mail/cltbld', 14:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:03 INFO - 'MOZ_NO_REMOTE': '1', 14:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:03 INFO - 'NO_EM_RESTART': '1', 14:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:03 INFO - 'PWD': '/builds/slave/test', 14:22:03 INFO - 'SHELL': '/bin/bash', 14:22:03 INFO - 'SHLVL': '1', 14:22:03 INFO - 'TERM': 'linux', 14:22:03 INFO - 'TMOUT': '86400', 14:22:03 INFO - 'USER': 'cltbld', 14:22:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:03 INFO - '_': '/tools/buildbot/bin/python'} 14:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:05 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:05 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:22:05 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:22:05 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:22:05 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:22:05 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:22:05 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:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:06 INFO - Downloading docopt-0.6.1.tar.gz 14:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:06 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:06 INFO - Running setup.py install for blobuploader 14:22:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:06 INFO - Running setup.py install for requests 14:22:06 INFO - Running setup.py install for docopt 14:22:06 INFO - Successfully installed blobuploader requests docopt 14:22:06 INFO - Cleaning up... 14:22:06 INFO - Return code: 0 14:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:06 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:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 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:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:06 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:06 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:22:06 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:22:06 INFO - Using env: {'DISPLAY': ':0', 14:22:06 INFO - 'HOME': '/home/cltbld', 14:22:06 INFO - 'LANG': 'en_US.UTF-8', 14:22:06 INFO - 'LANGUAGE': 'en_US:en', 14:22:06 INFO - 'LOGNAME': 'cltbld', 14:22:06 INFO - 'MAIL': '/var/mail/cltbld', 14:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:06 INFO - 'MOZ_NO_REMOTE': '1', 14:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:06 INFO - 'NO_EM_RESTART': '1', 14:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:06 INFO - 'PWD': '/builds/slave/test', 14:22:06 INFO - 'SHELL': '/bin/bash', 14:22:06 INFO - 'SHLVL': '1', 14:22:06 INFO - 'TERM': 'linux', 14:22:06 INFO - 'TMOUT': '86400', 14:22:06 INFO - 'USER': 'cltbld', 14:22:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:06 INFO - '_': '/tools/buildbot/bin/python'} 14:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:07 INFO - Running setup.py (path:/tmp/pip-hjfIx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:07 INFO - Running setup.py (path:/tmp/pip-zFJdRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:07 INFO - Running setup.py (path:/tmp/pip-Z4pLXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:07 INFO - Running setup.py (path:/tmp/pip-bJirGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:07 INFO - Running setup.py (path:/tmp/pip-EvmDpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:07 INFO - Running setup.py (path:/tmp/pip-_529_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:07 INFO - Running setup.py (path:/tmp/pip-cU0G1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:07 INFO - Running setup.py (path:/tmp/pip-kqf2JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:07 INFO - Running setup.py (path:/tmp/pip-NiWfZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:07 INFO - Running setup.py (path:/tmp/pip-0456Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:07 INFO - Running setup.py (path:/tmp/pip-htMiT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:07 INFO - Running setup.py (path:/tmp/pip-1DdJ5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:08 INFO - Running setup.py (path:/tmp/pip-ZMWROj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:08 INFO - Running setup.py (path:/tmp/pip-mpUFEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:08 INFO - Running setup.py (path:/tmp/pip-rwhswj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:08 INFO - Running setup.py (path:/tmp/pip-u5YhVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:08 INFO - Running setup.py (path:/tmp/pip-Nf1Zce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:08 INFO - Running setup.py install for manifestparser 14:22:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:08 INFO - Running setup.py install for mozcrash 14:22:08 INFO - Running setup.py install for mozdebug 14:22:08 INFO - Running setup.py install for mozdevice 14:22:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:22:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:08 INFO - Running setup.py install for mozfile 14:22:08 INFO - Running setup.py install for mozhttpd 14:22:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:08 INFO - Running setup.py install for mozinfo 14:22:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for mozInstall 14:22:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for mozleak 14:22:09 INFO - Running setup.py install for mozlog 14:22:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for moznetwork 14:22:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for mozprocess 14:22:09 INFO - Running setup.py install for mozprofile 14:22:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for mozrunner 14:22:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:09 INFO - Running setup.py install for mozscreenshot 14:22:09 INFO - Running setup.py install for moztest 14:22:10 INFO - Running setup.py install for mozversion 14:22:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:10 INFO - Cleaning up... 14:22:10 INFO - Return code: 0 14:22:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:10 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:10 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:22:10 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:22:10 INFO - Using env: {'DISPLAY': ':0', 14:22:10 INFO - 'HOME': '/home/cltbld', 14:22:10 INFO - 'LANG': 'en_US.UTF-8', 14:22:10 INFO - 'LANGUAGE': 'en_US:en', 14:22:10 INFO - 'LOGNAME': 'cltbld', 14:22:10 INFO - 'MAIL': '/var/mail/cltbld', 14:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:10 INFO - 'MOZ_NO_REMOTE': '1', 14:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:10 INFO - 'NO_EM_RESTART': '1', 14:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:10 INFO - 'PWD': '/builds/slave/test', 14:22:10 INFO - 'SHELL': '/bin/bash', 14:22:10 INFO - 'SHLVL': '1', 14:22:10 INFO - 'TERM': 'linux', 14:22:10 INFO - 'TMOUT': '86400', 14:22:10 INFO - 'USER': 'cltbld', 14:22:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:10 INFO - '_': '/tools/buildbot/bin/python'} 14:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:10 INFO - Running setup.py (path:/tmp/pip-GPcxhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:10 INFO - Running setup.py (path:/tmp/pip-PEanbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:10 INFO - Running setup.py (path:/tmp/pip-OjLxbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:10 INFO - Running setup.py (path:/tmp/pip-IFA7iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:10 INFO - Running setup.py (path:/tmp/pip-BcgFBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:10 INFO - Running setup.py (path:/tmp/pip-pAI5fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:10 INFO - Running setup.py (path:/tmp/pip-hnBbRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:10 INFO - Running setup.py (path:/tmp/pip-F6kIzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:10 INFO - Running setup.py (path:/tmp/pip-1zRIPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:11 INFO - Running setup.py (path:/tmp/pip-ekra2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:11 INFO - Running setup.py (path:/tmp/pip-CpLY8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:11 INFO - Running setup.py (path:/tmp/pip-Q2IHDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:11 INFO - Running setup.py (path:/tmp/pip-VvJIFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:11 INFO - Running setup.py (path:/tmp/pip-NbQ0g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:11 INFO - Running setup.py (path:/tmp/pip-weEKep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:11 INFO - Running setup.py (path:/tmp/pip-Flmh3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:11 INFO - Running setup.py (path:/tmp/pip-ts44u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 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:22:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:13 INFO - Downloading blessings-1.6.tar.gz 14:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:13 INFO - Installing collected packages: blessings 14:22:13 INFO - Running setup.py install for blessings 14:22:13 INFO - Successfully installed blessings 14:22:13 INFO - Cleaning up... 14:22:13 INFO - Return code: 0 14:22:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:13 INFO - Reading from file tmpfile_stdout 14:22:13 INFO - Current package versions: 14:22:13 INFO - argparse == 1.2.1 14:22:13 INFO - blessings == 1.6 14:22:13 INFO - blobuploader == 1.2.4 14:22:13 INFO - docopt == 0.6.1 14:22:13 INFO - manifestparser == 1.1 14:22:13 INFO - mozInstall == 1.12 14:22:13 INFO - mozcrash == 0.17 14:22:13 INFO - mozdebug == 0.1 14:22:13 INFO - mozdevice == 0.48 14:22:13 INFO - mozfile == 1.2 14:22:13 INFO - mozhttpd == 0.7 14:22:13 INFO - mozinfo == 0.9 14:22:13 INFO - mozleak == 0.1 14:22:13 INFO - mozlog == 3.2 14:22:13 INFO - moznetwork == 0.27 14:22:13 INFO - mozprocess == 0.22 14:22:13 INFO - mozprofile == 0.28 14:22:13 INFO - mozrunner == 6.11 14:22:13 INFO - mozscreenshot == 0.1 14:22:13 INFO - mozsystemmonitor == 0.3 14:22:13 INFO - moztest == 0.7 14:22:13 INFO - mozversion == 1.4 14:22:13 INFO - psutil == 3.1.1 14:22:13 INFO - requests == 1.2.3 14:22:13 INFO - wsgiref == 0.1.2 14:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:13 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:13 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:22:13 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:22:13 INFO - Using env: {'DISPLAY': ':0', 14:22:13 INFO - 'HOME': '/home/cltbld', 14:22:13 INFO - 'LANG': 'en_US.UTF-8', 14:22:13 INFO - 'LANGUAGE': 'en_US:en', 14:22:13 INFO - 'LOGNAME': 'cltbld', 14:22:13 INFO - 'MAIL': '/var/mail/cltbld', 14:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:13 INFO - 'MOZ_NO_REMOTE': '1', 14:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:13 INFO - 'NO_EM_RESTART': '1', 14:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:13 INFO - 'PWD': '/builds/slave/test', 14:22:13 INFO - 'SHELL': '/bin/bash', 14:22:13 INFO - 'SHLVL': '1', 14:22:13 INFO - 'TERM': 'linux', 14:22:13 INFO - 'TMOUT': '86400', 14:22:13 INFO - 'USER': 'cltbld', 14:22:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:13 INFO - '_': '/tools/buildbot/bin/python'} 14:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 INFO - Cleaning up... 14:22:14 INFO - Return code: 0 14:22:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:14 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:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:14 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:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:14 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:14 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:22:14 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:22:14 INFO - Using env: {'DISPLAY': ':0', 14:22:14 INFO - 'HOME': '/home/cltbld', 14:22:14 INFO - 'LANG': 'en_US.UTF-8', 14:22:14 INFO - 'LANGUAGE': 'en_US:en', 14:22:14 INFO - 'LOGNAME': 'cltbld', 14:22:14 INFO - 'MAIL': '/var/mail/cltbld', 14:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:14 INFO - 'MOZ_NO_REMOTE': '1', 14:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:14 INFO - 'NO_EM_RESTART': '1', 14:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:14 INFO - 'PWD': '/builds/slave/test', 14:22:14 INFO - 'SHELL': '/bin/bash', 14:22:14 INFO - 'SHLVL': '1', 14:22:14 INFO - 'TERM': 'linux', 14:22:14 INFO - 'TMOUT': '86400', 14:22:14 INFO - 'USER': 'cltbld', 14:22:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:14 INFO - '_': '/tools/buildbot/bin/python'} 14:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:14 INFO - Downloading/unpacking jsonschema 14:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:14 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:22:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:16 INFO - Downloading/unpacking functools32 (from jsonschema) 14:22:16 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:22:16 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:22:16 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:22:16 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:22:16 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:22:16 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:22:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:16 INFO - warning: no files found matching '*.txt' 14:22:16 INFO - no previously-included directories found matching 'build' 14:22:16 INFO - no previously-included directories found matching 'dist' 14:22:16 INFO - no previously-included directories found matching '.git*' 14:22:16 INFO - Installing collected packages: jsonschema, functools32 14:22:16 INFO - Running setup.py install for functools32 14:22:16 INFO - warning: no files found matching '*.txt' 14:22:16 INFO - no previously-included directories found matching 'build' 14:22:16 INFO - no previously-included directories found matching 'dist' 14:22:16 INFO - no previously-included directories found matching '.git*' 14:22:16 INFO - Successfully installed jsonschema functools32 14:22:16 INFO - Cleaning up... 14:22:16 INFO - Return code: 0 14:22:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:16 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 0x7f9d2e16cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, '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': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', '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:22:16 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:22:16 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:22:16 INFO - Using env: {'DISPLAY': ':0', 14:22:16 INFO - 'HOME': '/home/cltbld', 14:22:16 INFO - 'LANG': 'en_US.UTF-8', 14:22:16 INFO - 'LANGUAGE': 'en_US:en', 14:22:16 INFO - 'LOGNAME': 'cltbld', 14:22:16 INFO - 'MAIL': '/var/mail/cltbld', 14:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:16 INFO - 'MOZ_NO_REMOTE': '1', 14:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:16 INFO - 'NO_EM_RESTART': '1', 14:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:16 INFO - 'PWD': '/builds/slave/test', 14:22:16 INFO - 'SHELL': '/bin/bash', 14:22:16 INFO - 'SHLVL': '1', 14:22:16 INFO - 'TERM': 'linux', 14:22:16 INFO - 'TMOUT': '86400', 14:22:16 INFO - 'USER': 'cltbld', 14:22:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:16 INFO - '_': '/tools/buildbot/bin/python'} 14:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:16 INFO - Downloading/unpacking flake8 14:22:16 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:22:16 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:22:16 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:22:16 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:22:16 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:22:16 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:22:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:22:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:22:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:19 INFO - no previously-included directories found matching 'docs/_build' 14:22:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:22:19 INFO - Running setup.py install for pep8 14:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:19 INFO - no previously-included directories found matching 'docs/_build' 14:22:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:22:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:22:19 INFO - Cleaning up... 14:22:19 INFO - Return code: 0 14:22:19 INFO - Running post-action listener: _resource_record_post_action 14:22:19 INFO - Running post-action listener: _start_resource_monitoring 14:22:19 INFO - Starting resource monitoring. 14:22:19 INFO - ##### 14:22:19 INFO - ##### Finished create-virtualenv step (success) 14:22:19 INFO - ##### 14:22:19 INFO - ##### 14:22:19 INFO - ##### Running install step. 14:22:19 INFO - ##### 14:22:19 INFO - Running pre-action listener: _resource_record_pre_action 14:22:19 INFO - Running main action method: install 14:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:20 INFO - Reading from file tmpfile_stdout 14:22:20 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:20 INFO - Reading from file tmpfile_stdout 14:22:20 INFO - Output received: 14:22:20 INFO - Usage: mozinstall [options] installer 14:22:20 INFO - Options: 14:22:20 INFO - -h, --help show this help message and exit 14:22:20 INFO - -d DEST, --destination=DEST 14:22:20 INFO - Directory to install application into. [default: 14:22:20 INFO - "/builds/slave/test"] 14:22:20 INFO - --app=APP Application being installed. [default: firefox] 14:22:20 INFO - mkdir: /builds/slave/test/build/application 14:22:20 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:22:20 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:22:36 INFO - Reading from file tmpfile_stdout 14:22:36 INFO - Output received: 14:22:36 INFO - /builds/slave/test/build/application/firefox/firefox 14:22:36 INFO - Running post-action listener: _resource_record_post_action 14:22:36 INFO - ##### 14:22:36 INFO - ##### Finished install step (success) 14:22:36 INFO - ##### 14:22:36 INFO - ##### 14:22:36 INFO - ##### Running run-tests step. 14:22:36 INFO - ##### 14:22:36 INFO - Running pre-action listener: _resource_record_pre_action 14:22:36 INFO - Running main action method: run_tests 14:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:36 INFO - Python 2.7.3 14:22:36 INFO - Return code: 0 14:22:36 INFO - grabbing minidump binary from tooltool 14:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:36 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 0x1db99c0>, '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 0x1dba8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:36 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:22:36 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:22:36 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:22:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:36 INFO - Return code: 0 14:22:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:22:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:22:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:22:37 INFO - Return code: 0 14:22:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:22:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:22:37 INFO - Using env: {'DISPLAY': ':0', 14:22:37 INFO - 'HOME': '/home/cltbld', 14:22:37 INFO - 'LANG': 'en_US.UTF-8', 14:22:37 INFO - 'LANGUAGE': 'en_US:en', 14:22:37 INFO - 'LOGNAME': 'cltbld', 14:22:37 INFO - 'MAIL': '/var/mail/cltbld', 14:22:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:37 INFO - 'MOZ_NO_REMOTE': '1', 14:22:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:37 INFO - 'NO_EM_RESTART': '1', 14:22:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:37 INFO - 'PWD': '/builds/slave/test', 14:22:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:37 INFO - 'SHELL': '/bin/bash', 14:22:37 INFO - 'SHLVL': '1', 14:22:37 INFO - 'TERM': 'linux', 14:22:37 INFO - 'TMOUT': '86400', 14:22:37 INFO - 'USER': 'cltbld', 14:22:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575', 14:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:37 INFO - '_': '/tools/buildbot/bin/python'} 14:22:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:22:38 INFO - mozversion application_buildid: 20160523113040 14:22:38 INFO - mozversion application_changeset: 60435b82caee3a0c05466ff2249a574df57214e6 14:22:38 INFO - mozversion application_display_name: Nightly 14:22:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:38 INFO - mozversion application_name: Firefox 14:22:38 INFO - mozversion application_remotingname: firefox 14:22:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:22:38 INFO - mozversion application_vendor: Mozilla 14:22:38 INFO - mozversion application_version: 49.0a1 14:22:38 INFO - mozversion platform_buildid: 20160523113040 14:22:38 INFO - mozversion platform_changeset: 60435b82caee3a0c05466ff2249a574df57214e6 14:22:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:22:38 INFO - mozversion platform_version: 49.0a1 14:22:38 INFO - using testdate: 1464038558 14:22:38 INFO - actual date: 1464038558 14:22:38 INFO - starting webserver on 'localhost:56302' 14:22:38 INFO - SUITE-START | Running 2 tests 14:22:38 INFO - TEST-START | dromaeo_css 14:22:38 INFO - operating with platform_type : linux_ 14:22:38 INFO - Initialising browser for dromaeo_css test... 14:22:38 INFO - TEST-INFO | started process 17540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4Gg5e/profile http://localhost:56302/getInfo.html) 14:22:42 INFO - PROCESS | 17540 | __metrics Screen width/height:1600/1200 14:22:42 INFO - PROCESS | 17540 | colorDepth:24 14:22:42 INFO - PROCESS | 17540 | Browser inner width/height: 1024/697 14:22:42 INFO - PROCESS | 17540 | __metrics 14:22:44 ERROR - PROCESS | 17540 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:22:45 INFO - TEST-INFO | 17540: exit 0 14:22:45 INFO - Browser initialized. 14:22:45 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:45 INFO - TEST-INFO | started process 17624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4Gg5e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:56 INFO - PROCESS | 17624 | RSS: Main: 153161728 14:22:56 INFO - PROCESS | 17624 | 14:23:47 INFO - PROCESS | 17624 | 1464038627882 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:25:55 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56302/tests/dromaeo/cssquery-ext.html) 14:25:56 INFO - PROCESS | 17624 | RSS: Main: 261332992 14:25:56 INFO - PROCESS | 17624 | 14:28:59 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-ext.html (next: http://localhost:56302/tests/dromaeo/cssquery-jquery.html) 14:28:59 INFO - PROCESS | 17624 | RSS: Main: 236544000 14:28:59 INFO - PROCESS | 17624 | 14:32:01 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56302/tests/dromaeo/cssquery-mootools.html) 14:32:02 INFO - PROCESS | 17624 | RSS: Main: 233635840 14:32:02 INFO - PROCESS | 17624 | 14:35:04 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56302/tests/dromaeo/cssquery-prototype.html) 14:35:05 INFO - PROCESS | 17624 | RSS: Main: 233164800 14:35:05 INFO - PROCESS | 17624 | 14:38:07 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56302/tests/dromaeo/cssquery-yui.html) 14:38:08 INFO - PROCESS | 17624 | RSS: Main: 205922304 14:38:08 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | Cycle 1(1): loaded http://localhost:56302/tests/dromaeo/cssquery-yui.html (next: http://localhost:56302/tests/dromaeo/cssquery-dojo.html) 14:41:10 INFO - PROCESS | 17624 | RSS: Main: 273051648 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | __start_tp_report 14:41:10 INFO - PROCESS | 17624 | _x_x_mozilla_page_load 14:41:10 INFO - PROCESS | 17624 | _x_x_mozilla_page_load_details 14:41:10 INFO - PROCESS | 17624 | |i|pagename|runs| 14:41:10 INFO - PROCESS | 17624 | |0;dojo.html;3072.7234548890597;3114.330418959924;3146.0247323329777;3146.921326966827;3176.4600017996936;5184.092783762836;5255.448177941318;5270.81552145675;5364.275822763926;5386.9461305386985;5344.0915044442445;5357.276767636368;5361.678299302044;5397.109476936311;5427.104527752916;4617.215073437524;4881.609471242301;4942.802287908479;4961.18140506816;5005.499450054984;4851.951480485185;4927.901441971158;4941.308216849644;4988.301637770697;5011.67424117433;4789.976050119762;4805.975970120145;4832.130216561018;4833.637477189225;4839.467658557556;4825.613950883956;4895.68178068428;4902.8774280643265;4903.779329930126;4944.752762361867;4761.714297142148;4857.222844344888;4880.536349046835;4881.414230292387;4898.779554920002;5394.676319420808;5485.0949593317055;5488.670679759227;5490.203920431555;5497.202905578709;5837.124431335291;5864.1203819427;5879.67661778602;5891.027980383232;5895.705214739246;5668.348139963916;5669.914951275734;5683.829485115411;5815.21494598228;5821.18503409523;5350.705711185922;5403.189521571757;5414.675119492843;5416.160495123262;5416.377116631559;5910.763569457174;5917.467427931507;5928.970355148197;5929.407059294036;5930.436608522184;5630.887382252332;5653.858653533613;5675.2054712340305;5727;5774.018416869142;5819.941800582024;5864.354920958691;5869.20765696634;5871.588988770745;5876.706164691748;5786.855328616734;5793.826185214366;5796.739146738407;5796.88406231873;5798.9420105799245;5619.494245517923;5635.718214089279;5638.154276858504;5655.886882262332;5716.228309178291;4346.826126954887;4351.086271882877;4351.782410879443;4354.194474022316;4386.7367957922625;3828.272628200633;3904.6485816276104;3907.159960608426;3956.40653901917;3962.0293028208275;5517.420670829585;5555.833325000256;5561.249231353796;5592.356878958972;5598.86002849932;5900.114982752536;5925.792597259161;5926.525877929756;5929.644221346733;5980.252468441445;5297.54970827484;5440.401555828856;5574.052411090124;5575.386707462176;5579.6652200868075;5022.397312322545;5051.924221136685;5052.9494705052475;5054.039732450822;5091.9236211456855;6006;6027.6986150693165;6029.336772954972;6031.065184896348;6045.063015232646;5714.257146570919;5748.137779333133;5803.100519419497;5845.1232315153065;5855.59010869235;6026.879462410815;6057;6058.212432383938;6059.606125601822;6097.237845269341;5697.003024470784;5727.255456790591;5736.19693242938;5738.741756620879;5744.052231381942;5702.429757024264;5830.125481177857;5846.386129456516;5877.823665289877;5925.111233315038;5729.3984131665575;5731.8853622928145;5732.971335143297;5742.483176514133;5744.684042377709;5693.5160511357;5713.7428815704225;5745.540356771532;5750.079987202028;5754.913676294943;5444.6188766785945;5568.220449137043;5587.106063029895;5620.85947851307;5660.830175094754;5779;5809.30288365382;5813.3605303417435;5838.970805145947;5843.29880414336;5469.863253418696;5618.353889302783;5662.235598194356;5664.830055098354;5699.715014249354 14:41:10 INFO - PROCESS | 17624 | |1;ext.html;593.1666009256995;610.7618028968701;629.3769168523162;631.5515983651607;649.6881496881493;31369.68630313699;33866.322673546514;33918;33946.32107357851;43538.12923741523;40381.59618403822;43564;43826.561734382645;43848;44085.559144408544;8513.574321283942;8722.084181160983;8728.650853965833;8729.563521823915;8736.563171841382;7984;8713.651453941835;10456.634017809378;10744.301620394688;10750.78498430031;10757.515911783988;10764;10783.352998820057;10796.460176991159;10826.512806923707;8102.716404925799;10690.091342235919;10738;10746.408947507884;10762.73093172677;10409.167266618653;10760.515776790064;10760.623378181726;10768.569257229701;11042.061424778904;40956.38565421521;41444.585554144374;44899.77550112228;44936.3259551107;44945.77527112376;3484.337975784593;3535.9292814143832;3629.274145170976;3715.6098609646137;3916.941245881314;33147.33705325904;34044.48933266003;34070.65929340725;34169.82915085433;34838;4401.6478681705385;4497.280435130363;4505.346724724929;4516.6612504061995;4553.248713962193;382760;386280;386533.9999999972;387449;387909;67402.66298668475;67403;67718.32281677218;67721;67744;37765;38506.80746596249;38523.614763852005;40007.79996100059;69826.65086674535;17176.914115429343;17334.65330693379;17341.219645116;17346.65306693859;17359.479215623553;11863.58477453285;12446.128770985944;12731.68170795719;12750.80873786894;12792;20557.280495182596;21544.89227553852;21560;21635.511916129533;21648.567028659338;7817.179196184433;7838.255365740246;8062.959685201537;8091.514509129471;8115.634796434175;974.2206235011962;1063.7181146996052;1161.1117495116243;1168.5909931524068;1223.9082068844873;33131.83434082814;33383.49924751131;33388.499172512435;33410.331793364;33651;1141.9200655954169;1153.682737247247;1183.2841131115551;1183.556166437586;1187.6080893305189;17428.390006349717;17455.476335709696;17549.385771497935;17587.82412175862;17596.648067038586;596820;598805;601565;603057;603701;60357.39642603518;60819;60881.391186088455;60911;60915.08627370593;1276.4192292506887;1383.163186272311;1390.7774756038984;1434.0821874000649;1434.7489189391815;32891;33600;33831.154221144665;33893.661063390035;34506.71423616313;51163.74418127885;52178.21732674089;52252.73873630608;52267.47732522626;52357;394322;395500;397867;399170;399629;25726.356841079123;28563;28993.7100628991;29036.56445153282;29373;49670.50329496803;49818.25272620841;50155.74922125366;50761;51164.48835511597;41006.384904225866;42143.36784948167;42359.3646095315;42787;43447.565524344354;41073.794631026656;42616.57383426126;42636;43200.56799432091;43251.78374108109;41177.1764564713;41501.169976600904;41806.1638767229;41833;42035.369469458594;36173.638263617024;37325.76920776048;37858.81070594629;37964.62035379611;38256.617433825304;28422.147335579964;28477.715222848336;28631.284217893884;28784.42431151407;28973 14:41:10 INFO - PROCESS | 17624 | |2;jquery.html;391.96864250859926;394.8262764383673;398.5177934699014;403.3586597310276;419.7775179155047;13855.722885542284;18580.721289180656;19822.40532784015;20290.289839855606;20310;15357.308921098549;18339.724904126448;18492.537686557844;19064.142113604885;19183.13675884585;5611.438856114387;5831.271091113611;5831.650100993933;5839.5620328475325;5861.355250922416;5715.342735585419;5772.220750198711;5797.9130313045125;5798.536117110642;5799.956007918573;4215.873523794291;6119.6328220306705;6371.808845734636;6406.93593064068;6496.642684652342;6315.305316415191;6451.354864513558;6463.515236357269;6477.190351206099;6505.577137486048;5568.52667523261;5645.802396916089;5655.802046928379;5678.063119585264;5696.971515142439;22947.1968481104;23010;24052.15817446381;24247.878760606083;24304.513909721707;2315.120254303354;2527.36815796051;2542.8855701493294;2962.066948911086;3140.842957852121;14339.498117565836;14474;14814.185219812905;14852.851471485255;15283.235838208157;1964.911578978935;2022.686483595045;2046.3758553641132;2079.8024187702295;2134.8185404240658;81344.59327703383;84304.15695843025;84470.57764711136;84557;85459.5727021361;10427.270091093702;10513.84229236562;10661.307015043998;11396.35316698665;11712;14781.113133212042;14902.329395177243;15007.624809379853;15025.924870375797;15032.549023529311;8165.101838797727;8427.452215606088;8447.493150410995;8511.914880851236;8531.104234055334;8237.876431853527;8282.627281772335;8287;8315.83368332642;8381.790455238668;5859.828034393053;6266.811995640138;6466.6766661666725;6692.732290708414;6743.35938085881;1856.981430185708;1904.1812020830898;1933.806619338055;1957.4910523263768;1961.2351183038627;469.76511744127936;986.2849434160177;1034.912032477248;1065.3181963543338;1080.8919108089285;11359.488823002985;11984.76030479403;12386.380680966096;12413.565525206755;12607.432665530074;458.8004218165109;478.7701903086538;486.10973605528494;487.2496355612388;496.1639637211238;6409.711562979677;6521.608703477807;6629.436497897636;6647;6697.732090716317;527496;533440;536282;536887;553408;94615.52692236495;96396.51801740947;96824.51587742016;98811;98967.50516247516;488.39682991505464;500.14225603090875;501.5511117549772;501.81934503578685;502.45985565516486;11158;11172.832407514057;11329.546818127183;11431.59989400367;11477.770444591228;30990.380192395576;41588.79205603953;42305.15389692127;42684.57315426806;43132.353014704175;61282;62512;62611.37388626055;63475;63565;8308.626111825104;8548.74353769388;8560.91439085601;8715.172058654418;8803.075677053817;9128.406653567497;11059.281146725438;12684.326117161629;12735.93632031871;12885.42015609281;11100.888991109985;11527.193096483501;11715.765684686088;11942.701432464259;11959.880401195876;11731.41342932833;11804.114691398352;11894.524219031142;11895;12024.158308918291;11731.530738770354;11872.643820685393;12138.696532586757;12176.0867934907;12293.323867187033;8627.95686021566;8669.696560620348;8678.739637810875;8711.47731136134;8726;9009.009009008872;11045.889541104487;11469.655910322703;11857.5849845255;12118.575849845565 14:41:10 INFO - PROCESS | 17624 | |3;mootools.html;1345.8183145275384;1525.1382968622731;1532.8390518995504;1729.411999920027;1864.804195559467;8557;8899.822003559933;8905.931288245412;9144.542772861363;9158.908410915888;8799.120087991198;9005.639774409032;9023.458592484456;9023.593938272777;9027.638894444231;2101.936941891746;2342.5197834443898;2386.832921695482;2412.4210189554556;2424.212131057405;2422.648715936188;2431.6230984197477;2435.561598912195;2440.6095024796036;2444.486657801855;2371.3715865295712;2413.9517209655796;2415.987920060406;2416.4562973331035;2418.7218469875925;2063.4531849060013;2335.602947498929;2399.004413168533;2401.0515846240637;2423.236680445654;2367.5028244068594;2371.454565449939;2374.5725769361507;2377.38188071101;2404.747501512351;9014.909850901538;9024.278057755364;9024.368294219406;9044.77388065297;9058.7282381528;5309.41596424393;5432.049391356497;5439.129739241703;5443.673379597197;5449.618526703132;3515.2969406118877;3515.894523164284;3558.857645694169;3638.6725194732335;3639.94540081899;1152.6196355202762;1163.2671417007232;1175.518037604578;1177.6437154110715;1216.367488905764;12700.936495317557;12727.427265773062;12729.55446559366;12758.362081895868;12777.616671499869;4785.779626195298;4798.904021919612;4836.637252206098;4849.612031037508;4905.2151655734915;10534.841977370346;10582.894171058191;10597.417142057107;10629.84055239172;10640.46797660114;4764.118638051971;5441.83674489766;5445.319335083114;5450.427705090988;5480.7533660985355;4884.3161957326;4999.975000124976;5007.499250074963;5034.949650503521;5037.319961805109;3968.897206544719;4023.195360927826;4068.4507591475362;4077.7553346799286;4176.874693759192;1276.310792172235;1279.3795009420423;1292.037432113063;1292.702678383958;1309.0378571749948;905.4250550900094;933.5425641435784;976.7411635916487;1014.6600888702368;1026.8819085805078;6086.482648974887;6167.753289868355;6282.654454005074;6412.4549413299455;6500.122483464766;466.5055041655856;474.9715017098916;476.3569181604875;478.9281607758864;482.19954874907484;4059.7564146150735;4108.897277568025;4222.809973551198;4306.418633484503;4307.6769242306955;10972.286801357886;11253.774924501628;11302.43487825622;11334.603288885015;11347.092232621371;11033.172512061628;11124.55501779936;11137.276077054965;11147.944260278648;11164.497597608128;7958.124606293303;8252.546109964009;8272.88316077334;8372.748817535483;8437.156284371515;5988.790392336247;6155.35368786271;6180.165677633462;6204.720787564661;6308.684565771785;10283.742906427398;10464.63373781914;10655.04104630556;10659.89340106589;10662.786744264917;10559.788804224027;10655.946720266349;10686.412247326472;10737.248392612755;10801.081908037904;7055.400290975324;7543.358814500829;7725.420593455626;8032.558209298545;8156.959215203886;8302.335813135056;8333.499990000619;8347.66609335644;8396.706115285935;8399.328053755808;7419.4806363554035;7436.442266829901;7607.923920760943;7618.085829700472;7692.615369231404;7473.850522989401;7487.138979017265;7511.51175173612;7543.207963163789;7615.695372185272;6357.93642063592;6405.743770249138;6426.4216220540375;6426.935730642634;6449.258335291313;4914.066327397783;4968.056069346812;5004.974975125101;5138.12651849179;5177.741112944413;5206.869828254324;5228.686278823283;5239.423663396947;5249.370075590953;5329.493698098674 14:41:10 INFO - PROCESS | 17624 | |4;prototype.html;307.8553080052376;320.58324178567864;323.9287356781509;327.7558219126751;328.41542055141855;5247.396549396821;5357.49103835136;5415.783368665254;5456.290682211312;5480.808171713991;5341.813036543722;5354.250404943311;5361.061814182522;5367.624266301351;5411.215373770801;4197.643200327968;4209.663226941837;4232.301670224425;4241.151769646068;4248.596383343577;4019.6583290420203;4064.5122585289805;4091.9590804092027;4219.957800422003;4243.533211346749;4103.261412945683;4125.113100683352;4161.812718427663;4167.291560434718;4169.249535083683;4125.979370103145;4138.4413104231;4138.8344466221315;4151.27352713277;4204.0540878302445;3597.928041439183;3599.063884877778;3664.9633503665154;3666.4500324951205;3672.210474747942;5087.56755675768;5109.897802043938;5114.360704911886;5160.174372100483;5163.277141200235;4646.976765116153;4697.224957881946;4698.154332220199;4715.481297057321;4744.501827308152;5393.568514518829;5534.889302213933;5557.805476808333;5559.805406810783;5564.527015203713;3913.688914213742;3931.174453364797;3944.881653550398;3951.8419263229434;3959.5644479107277;5740.856478588027;5741.885162296772;5754.6547207167705;5846.239988801472;5874.999999999957;3916.138449541096;4068.6541643960004;4070.5929407059057;4070.653994410449;4076.30702780528;4031;4062.1672557125717;4081.653059489977;4083.959160408358;4095.0990782027907;4679.110968915895;4706.976465117653;4707.882302942454;4729.881752956204;4734.502877197913;5527.861803454945;5607.915881261784;5608.42963970089;5636.718164091861;5695.943040569541;1392.7075314183933;1411.6682579593787;1413.3357322058616;1428.243031193469;1431.8711315981404;905.9094090590888;922.6447817590276;923.2106548900593;932.8927173375149;935.3359115028406;4850.563449289581;4854.611631069506;4892.657513974059;4915.459299477055;4927.39859545642;5097.133487307166;5106.693598384109;5138.458462461247;5164.715940623227;5172;4672.789724462407;4881.780319885543;4907.705537667752;4931.816364072669;4965.875853103701;2678.397360593851;2694.326418395401;2732.4425077705914;2778.6387769589824;2808.326001759563;5212.628254144431;5284.150547308488;5294.602904782157;5324.680519168863;5355.86610334737;4845.6123510119105;5144.806982309406;5154.304168937146;5204.869878252998;5221.477852214748;5255.343082114736;5300.337457817773;5312;5314.335708036496;5314.335708036496;5020.221865610836;5072.239164125411;5080.339555857715;5145.382554093533;5185.403678577012;4776.5854429754845;5037.370328708911;5056.418511871035;5075.746212689424;5075.974620126875;5306.373345193999;5308.57531397495;5311.920321195108;5343.225232341367;5370.650907690988;3712.3874560698264;3919.353306704362;3920.686345092329;4081.285774989424;4082.4284600156598;5673.234113394639;5710;5755.561109722569;5775.364709881994;5787.2187254720075;5573.996680597531;5575.358833734173;5644.322681278273;5647.6893770843;5672.14917762339;5451.972740136274;5689.886202276014;5707.400722924199;5723.399043100415;5765.654060756368;5588;5611.80358687444;5617.943820561905;5697.401772813961;5703.486686198096;5656.303109067346;5696.465073042456;5761.510271626791;5831.533477321719;5836.678982655994;5605.439456054362;5630.943690563042;5631.943680563142;5641.774329026793;5650.547956163579 14:41:10 INFO - PROCESS | 17624 | |5;yui.html;810.0967421325224;838.9035260944992;859.467130379165;865.3336930563462;876.3646356391613;14160.433582656682;14808.25958702066;14827.85172148281;14835.554933352018;14843.035202711817;12048.7590248195;13778.173309601405;13793.10344827588;13823.239721815296;13855;796.5977181523338;832.4089896173693;834.0366876257932;834.1283358889974;835.5696816139692;822.1080128061031;826.1903334731966;830.4311546590575;831.085805613823;831.3058596072287;699.7935608995358;865.2256230673544;867.9609417576193;868.535333596526;868.5483548554748;831.9459235149726;871.3160169267127;872.3675335381829;878.4070752242211;878.973630791071;636.6212103798233;642.1683919324486;642.1972534332085;642.6497558830449;642.858571114354;12827.551035713705;12829.61511154667;12849.4217760201;12886.097973141885;12917.612471625866;13821.239831809247;13929.233892135928;13939.581812545639;13982.860171398257;14152.29238538069;12405.62783116508;12408.255504669749;12450.3152326622;12701.491940322469;12801.103922725413;4509.143262780061;4509.549045095497;4525.751083690396;4526.502084770673;4539;57761.71119144419;58074;59293.703531482926;59373.40626593722;59514;11391.601293954673;11506.59726909571;11538.134639901873;11622.88377116218;11632.243904146204;19957.800421995886;20031.09860056301;20032.399028029184;20364.389068327975;20375.08312125958;8464.703735369356;8480.279176270085;8489.617967191367;8526.062133165347;8575.056743758181;4581.65637577183;4637.466691330473;4697.788599512962;4709.835155769531;4743.051389722069;3455.9654403455643;3560.6973407260157;3562.7327950403824;3563.127033876665;3565.16218688608;612.4824523277823;632.8228096132998;638.5530128909782;640.9519286053471;656.8522082531488;689.3864460630043;725.804032911111;729.7920092773534;754.2721273970535;758.9734359297398;8916.910830891738;8971.327150463741;9026.18764311215;9048.321375896834;9295.535223238947;640.4044238857907;655.8884989551788;698.9545679530814;709.8651256261294;740.8629403560359;4164.354525048622;4230.534641189467;4307.5261721210645;4335.1979883721615;4350.0647360817575;66171.66914165494;66738.66630666815;68811.65594171998;69512;69523;60202;61037.474063147885;61261;61393.69303153456;62884;52436.21345679818;52474.47525524696;52667.73666131645;52987.73506132522;53687;8212.876806848022;8274.793130171553;8288.875666864882;8346.290565302017;8403.696430173517;36655.633443665225;36725.44911826271;37794;38362.42456363213;38450.230995379374;44756.77621611871;48140.27789583229;48356.51643483661;48543.514564855315;49342;11548.364839933884;11602.941985290357;11634.476448560004;11712.238704484182;11999.16005879615;11930.284182948704;12357.135000549875;12586.748265034465;12681.556145534862;12908.677283067998;11896.345700986529;11949.581764638197;11980.221285616408;12069.215500992408;12147.088968327234;11757.706057348292;11898.345590992578;12106.213096148722;12176.878231217928;12245.693857653274;10872.565097396016;11225;11242.213045086766;11294.378809165575;11574.074074073886;9981.401115933068;10004.149647280063;10131.696049118538;10172.745681358025;10414.843777343498;9990.450525221182;10081.092701656886;10142.391456512632;10187.7453063674;10199.694009179737 14:41:10 INFO - PROCESS | 17624 | __end_tp_report 14:41:10 INFO - PROCESS | 17624 | __start_cc_report 14:41:10 INFO - PROCESS | 17624 | _x_x_mozilla_cycle_collect,847 14:41:10 INFO - PROCESS | 17624 | __end_cc_report 14:41:10 INFO - PROCESS | 17624 | __startTimestamp1464039670630__endTimestamp 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | ------- Summary: start ------- 14:41:10 INFO - PROCESS | 17624 | Number of tests: 6 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#0] dojo.html Cycles:165 Average:5389.19 Median:5630.89 stddev:635.21 (11.3%) stddev-sans-first:610.61 14:41:10 INFO - PROCESS | 17624 | Values: 3072.7 3114.3 3146.0 3146.9 3176.5 5184.1 5255.4 5270.8 5364.3 5386.9 5344.1 5357.3 5361.7 5397.1 5427.1 4617.2 4881.6 4942.8 4961.2 5005.5 4852.0 4927.9 4941.3 4988.3 5011.7 4790.0 4806.0 4832.1 4833.6 4839.5 4825.6 4895.7 4902.9 4903.8 4944.8 4761.7 4857.2 4880.5 4881.4 4898.8 5394.7 5485.1 5488.7 5490.2 5497.2 5837.1 5864.1 5879.7 5891.0 5895.7 5668.3 5669.9 5683.8 5815.2 5821.2 5350.7 5403.2 5414.7 5416.2 5416.4 5910.8 5917.5 5929.0 5929.4 5930.4 5630.9 5653.9 5675.2 5727.0 5774.0 5819.9 5864.4 5869.2 5871.6 5876.7 5786.9 5793.8 5796.7 5796.9 5798.9 5619.5 5635.7 5638.2 5655.9 5716.2 4346.8 4351.1 4351.8 4354.2 4386.7 3828.3 3904.6 3907.2 3956.4 3962.0 5517.4 5555.8 5561.2 5592.4 5598.9 5900.1 5925.8 5926.5 5929.6 5980.3 5297.5 5440.4 5574.1 5575.4 5579.7 5022.4 5051.9 5052.9 5054.0 5091.9 6006.0 6027.7 6029.3 6031.1 6045.1 5714.3 5748.1 5803.1 5845.1 5855.6 6026.9 6057.0 6058.2 6059.6 6097.2 5697.0 5727.3 5736.2 5738.7 5744.1 5702.4 5830.1 5846.4 5877.8 5925.1 5729.4 5731.9 5733.0 5742.5 5744.7 5693.5 5713.7 5745.5 5750.1 5754.9 5444.6 5568.2 5587.1 5620.9 5660.8 5779.0 5809.3 5813.4 5839.0 5843.3 5469.9 5618.4 5662.2 5664.8 5699.7 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#1] ext.html Cycles:180 Average:62317.96 Median:210633.40 stddev:125344.25 (59.5%) stddev-sans-first:125610.20 14:41:10 INFO - PROCESS | 17624 | Values: 593.2 610.8 629.4 631.6 649.7 31369.7 33866.3 33918.0 33946.3 43538.1 40381.6 43564.0 43826.6 43848.0 44085.6 8513.6 8722.1 8728.7 8729.6 8736.6 7984.0 8713.7 10456.6 10744.3 10750.8 10757.5 10764.0 10783.4 10796.5 10826.5 8102.7 10690.1 10738.0 10746.4 10762.7 10409.2 10760.5 10760.6 10768.6 11042.1 40956.4 41444.6 44899.8 44936.3 44945.8 3484.3 3535.9 3629.3 3715.6 3916.9 33147.3 34044.5 34070.7 34169.8 34838.0 4401.6 4497.3 4505.3 4516.7 4553.2 382760.0 386280.0 386534.0 387449.0 387909.0 67402.7 67403.0 67718.3 67721.0 67744.0 37765.0 38506.8 38523.6 40007.8 69826.7 17176.9 17334.7 17341.2 17346.7 17359.5 11863.6 12446.1 12731.7 12750.8 12792.0 20557.3 21544.9 21560.0 21635.5 21648.6 7817.2 7838.3 8063.0 8091.5 8115.6 974.2 1063.7 1161.1 1168.6 1223.9 33131.8 33383.5 33388.5 33410.3 33651.0 1141.9 1153.7 1183.3 1183.6 1187.6 17428.4 17455.5 17549.4 17587.8 17596.6 596820.0 598805.0 601565.0 603057.0 603701.0 60357.4 60819.0 60881.4 60911.0 60915.1 1276.4 1383.2 1390.8 1434.1 1434.7 32891.0 33600.0 33831.2 33893.7 34506.7 51163.7 52178.2 52252.7 52267.5 52357.0 394322.0 395500.0 397867.0 399170.0 399629.0 25726.4 28563.0 28993.7 29036.6 29373.0 49670.5 49818.3 50155.7 50761.0 51164.5 41006.4 42143.4 42359.4 42787.0 43447.6 41073.8 42616.6 42636.0 43200.6 43251.8 41177.2 41501.2 41806.2 41833.0 42035.4 36173.6 37325.8 37858.8 37964.6 38256.6 28422.1 28477.7 28631.3 28784.4 28973.0 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#2] jquery.html Cycles:180 Average:30273.97 Median:42908.46 stddev:88655.58 (206.6%) stddev-sans-first:88875.89 14:41:10 INFO - PROCESS | 17624 | Values: 392.0 394.8 398.5 403.4 419.8 13855.7 18580.7 19822.4 20290.3 20310.0 15357.3 18339.7 18492.5 19064.1 19183.1 5611.4 5831.3 5831.7 5839.6 5861.4 5715.3 5772.2 5797.9 5798.5 5800.0 4215.9 6119.6 6371.8 6406.9 6496.6 6315.3 6451.4 6463.5 6477.2 6505.6 5568.5 5645.8 5655.8 5678.1 5697.0 22947.2 23010.0 24052.2 24247.9 24304.5 2315.1 2527.4 2542.9 2962.1 3140.8 14339.5 14474.0 14814.2 14852.9 15283.2 1964.9 2022.7 2046.4 2079.8 2134.8 81344.6 84304.2 84470.6 84557.0 85459.6 10427.3 10513.8 10661.3 11396.4 11712.0 14781.1 14902.3 15007.6 15025.9 15032.5 8165.1 8427.5 8447.5 8511.9 8531.1 8237.9 8282.6 8287.0 8315.8 8381.8 5859.8 6266.8 6466.7 6692.7 6743.4 1857.0 1904.2 1933.8 1957.5 1961.2 469.8 986.3 1034.9 1065.3 1080.9 11359.5 11984.8 12386.4 12413.6 12607.4 458.8 478.8 486.1 487.2 496.2 6409.7 6521.6 6629.4 6647.0 6697.7 527496.0 533440.0 536282.0 536887.0 553408.0 94615.5 96396.5 96824.5 98811.0 98967.5 488.4 500.1 501.6 501.8 502.5 11158.0 11172.8 11329.5 11431.6 11477.8 30990.4 41588.8 42305.2 42684.6 43132.4 61282.0 62512.0 62611.4 63475.0 63565.0 8308.6 8548.7 8560.9 8715.2 8803.1 9128.4 11059.3 12684.3 12735.9 12885.4 11100.9 11527.2 11715.8 11942.7 11959.9 11731.4 11804.1 11894.5 11895.0 12024.2 11731.5 11872.6 12138.7 12176.1 12293.3 8628.0 8669.7 8678.7 8711.5 8726.0 9009.0 11045.9 11469.7 11857.6 12118.6 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#3] mootools.html Cycles:180 Average:5895.18 Median:2621.52 stddev:3392.76 (129.4%) stddev-sans-first:3385.05 14:41:10 INFO - PROCESS | 17624 | Values: 1345.8 1525.1 1532.8 1729.4 1864.8 8557.0 8899.8 8905.9 9144.5 9158.9 8799.1 9005.6 9023.5 9023.6 9027.6 2101.9 2342.5 2386.8 2412.4 2424.2 2422.6 2431.6 2435.6 2440.6 2444.5 2371.4 2414.0 2416.0 2416.5 2418.7 2063.5 2335.6 2399.0 2401.1 2423.2 2367.5 2371.5 2374.6 2377.4 2404.7 9014.9 9024.3 9024.4 9044.8 9058.7 5309.4 5432.0 5439.1 5443.7 5449.6 3515.3 3515.9 3558.9 3638.7 3639.9 1152.6 1163.3 1175.5 1177.6 1216.4 12700.9 12727.4 12729.6 12758.4 12777.6 4785.8 4798.9 4836.6 4849.6 4905.2 10534.8 10582.9 10597.4 10629.8 10640.5 4764.1 5441.8 5445.3 5450.4 5480.8 4884.3 5000.0 5007.5 5034.9 5037.3 3968.9 4023.2 4068.5 4077.8 4176.9 1276.3 1279.4 1292.0 1292.7 1309.0 905.4 933.5 976.7 1014.7 1026.9 6086.5 6167.8 6282.7 6412.5 6500.1 466.5 475.0 476.4 478.9 482.2 4059.8 4108.9 4222.8 4306.4 4307.7 10972.3 11253.8 11302.4 11334.6 11347.1 11033.2 11124.6 11137.3 11147.9 11164.5 7958.1 8252.5 8272.9 8372.7 8437.2 5988.8 6155.4 6180.2 6204.7 6308.7 10283.7 10464.6 10655.0 10659.9 10662.8 10559.8 10655.9 10686.4 10737.2 10801.1 7055.4 7543.4 7725.4 8032.6 8157.0 8302.3 8333.5 8347.7 8396.7 8399.3 7419.5 7436.4 7607.9 7618.1 7692.6 7473.9 7487.1 7511.5 7543.2 7615.7 6357.9 6405.7 6426.4 6426.9 6449.3 4914.1 4968.1 5005.0 5138.1 5177.7 5206.9 5228.7 5239.4 5249.4 5329.5 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#4] prototype.html Cycles:180 Average:4555.91 Median:5101.91 stddev:1327.15 (26.0%) stddev-sans-first:1292.00 14:41:10 INFO - PROCESS | 17624 | Values: 307.9 320.6 323.9 327.8 328.4 5247.4 5357.5 5415.8 5456.3 5480.8 5341.8 5354.3 5361.1 5367.6 5411.2 4197.6 4209.7 4232.3 4241.2 4248.6 4019.7 4064.5 4092.0 4220.0 4243.5 4103.3 4125.1 4161.8 4167.3 4169.2 4126.0 4138.4 4138.8 4151.3 4204.1 3597.9 3599.1 3665.0 3666.5 3672.2 5087.6 5109.9 5114.4 5160.2 5163.3 4647.0 4697.2 4698.2 4715.5 4744.5 5393.6 5534.9 5557.8 5559.8 5564.5 3913.7 3931.2 3944.9 3951.8 3959.6 5740.9 5741.9 5754.7 5846.2 5875.0 3916.1 4068.7 4070.6 4070.7 4076.3 4031.0 4062.2 4081.7 4084.0 4095.1 4679.1 4707.0 4707.9 4729.9 4734.5 5527.9 5607.9 5608.4 5636.7 5695.9 1392.7 1411.7 1413.3 1428.2 1431.9 905.9 922.6 923.2 932.9 935.3 4850.6 4854.6 4892.7 4915.5 4927.4 5097.1 5106.7 5138.5 5164.7 5172.0 4672.8 4881.8 4907.7 4931.8 4965.9 2678.4 2694.3 2732.4 2778.6 2808.3 5212.6 5284.2 5294.6 5324.7 5355.9 4845.6 5144.8 5154.3 5204.9 5221.5 5255.3 5300.3 5312.0 5314.3 5314.3 5020.2 5072.2 5080.3 5145.4 5185.4 4776.6 5037.4 5056.4 5075.7 5076.0 5306.4 5308.6 5311.9 5343.2 5370.7 3712.4 3919.4 3920.7 4081.3 4082.4 5673.2 5710.0 5755.6 5775.4 5787.2 5574.0 5575.4 5644.3 5647.7 5672.1 5452.0 5689.9 5707.4 5723.4 5765.7 5588.0 5611.8 5617.9 5697.4 5703.5 5656.3 5696.5 5761.5 5831.5 5836.7 5605.4 5630.9 5631.9 5641.8 5650.5 14:41:10 INFO - PROCESS | 17624 | 14:41:10 INFO - PROCESS | 17624 | [#5] yui.html Cycles:180 Average:15425.99 Median:4667.63 stddev:18664.98 (399.9%) stddev-sans-first:18685.07 14:41:10 INFO - PROCESS | 17624 | Values: 810.1 838.9 859.5 865.3 876.4 14160.4 14808.3 14827.9 14835.6 14843.0 12048.8 13778.2 13793.1 13823.2 13855.0 796.6 832.4 834.0 834.1 835.6 822.1 826.2 830.4 831.1 831.3 699.8 865.2 868.0 868.5 868.5 831.9 871.3 872.4 878.4 879.0 636.6 642.2 642.2 642.6 642.9 12827.6 12829.6 12849.4 12886.1 12917.6 13821.2 13929.2 13939.6 13982.9 14152.3 12405.6 12408.3 12450.3 12701.5 12801.1 4509.1 4509.5 4525.8 4526.5 4539.0 57761.7 58074.0 59293.7 59373.4 59514.0 11391.6 11506.6 11538.1 11622.9 11632.2 19957.8 20031.1 20032.4 20364.4 20375.1 8464.7 8480.3 8489.6 8526.1 8575.1 4581.7 4637.5 4697.8 4709.8 4743.1 3456.0 3560.7 3562.7 3563.1 3565.2 612.5 632.8 638.6 641.0 656.9 689.4 725.8 729.8 754.3 759.0 8916.9 8971.3 9026.2 9048.3 9295.5 640.4 655.9 699.0 709.9 740.9 4164.4 4230.5 4307.5 4335.2 4350.1 66171.7 66738.7 68811.7 69512.0 69523.0 60202.0 61037.5 61261.0 61393.7 62884.0 52436.2 52474.5 52667.7 52987.7 53687.0 8212.9 8274.8 8288.9 8346.3 8403.7 36655.6 36725.4 37794.0 38362.4 38450.2 44756.8 48140.3 48356.5 48543.5 49342.0 11548.4 11602.9 11634.5 11712.2 11999.2 11930.3 12357.1 12586.7 12681.6 12908.7 11896.3 11949.6 11980.2 12069.2 12147.1 11757.7 11898.3 12106.2 12176.9 12245.7 10872.6 11225.0 11242.2 11294.4 11574.1 9981.4 10004.1 10131.7 10172.7 10414.8 9990.5 10081.1 10142.4 10187.7 10199.7 14:41:10 INFO - PROCESS | 17624 | -------- Summary: end -------- 14:41:10 INFO - PROCESS | 17624 | 14:41:11 INFO - TEST-INFO | 17624: exit 0 14:41:11 INFO - TEST-OK | dromaeo_css | took 1113298ms 14:41:11 INFO - TEST-START | kraken 14:41:11 INFO - operating with platform_type : linux_ 14:41:11 INFO - Initialising browser for kraken test... 14:41:11 INFO - TEST-INFO | started process 17810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPtvgu/profile http://localhost:56302/getInfo.html) 14:41:15 INFO - PROCESS | 17810 | __metrics Screen width/height:1600/1200 14:41:15 INFO - PROCESS | 17810 | colorDepth:24 14:41:15 INFO - PROCESS | 17810 | Browser inner width/height: 1024/697 14:41:15 INFO - PROCESS | 17810 | __metrics 14:41:16 ERROR - PROCESS | 17810 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:41:17 INFO - TEST-INFO | 17810: exit 0 14:41:17 INFO - Browser initialized. 14:41:17 INFO - Running cycle 1/1 for kraken test... 14:41:17 INFO - TEST-INFO | started process 17895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPtvgu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:29 INFO - PROCESS | 17895 | RSS: Main: 152768512 14:41:29 INFO - PROCESS | 17895 | 14:41:32 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56302/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:32 INFO - PROCESS | 17895 | RSS: Main: 209178624 14:41:32 INFO - PROCESS | 17895 | 14:41:35 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56302/tests/kraken/driver.html?testName=audio-dft) 14:41:36 INFO - PROCESS | 17895 | RSS: Main: 197042176 14:41:36 INFO - PROCESS | 17895 | 14:41:39 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56302/tests/kraken/driver.html?testName=audio-fft) 14:41:40 INFO - PROCESS | 17895 | RSS: Main: 265342976 14:41:40 INFO - PROCESS | 17895 | 14:41:42 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56302/tests/kraken/driver.html?testName=audio-oscillator) 14:41:42 INFO - PROCESS | 17895 | RSS: Main: 174792704 14:41:42 INFO - PROCESS | 17895 | 14:41:45 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:45 INFO - PROCESS | 17895 | RSS: Main: 178573312 14:41:45 INFO - PROCESS | 17895 | 14:41:48 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56302/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:49 INFO - PROCESS | 17895 | RSS: Main: 215154688 14:41:49 INFO - PROCESS | 17895 | 14:41:53 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56302/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:53 INFO - PROCESS | 17895 | RSS: Main: 212881408 14:41:53 INFO - PROCESS | 17895 | 14:41:56 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56302/tests/kraken/driver.html?testName=json-parse-financial) 14:41:57 INFO - PROCESS | 17895 | RSS: Main: 213991424 14:41:57 INFO - PROCESS | 17895 | 14:41:58 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:59 INFO - PROCESS | 17895 | RSS: Main: 202670080 14:41:59 INFO - PROCESS | 17895 | 14:42:01 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:01 INFO - PROCESS | 17895 | RSS: Main: 204873728 14:42:01 INFO - PROCESS | 17895 | 14:42:04 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:04 INFO - PROCESS | 17895 | RSS: Main: 215330816 14:42:04 INFO - PROCESS | 17895 | 14:42:07 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:07 INFO - PROCESS | 17895 | RSS: Main: 224952320 14:42:07 INFO - PROCESS | 17895 | 14:42:10 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:11 INFO - PROCESS | 17895 | RSS: Main: 220831744 14:42:11 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | Cycle 1(1): loaded http://localhost:56302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56302/tests/kraken/driver.html?testName=ai-astar) 14:42:13 INFO - PROCESS | 17895 | RSS: Main: 266240000 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | __start_tp_report 14:42:13 INFO - PROCESS | 17895 | _x_x_mozilla_page_load 14:42:13 INFO - PROCESS | 17895 | _x_x_mozilla_page_load_details 14:42:13 INFO - PROCESS | 17895 | |i|pagename|runs| 14:42:13 INFO - PROCESS | 17895 | |0;ai-astar;111;106;112;110;111;110;110;109;111;110 14:42:13 INFO - PROCESS | 17895 | |1;audio-beat-detection;150;125;125;210;126;124;150;127;156;123 14:42:13 INFO - PROCESS | 17895 | |2;audio-dft;161;161;161;162;160;161;162;162;162;162 14:42:13 INFO - PROCESS | 17895 | |3;audio-fft;75;75;76;149;75;77;75;76;115;74 14:42:13 INFO - PROCESS | 17895 | |4;audio-oscillator;93;92;149;93;93;93;119;92;92;133 14:42:13 INFO - PROCESS | 17895 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;118;116;117 14:42:13 INFO - PROCESS | 17895 | |6;imaging-darkroom;146;145;145;146;145;146;146;145;145;146 14:42:13 INFO - PROCESS | 17895 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 14:42:13 INFO - PROCESS | 17895 | |8;json-parse-financial;53;54;53;52;54;53;53;107;51;51 14:42:13 INFO - PROCESS | 17895 | |9;json-stringify-tinderbox;61;61;61;62;63;62;62;62;62;63 14:42:13 INFO - PROCESS | 17895 | |10;stanford-crypto-aes;79;79;79;83;78;79;79;78;80;85 14:42:13 INFO - PROCESS | 17895 | |11;stanford-crypto-ccm;119;125;119;116;118;117;117;120;190;128 14:42:13 INFO - PROCESS | 17895 | |12;stanford-crypto-pbkdf2;165;159;163;163;160;165;160;161;159;162 14:42:13 INFO - PROCESS | 17895 | |13;stanford-crypto-sha256-iterative;62;62;62;63;62;61;63;61;64;61 14:42:13 INFO - PROCESS | 17895 | __end_tp_report 14:42:13 INFO - PROCESS | 17895 | __start_cc_report 14:42:13 INFO - PROCESS | 17895 | _x_x_mozilla_cycle_collect,1818 14:42:13 INFO - PROCESS | 17895 | __end_cc_report 14:42:13 INFO - PROCESS | 17895 | __startTimestamp1464039733283__endTimestamp 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | ------- Summary: start ------- 14:42:13 INFO - PROCESS | 17895 | Number of tests: 14 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.63 (1.5%) stddev-sans-first:1.69 14:42:13 INFO - PROCESS | 17895 | Values: 111.0 106.0 112.0 110.0 111.0 110.0 110.0 109.0 111.0 110.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:138.50 stddev:27.26 (19.7%) stddev-sans-first:28.75 14:42:13 INFO - PROCESS | 17895 | Values: 150.0 125.0 125.0 210.0 126.0 124.0 150.0 127.0 156.0 123.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 14:42:13 INFO - PROCESS | 17895 | Values: 161.0 161.0 161.0 162.0 160.0 161.0 162.0 162.0 162.0 162.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:25.20 (33.6%) stddev-sans-first:26.37 14:42:13 INFO - PROCESS | 17895 | Values: 75.0 75.0 76.0 149.0 75.0 77.0 75.0 76.0 115.0 74.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.50 stddev:21.08 (22.8%) stddev-sans-first:21.91 14:42:13 INFO - PROCESS | 17895 | Values: 93.0 92.0 149.0 93.0 93.0 93.0 119.0 92.0 92.0 133.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:42:13 INFO - PROCESS | 17895 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 118.0 116.0 117.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:42:13 INFO - PROCESS | 17895 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:42:13 INFO - PROCESS | 17895 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:53.00 stddev:17.21 (32.5%) stddev-sans-first:18.16 14:42:13 INFO - PROCESS | 17895 | Values: 53.0 54.0 53.0 52.0 54.0 53.0 53.0 107.0 51.0 51.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 14:42:13 INFO - PROCESS | 17895 | Values: 61.0 61.0 61.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.28 (2.9%) stddev-sans-first:2.40 14:42:13 INFO - PROCESS | 17895 | Values: 79.0 79.0 79.0 83.0 78.0 79.0 79.0 78.0 80.0 85.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:119.50 stddev:22.49 (18.8%) stddev-sans-first:23.67 14:42:13 INFO - PROCESS | 17895 | Values: 119.0 125.0 119.0 116.0 118.0 117.0 117.0 120.0 190.0 128.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.50 stddev:2.26 (1.4%) stddev-sans-first:2.06 14:42:13 INFO - PROCESS | 17895 | Values: 165.0 159.0 163.0 163.0 160.0 165.0 160.0 161.0 159.0 162.0 14:42:13 INFO - PROCESS | 17895 | 14:42:13 INFO - PROCESS | 17895 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 14:42:13 INFO - PROCESS | 17895 | Values: 62.0 62.0 62.0 63.0 62.0 61.0 63.0 61.0 64.0 61.0 14:42:13 INFO - PROCESS | 17895 | -------- Summary: end -------- 14:42:13 INFO - PROCESS | 17895 | 14:42:14 INFO - TEST-INFO | 17895: exit 0 14:42:14 INFO - TEST-OK | kraken | took 62937ms 14:42:14 INFO - SUITE-END | took 1176s 14:42:14 INFO - Completed test suite (00:19:36) 14:42:14 INFO - javascript benchmark 14:42:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.7234548890597, 3114.330418959924, 3146.0247323329777, 3146.921326966827, 3176.4600017996936, 5184.092783762836, 5255.448177941318, 5270.81552145675, 5364.275822763926, 5386.9461305386985, 5344.0915044442445, 5357.276767636368, 5361.678299302044, 5397.109476936311, 5427.104527752916, 4617.215073437524, 4881.609471242301, 4942.802287908479, 4961.18140506816, 5005.499450054984, 4851.951480485185, 4927.901441971158, 4941.308216849644, 4988.301637770697, 5011.67424117433, 4789.976050119762, 4805.975970120145, 4832.130216561018, 4833.637477189225, 4839.467658557556, 4825.613950883956, 4895.68178068428, 4902.8774280643265, 4903.779329930126, 4944.752762361867, 4761.714297142148, 4857.222844344888, 4880.536349046835, 4881.414230292387, 4898.779554920002, 5394.676319420808, 5485.0949593317055, 5488.670679759227, 5490.203920431555, 5497.202905578709, 5837.124431335291, 5864.1203819427, 5879.67661778602, 5891.027980383232, 5895.705214739246, 5668.348139963916, 5669.914951275734, 5683.829485115411, 5815.21494598228, 5821.18503409523, 5350.705711185922, 5403.189521571757, 5414.675119492843, 5416.160495123262, 5416.377116631559, 5910.763569457174, 5917.467427931507, 5928.970355148197, 5929.407059294036, 5930.436608522184, 5630.887382252332, 5653.858653533613, 5675.2054712340305, 5727.0, 5774.018416869142, 5819.941800582024, 5864.354920958691, 5869.20765696634, 5871.588988770745, 5876.706164691748, 5786.855328616734, 5793.826185214366, 5796.739146738407, 5796.88406231873, 5798.9420105799245, 5619.494245517923, 5635.718214089279, 5638.154276858504, 5655.886882262332, 5716.228309178291, 4346.826126954887, 4351.086271882877, 4351.782410879443, 4354.194474022316, 4386.7367957922625, 3828.272628200633, 3904.6485816276104, 3907.159960608426, 3956.40653901917, 3962.0293028208275, 5517.420670829585, 5555.833325000256, 5561.249231353796, 5592.356878958972, 5598.86002849932, 5900.114982752536, 5925.792597259161, 5926.525877929756, 5929.644221346733, 5980.252468441445, 5297.54970827484, 5440.401555828856, 5574.052411090124, 5575.386707462176, 5579.6652200868075, 5022.397312322545, 5051.924221136685, 5052.9494705052475, 5054.039732450822, 5091.9236211456855, 6006.0, 6027.6986150693165, 6029.336772954972, 6031.065184896348, 6045.063015232646, 5714.257146570919, 5748.137779333133, 5803.100519419497, 5845.1232315153065, 5855.59010869235, 6026.879462410815, 6057.0, 6058.212432383938, 6059.606125601822, 6097.237845269341, 5697.003024470784, 5727.255456790591, 5736.19693242938, 5738.741756620879, 5744.052231381942, 5702.429757024264, 5830.125481177857, 5846.386129456516, 5877.823665289877, 5925.111233315038, 5729.3984131665575, 5731.8853622928145, 5732.971335143297, 5742.483176514133, 5744.684042377709, 5693.5160511357, 5713.7428815704225, 5745.540356771532, 5750.079987202028, 5754.913676294943, 5444.6188766785945, 5568.220449137043, 5587.106063029895, 5620.85947851307, 5660.830175094754, 5779.0, 5809.30288365382, 5813.3605303417435, 5838.970805145947, 5843.29880414336, 5469.863253418696, 5618.353889302783, 5662.235598194356, 5664.830055098354, 5699.715014249354], "value": 5344.89942254848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.1666009256995, 610.7618028968701, 629.3769168523162, 631.5515983651607, 649.6881496881493, 31369.68630313699, 33866.322673546514, 33918.0, 33946.32107357851, 43538.12923741523, 40381.59618403822, 43564.0, 43826.561734382645, 43848.0, 44085.559144408544, 8513.574321283942, 8722.084181160983, 8728.650853965833, 8729.563521823915, 8736.563171841382, 7984.0, 8713.651453941835, 10456.634017809378, 10744.301620394688, 10750.78498430031, 10757.515911783988, 10764.0, 10783.352998820057, 10796.460176991159, 10826.512806923707, 8102.716404925799, 10690.091342235919, 10738.0, 10746.408947507884, 10762.73093172677, 10409.167266618653, 10760.515776790064, 10760.623378181726, 10768.569257229701, 11042.061424778904, 40956.38565421521, 41444.585554144374, 44899.77550112228, 44936.3259551107, 44945.77527112376, 3484.337975784593, 3535.9292814143832, 3629.274145170976, 3715.6098609646137, 3916.941245881314, 33147.33705325904, 34044.48933266003, 34070.65929340725, 34169.82915085433, 34838.0, 4401.6478681705385, 4497.280435130363, 4505.346724724929, 4516.6612504061995, 4553.248713962193, 382760.0, 386280.0, 386533.9999999972, 387449.0, 387909.0, 67402.66298668475, 67403.0, 67718.32281677218, 67721.0, 67744.0, 37765.0, 38506.80746596249, 38523.614763852005, 40007.79996100059, 69826.65086674535, 17176.914115429343, 17334.65330693379, 17341.219645116, 17346.65306693859, 17359.479215623553, 11863.58477453285, 12446.128770985944, 12731.68170795719, 12750.80873786894, 12792.0, 20557.280495182596, 21544.89227553852, 21560.0, 21635.511916129533, 21648.567028659338, 7817.179196184433, 7838.255365740246, 8062.959685201537, 8091.514509129471, 8115.634796434175, 974.2206235011962, 1063.7181146996052, 1161.1117495116243, 1168.5909931524068, 1223.9082068844873, 33131.83434082814, 33383.49924751131, 33388.499172512435, 33410.331793364, 33651.0, 1141.9200655954169, 1153.682737247247, 1183.2841131115551, 1183.556166437586, 1187.6080893305189, 17428.390006349717, 17455.476335709696, 17549.385771497935, 17587.82412175862, 17596.648067038586, 596820.0, 598805.0, 601565.0, 603057.0, 603701.0, 60357.39642603518, 60819.0, 60881.391186088455, 60911.0, 60915.08627370593, 1276.4192292506887, 1383.163186272311, 1390.7774756038984, 1434.0821874000649, 1434.7489189391815, 32891.0, 33600.0, 33831.154221144665, 33893.661063390035, 34506.71423616313, 51163.74418127885, 52178.21732674089, 52252.73873630608, 52267.47732522626, 52357.0, 394322.0, 395500.0, 397867.0, 399170.0, 399629.0, 25726.356841079123, 28563.0, 28993.7100628991, 29036.56445153282, 29373.0, 49670.50329496803, 49818.25272620841, 50155.74922125366, 50761.0, 51164.48835511597, 41006.384904225866, 42143.36784948167, 42359.3646095315, 42787.0, 43447.565524344354, 41073.794631026656, 42616.57383426126, 42636.0, 43200.56799432091, 43251.78374108109, 41177.1764564713, 41501.169976600904, 41806.1638767229, 41833.0, 42035.369469458594, 36173.638263617024, 37325.76920776048, 37858.81070594629, 37964.62035379611, 38256.617433825304, 28422.147335579964, 28477.715222848336, 28631.284217893884, 28784.42431151407, 28973.0], "value": 20859.619468149252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.96864250859926, 394.8262764383673, 398.5177934699014, 403.3586597310276, 419.7775179155047, 13855.722885542284, 18580.721289180656, 19822.40532784015, 20290.289839855606, 20310.0, 15357.308921098549, 18339.724904126448, 18492.537686557844, 19064.142113604885, 19183.13675884585, 5611.438856114387, 5831.271091113611, 5831.650100993933, 5839.5620328475325, 5861.355250922416, 5715.342735585419, 5772.220750198711, 5797.9130313045125, 5798.536117110642, 5799.956007918573, 4215.873523794291, 6119.6328220306705, 6371.808845734636, 6406.93593064068, 6496.642684652342, 6315.305316415191, 6451.354864513558, 6463.515236357269, 6477.190351206099, 6505.577137486048, 5568.52667523261, 5645.802396916089, 5655.802046928379, 5678.063119585264, 5696.971515142439, 22947.1968481104, 23010.0, 24052.15817446381, 24247.878760606083, 24304.513909721707, 2315.120254303354, 2527.36815796051, 2542.8855701493294, 2962.066948911086, 3140.842957852121, 14339.498117565836, 14474.0, 14814.185219812905, 14852.851471485255, 15283.235838208157, 1964.911578978935, 2022.686483595045, 2046.3758553641132, 2079.8024187702295, 2134.8185404240658, 81344.59327703383, 84304.15695843025, 84470.57764711136, 84557.0, 85459.5727021361, 10427.270091093702, 10513.84229236562, 10661.307015043998, 11396.35316698665, 11712.0, 14781.113133212042, 14902.329395177243, 15007.624809379853, 15025.924870375797, 15032.549023529311, 8165.101838797727, 8427.452215606088, 8447.493150410995, 8511.914880851236, 8531.104234055334, 8237.876431853527, 8282.627281772335, 8287.0, 8315.83368332642, 8381.790455238668, 5859.828034393053, 6266.811995640138, 6466.6766661666725, 6692.732290708414, 6743.35938085881, 1856.981430185708, 1904.1812020830898, 1933.806619338055, 1957.4910523263768, 1961.2351183038627, 469.76511744127936, 986.2849434160177, 1034.912032477248, 1065.3181963543338, 1080.8919108089285, 11359.488823002985, 11984.76030479403, 12386.380680966096, 12413.565525206755, 12607.432665530074, 458.8004218165109, 478.7701903086538, 486.10973605528494, 487.2496355612388, 496.1639637211238, 6409.711562979677, 6521.608703477807, 6629.436497897636, 6647.0, 6697.732090716317, 527496.0, 533440.0, 536282.0, 536887.0, 553408.0, 94615.52692236495, 96396.51801740947, 96824.51587742016, 98811.0, 98967.50516247516, 488.39682991505464, 500.14225603090875, 501.5511117549772, 501.81934503578685, 502.45985565516486, 11158.0, 11172.832407514057, 11329.546818127183, 11431.59989400367, 11477.770444591228, 30990.380192395576, 41588.79205603953, 42305.15389692127, 42684.57315426806, 43132.353014704175, 61282.0, 62512.0, 62611.37388626055, 63475.0, 63565.0, 8308.626111825104, 8548.74353769388, 8560.91439085601, 8715.172058654418, 8803.075677053817, 9128.406653567497, 11059.281146725438, 12684.326117161629, 12735.93632031871, 12885.42015609281, 11100.888991109985, 11527.193096483501, 11715.765684686088, 11942.701432464259, 11959.880401195876, 11731.41342932833, 11804.114691398352, 11894.524219031142, 11895.0, 12024.158308918291, 11731.530738770354, 11872.643820685393, 12138.696532586757, 12176.0867934907, 12293.323867187033, 8627.95686021566, 8669.696560620348, 8678.739637810875, 8711.47731136134, 8726.0, 9009.009009008872, 11045.889541104487, 11469.655910322703, 11857.5849845255, 12118.575849845565], "value": 8788.734619275301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.8183145275384, 1525.1382968622731, 1532.8390518995504, 1729.411999920027, 1864.804195559467, 8557.0, 8899.822003559933, 8905.931288245412, 9144.542772861363, 9158.908410915888, 8799.120087991198, 9005.639774409032, 9023.458592484456, 9023.593938272777, 9027.638894444231, 2101.936941891746, 2342.5197834443898, 2386.832921695482, 2412.4210189554556, 2424.212131057405, 2422.648715936188, 2431.6230984197477, 2435.561598912195, 2440.6095024796036, 2444.486657801855, 2371.3715865295712, 2413.9517209655796, 2415.987920060406, 2416.4562973331035, 2418.7218469875925, 2063.4531849060013, 2335.602947498929, 2399.004413168533, 2401.0515846240637, 2423.236680445654, 2367.5028244068594, 2371.454565449939, 2374.5725769361507, 2377.38188071101, 2404.747501512351, 9014.909850901538, 9024.278057755364, 9024.368294219406, 9044.77388065297, 9058.7282381528, 5309.41596424393, 5432.049391356497, 5439.129739241703, 5443.673379597197, 5449.618526703132, 3515.2969406118877, 3515.894523164284, 3558.857645694169, 3638.6725194732335, 3639.94540081899, 1152.6196355202762, 1163.2671417007232, 1175.518037604578, 1177.6437154110715, 1216.367488905764, 12700.936495317557, 12727.427265773062, 12729.55446559366, 12758.362081895868, 12777.616671499869, 4785.779626195298, 4798.904021919612, 4836.637252206098, 4849.612031037508, 4905.2151655734915, 10534.841977370346, 10582.894171058191, 10597.417142057107, 10629.84055239172, 10640.46797660114, 4764.118638051971, 5441.83674489766, 5445.319335083114, 5450.427705090988, 5480.7533660985355, 4884.3161957326, 4999.975000124976, 5007.499250074963, 5034.949650503521, 5037.319961805109, 3968.897206544719, 4023.195360927826, 4068.4507591475362, 4077.7553346799286, 4176.874693759192, 1276.310792172235, 1279.3795009420423, 1292.037432113063, 1292.702678383958, 1309.0378571749948, 905.4250550900094, 933.5425641435784, 976.7411635916487, 1014.6600888702368, 1026.8819085805078, 6086.482648974887, 6167.753289868355, 6282.654454005074, 6412.4549413299455, 6500.122483464766, 466.5055041655856, 474.9715017098916, 476.3569181604875, 478.9281607758864, 482.19954874907484, 4059.7564146150735, 4108.897277568025, 4222.809973551198, 4306.418633484503, 4307.6769242306955, 10972.286801357886, 11253.774924501628, 11302.43487825622, 11334.603288885015, 11347.092232621371, 11033.172512061628, 11124.55501779936, 11137.276077054965, 11147.944260278648, 11164.497597608128, 7958.124606293303, 8252.546109964009, 8272.88316077334, 8372.748817535483, 8437.156284371515, 5988.790392336247, 6155.35368786271, 6180.165677633462, 6204.720787564661, 6308.684565771785, 10283.742906427398, 10464.63373781914, 10655.04104630556, 10659.89340106589, 10662.786744264917, 10559.788804224027, 10655.946720266349, 10686.412247326472, 10737.248392612755, 10801.081908037904, 7055.400290975324, 7543.358814500829, 7725.420593455626, 8032.558209298545, 8156.959215203886, 8302.335813135056, 8333.499990000619, 8347.66609335644, 8396.706115285935, 8399.328053755808, 7419.4806363554035, 7436.442266829901, 7607.923920760943, 7618.085829700472, 7692.615369231404, 7473.850522989401, 7487.138979017265, 7511.51175173612, 7543.207963163789, 7615.695372185272, 6357.93642063592, 6405.743770249138, 6426.4216220540375, 6426.935730642634, 6449.258335291313, 4914.066327397783, 4968.056069346812, 5004.974975125101, 5138.12651849179, 5177.741112944413, 5206.869828254324, 5228.686278823283, 5239.423663396947, 5249.370075590953, 5329.493698098674], "value": 4640.403394425727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.8553080052376, 320.58324178567864, 323.9287356781509, 327.7558219126751, 328.41542055141855, 5247.396549396821, 5357.49103835136, 5415.783368665254, 5456.290682211312, 5480.808171713991, 5341.813036543722, 5354.250404943311, 5361.061814182522, 5367.624266301351, 5411.215373770801, 4197.643200327968, 4209.663226941837, 4232.301670224425, 4241.151769646068, 4248.596383343577, 4019.6583290420203, 4064.5122585289805, 4091.9590804092027, 4219.957800422003, 4243.533211346749, 4103.261412945683, 4125.113100683352, 4161.812718427663, 4167.291560434718, 4169.249535083683, 4125.979370103145, 4138.4413104231, 4138.8344466221315, 4151.27352713277, 4204.0540878302445, 3597.928041439183, 3599.063884877778, 3664.9633503665154, 3666.4500324951205, 3672.210474747942, 5087.56755675768, 5109.897802043938, 5114.360704911886, 5160.174372100483, 5163.277141200235, 4646.976765116153, 4697.224957881946, 4698.154332220199, 4715.481297057321, 4744.501827308152, 5393.568514518829, 5534.889302213933, 5557.805476808333, 5559.805406810783, 5564.527015203713, 3913.688914213742, 3931.174453364797, 3944.881653550398, 3951.8419263229434, 3959.5644479107277, 5740.856478588027, 5741.885162296772, 5754.6547207167705, 5846.239988801472, 5874.999999999957, 3916.138449541096, 4068.6541643960004, 4070.5929407059057, 4070.653994410449, 4076.30702780528, 4031.0, 4062.1672557125717, 4081.653059489977, 4083.959160408358, 4095.0990782027907, 4679.110968915895, 4706.976465117653, 4707.882302942454, 4729.881752956204, 4734.502877197913, 5527.861803454945, 5607.915881261784, 5608.42963970089, 5636.718164091861, 5695.943040569541, 1392.7075314183933, 1411.6682579593787, 1413.3357322058616, 1428.243031193469, 1431.8711315981404, 905.9094090590888, 922.6447817590276, 923.2106548900593, 932.8927173375149, 935.3359115028406, 4850.563449289581, 4854.611631069506, 4892.657513974059, 4915.459299477055, 4927.39859545642, 5097.133487307166, 5106.693598384109, 5138.458462461247, 5164.715940623227, 5172.0, 4672.789724462407, 4881.780319885543, 4907.705537667752, 4931.816364072669, 4965.875853103701, 2678.397360593851, 2694.326418395401, 2732.4425077705914, 2778.6387769589824, 2808.326001759563, 5212.628254144431, 5284.150547308488, 5294.602904782157, 5324.680519168863, 5355.86610334737, 4845.6123510119105, 5144.806982309406, 5154.304168937146, 5204.869878252998, 5221.477852214748, 5255.343082114736, 5300.337457817773, 5312.0, 5314.335708036496, 5314.335708036496, 5020.221865610836, 5072.239164125411, 5080.339555857715, 5145.382554093533, 5185.403678577012, 4776.5854429754845, 5037.370328708911, 5056.418511871035, 5075.746212689424, 5075.974620126875, 5306.373345193999, 5308.57531397495, 5311.920321195108, 5343.225232341367, 5370.650907690988, 3712.3874560698264, 3919.353306704362, 3920.686345092329, 4081.285774989424, 4082.4284600156598, 5673.234113394639, 5710.0, 5755.561109722569, 5775.364709881994, 5787.2187254720075, 5573.996680597531, 5575.358833734173, 5644.322681278273, 5647.6893770843, 5672.14917762339, 5451.972740136274, 5689.886202276014, 5707.400722924199, 5723.399043100415, 5765.654060756368, 5588.0, 5611.80358687444, 5617.943820561905, 5697.401772813961, 5703.486686198096, 5656.303109067346, 5696.465073042456, 5761.510271626791, 5831.533477321719, 5836.678982655994, 5605.439456054362, 5630.943690563042, 5631.943680563142, 5641.774329026793, 5650.547956163579], "value": 4132.1666525714745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.0967421325224, 838.9035260944992, 859.467130379165, 865.3336930563462, 876.3646356391613, 14160.433582656682, 14808.25958702066, 14827.85172148281, 14835.554933352018, 14843.035202711817, 12048.7590248195, 13778.173309601405, 13793.10344827588, 13823.239721815296, 13855.0, 796.5977181523338, 832.4089896173693, 834.0366876257932, 834.1283358889974, 835.5696816139692, 822.1080128061031, 826.1903334731966, 830.4311546590575, 831.085805613823, 831.3058596072287, 699.7935608995358, 865.2256230673544, 867.9609417576193, 868.535333596526, 868.5483548554748, 831.9459235149726, 871.3160169267127, 872.3675335381829, 878.4070752242211, 878.973630791071, 636.6212103798233, 642.1683919324486, 642.1972534332085, 642.6497558830449, 642.858571114354, 12827.551035713705, 12829.61511154667, 12849.4217760201, 12886.097973141885, 12917.612471625866, 13821.239831809247, 13929.233892135928, 13939.581812545639, 13982.860171398257, 14152.29238538069, 12405.62783116508, 12408.255504669749, 12450.3152326622, 12701.491940322469, 12801.103922725413, 4509.143262780061, 4509.549045095497, 4525.751083690396, 4526.502084770673, 4539.0, 57761.71119144419, 58074.0, 59293.703531482926, 59373.40626593722, 59514.0, 11391.601293954673, 11506.59726909571, 11538.134639901873, 11622.88377116218, 11632.243904146204, 19957.800421995886, 20031.09860056301, 20032.399028029184, 20364.389068327975, 20375.08312125958, 8464.703735369356, 8480.279176270085, 8489.617967191367, 8526.062133165347, 8575.056743758181, 4581.65637577183, 4637.466691330473, 4697.788599512962, 4709.835155769531, 4743.051389722069, 3455.9654403455643, 3560.6973407260157, 3562.7327950403824, 3563.127033876665, 3565.16218688608, 612.4824523277823, 632.8228096132998, 638.5530128909782, 640.9519286053471, 656.8522082531488, 689.3864460630043, 725.804032911111, 729.7920092773534, 754.2721273970535, 758.9734359297398, 8916.910830891738, 8971.327150463741, 9026.18764311215, 9048.321375896834, 9295.535223238947, 640.4044238857907, 655.8884989551788, 698.9545679530814, 709.8651256261294, 740.8629403560359, 4164.354525048622, 4230.534641189467, 4307.5261721210645, 4335.1979883721615, 4350.0647360817575, 66171.66914165494, 66738.66630666815, 68811.65594171998, 69512.0, 69523.0, 60202.0, 61037.474063147885, 61261.0, 61393.69303153456, 62884.0, 52436.21345679818, 52474.47525524696, 52667.73666131645, 52987.73506132522, 53687.0, 8212.876806848022, 8274.793130171553, 8288.875666864882, 8346.290565302017, 8403.696430173517, 36655.633443665225, 36725.44911826271, 37794.0, 38362.42456363213, 38450.230995379374, 44756.77621611871, 48140.27789583229, 48356.51643483661, 48543.514564855315, 49342.0, 11548.364839933884, 11602.941985290357, 11634.476448560004, 11712.238704484182, 11999.16005879615, 11930.284182948704, 12357.135000549875, 12586.748265034465, 12681.556145534862, 12908.677283067998, 11896.345700986529, 11949.581764638197, 11980.221285616408, 12069.215500992408, 12147.088968327234, 11757.706057348292, 11898.345590992578, 12106.213096148722, 12176.878231217928, 12245.693857653274, 10872.565097396016, 11225.0, 11242.213045086766, 11294.378809165575, 11574.074074073886, 9981.401115933068, 10004.149647280063, 10131.696049118538, 10172.745681358025, 10414.843777343498, 9990.450525221182, 10081.092701656886, 10142.391456512632, 10187.7453063674, 10199.694009179737], "value": 6823.30408678565, "unit": "score"}], "name": "dromaeo_css", "value": 7101.082698958691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 110.0, 111.0, 110.0, 110.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 125.0, 210.0, 126.0, 124.0, 150.0, 127.0, 156.0, 123.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 149.0, 75.0, 77.0, 75.0, 76.0, 115.0, 74.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 149.0, 93.0, 93.0, 93.0, 119.0, 92.0, 92.0, 133.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 54.0, 53.0, 53.0, 107.0, 51.0, 51.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 83.0, 78.0, 79.0, 79.0, 78.0, 80.0, 85.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 125.0, 119.0, 116.0, 118.0, 117.0, 117.0, 120.0, 190.0, 128.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 163.0, 163.0, 160.0, 165.0, 160.0, 161.0, 159.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 63.0, 61.0, 64.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1512.5000000000002, "alertThreshold": 2.0}]} 14:42:14 INFO - Return code: 0 14:42:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:42:14 ERROR - # TBPL SUCCESS # 14:42:14 INFO - Running post-action listener: _resource_record_post_action 14:42:14 INFO - ##### 14:42:14 INFO - ##### Finished run-tests step (success) 14:42:14 INFO - ##### 14:42:14 INFO - Running post-run listener: _resource_record_post_run 14:42:14 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545579008; Read time: 712; Write time: 1766980 14:42:14 INFO - TinderboxPrint: CPU usage
13.3% 14:42:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 712 14:42:14 INFO - TinderboxPrint: I/O write bytes / time
545,579,008 / 1,766,980 14:42:14 INFO - TinderboxPrint: CPU idle
8,261.6 (86.7%) 14:42:14 INFO - TinderboxPrint: CPU user
1,210.0 (12.7%) 14:42:14 INFO - TinderboxPrint: Swap in / out
0 / 0 14:42:14 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 4096; Write bytes: 259923968; Read time: 16; Write time: 1200732 14:42:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285593600; Read time: 696; Write time: 566224 14:42:15 INFO - Running post-run listener: _upload_blobber_files 14:42:15 INFO - Blob upload gear active. 14:42:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:15 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:42:15 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:42:15 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:42:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:20 INFO - (blobuploader) - INFO - Done attempting. 14:42:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:42:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:21 INFO - (blobuploader) - INFO - Done attempting. 14:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:42:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:21 INFO - (blobuploader) - INFO - Done attempting. 14:42:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:21 INFO - Return code: 0 14:42:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c3ecd4195d2bee1fedf1b178a28c5f49694604fe6735baffe92280ee94c872592f83c077180843350bc0e1586fc84c5279d9edb9a9e008c4eb624ba77163af0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94f28a1e06a21db993c8ea663152baeeffe4502a081932c39c76cb6c3da44dae577953b04d53c038179d76e89d987796245a1de9a5174d7719a1e2f2362fc65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cb09474d455993a3b917df8e0cb8afae24b9baa1cf8829daf6ec4fa0461a37731018404a69750b795b22f39a6912fb589764450c1bc7e90fda1cfb2422a939"} 14:42:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:21 INFO - Contents: 14:42:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c3ecd4195d2bee1fedf1b178a28c5f49694604fe6735baffe92280ee94c872592f83c077180843350bc0e1586fc84c5279d9edb9a9e008c4eb624ba77163af0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94f28a1e06a21db993c8ea663152baeeffe4502a081932c39c76cb6c3da44dae577953b04d53c038179d76e89d987796245a1de9a5174d7719a1e2f2362fc65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cb09474d455993a3b917df8e0cb8afae24b9baa1cf8829daf6ec4fa0461a37731018404a69750b795b22f39a6912fb589764450c1bc7e90fda1cfb2422a939"} 14:42:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:21 INFO - Copying logs to upload dir... 14:42:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.736008 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-23 14:42:21.448708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:42:21.452072) ========= 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=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c3ecd4195d2bee1fedf1b178a28c5f49694604fe6735baffe92280ee94c872592f83c077180843350bc0e1586fc84c5279d9edb9a9e008c4eb624ba77163af0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94f28a1e06a21db993c8ea663152baeeffe4502a081932c39c76cb6c3da44dae577953b04d53c038179d76e89d987796245a1de9a5174d7719a1e2f2362fc65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cb09474d455993a3b917df8e0cb8afae24b9baa1cf8829daf6ec4fa0461a37731018404a69750b795b22f39a6912fb589764450c1bc7e90fda1cfb2422a939"} build_url:https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/Nyfavs0YSpaczh6H9ZQzPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c3ecd4195d2bee1fedf1b178a28c5f49694604fe6735baffe92280ee94c872592f83c077180843350bc0e1586fc84c5279d9edb9a9e008c4eb624ba77163af0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94f28a1e06a21db993c8ea663152baeeffe4502a081932c39c76cb6c3da44dae577953b04d53c038179d76e89d987796245a1de9a5174d7719a1e2f2362fc65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47cb09474d455993a3b917df8e0cb8afae24b9baa1cf8829daf6ec4fa0461a37731018404a69750b795b22f39a6912fb589764450c1bc7e90fda1cfb2422a939"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:42:21.477749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:42:21.478092) ========= 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=df17445c3590ff7897617a0e00000225-1464038502.616041-1658800575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:42:21.560972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:42:21.561290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:42:21.561608) ========= ========= Total master_lag: 0.16 =========