builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1463629335.24 results: success (0) buildid: 20160518173013 builduid: 449475b2c0c5410aa40de0ed10be19c7 revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.239266) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.239704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.239978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.255765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.256092) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 20:42:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2016-05-18 20:42:15 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.358663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.362025) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:15.411524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 20:42:15.414906) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5bd03d0a58768dbe3184fa9f001372291bd679b8 --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 5bd03d0a58768dbe3184fa9f001372291bd679b8 --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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 20:42:15,835 truncating revision to first 12 chars 2016-05-18 20:42:15,835 Setting DEBUG logging. 2016-05-18 20:42:15,835 attempt 1/10 2016-05-18 20:42:15,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5bd03d0a5876?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 20:42:16,554 unpacking tar archive at: fx-team-5bd03d0a5876/testing/mozharness/ program finished with exit code 0 elapsedTime=1.007239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 20:42:16.438115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:16.438507) ========= script_repo_revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:16.438924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:16.439190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 20:42:16.449588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-18 20:42:16.449988) ========= /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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:42:16 INFO - MultiFileLogger online at 20160518 20:42:16 in /builds/slave/test 20:42:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:42:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:42:16 INFO - {'append_to_log': False, 20:42:16 INFO - 'base_work_dir': '/builds/slave/test', 20:42:16 INFO - 'blob_upload_branch': 'Fx-Team', 20:42:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:42:16 INFO - 'branch': 'Fx-Team', 20:42:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:42:16 INFO - 'config_files': ('talos/linux_config.py',), 20:42:16 INFO - 'default_actions': ('clobber', 20:42:16 INFO - 'read-buildbot-config', 20:42:16 INFO - 'download-and-extract', 20:42:16 INFO - 'populate-webroot', 20:42:16 INFO - 'create-virtualenv', 20:42:16 INFO - 'install', 20:42:16 INFO - 'run-tests'), 20:42:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:42:16 INFO - 'download_minidump_stackwalk': True, 20:42:16 INFO - 'download_symbols': 'ondemand', 20:42:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:42:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:42:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:42:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:42:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:42:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:42:16 INFO - 'installer_path': 'installer.exe', 20:42:16 INFO - 'log_level': 'info', 20:42:16 INFO - 'log_name': 'talos', 20:42:16 INFO - 'log_to_console': True, 20:42:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:42:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:42:16 INFO - 'opt_config_files': (), 20:42:16 INFO - 'pip_index': False, 20:42:16 INFO - 'sps_profile': False, 20:42:16 INFO - 'sps_profile_interval': 0, 20:42:16 INFO - 'suite': 'dromaeojs', 20:42:16 INFO - 'system_bits': '32', 20:42:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:42:16 INFO - 'title': 'talos-linux64-ix-001', 20:42:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:42:16 INFO - 'use_talos_json': True, 20:42:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:42:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:42:16 INFO - 'work_dir': 'build'} 20:42:16 INFO - ##### 20:42:16 INFO - ##### Running clobber step. 20:42:16 INFO - ##### 20:42:16 INFO - Running pre-action listener: _resource_record_pre_action 20:42:16 INFO - Running main action method: clobber 20:42:16 INFO - rmtree: /builds/slave/test/build 20:42:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:42:17 INFO - Running post-action listener: _resource_record_post_action 20:42:17 INFO - ##### 20:42:17 INFO - ##### Finished clobber step (success) 20:42:17 INFO - ##### 20:42:17 INFO - ##### 20:42:17 INFO - ##### Running read-buildbot-config step. 20:42:17 INFO - ##### 20:42:17 INFO - Running pre-action listener: _resource_record_pre_action 20:42:17 INFO - Running main action method: read_buildbot_config 20:42:17 INFO - Using buildbot properties: 20:42:17 INFO - { 20:42:17 INFO - "project": "", 20:42:17 INFO - "product": "firefox", 20:42:17 INFO - "script_repo_revision": "production", 20:42:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:42:17 INFO - "repository": "", 20:42:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:42:17 INFO - "buildid": "20160518173013", 20:42:17 INFO - "pgo_build": "True", 20:42:17 INFO - "basedir": "/builds/slave/test", 20:42:17 INFO - "buildnumber": 1165, 20:42:17 INFO - "slavename": "talos-linux64-ix-001", 20:42:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:42:17 INFO - "platform": "ubuntu64_hw", 20:42:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:42:17 INFO - "branch": "fx-team", 20:42:17 INFO - "repo_path": "integration/fx-team", 20:42:17 INFO - "revision": "5bd03d0a58768dbe3184fa9f001372291bd679b8", 20:42:17 INFO - "stage_platform": "linux64-pgo", 20:42:17 INFO - "builduid": "449475b2c0c5410aa40de0ed10be19c7", 20:42:17 INFO - "slavebuilddir": "test" 20:42:17 INFO - } 20:42:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:42:17 INFO - Running post-action listener: _resource_record_post_action 20:42:17 INFO - ##### 20:42:17 INFO - ##### Finished read-buildbot-config step (success) 20:42:17 INFO - ##### 20:42:17 INFO - ##### 20:42:17 INFO - ##### Running download-and-extract step. 20:42:17 INFO - ##### 20:42:17 INFO - Running pre-action listener: _resource_record_pre_action 20:42:17 INFO - Running main action method: download_and_extract 20:42:17 INFO - mkdir: /builds/slave/test/build/tests 20:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:17 INFO - https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:18 INFO - Downloaded 1361 bytes. 20:42:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:42:18 INFO - Using the following test package requirements: 20:42:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:42:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:42:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:42:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'jsshell-linux-x86_64.zip'], 20:42:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:42:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:42:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:42:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:42:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:42:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:42:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:42:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:42:18 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')]} 20:42:18 INFO - https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:42:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:42:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:42:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:19 INFO - Downloaded 24385535 bytes. 20:42:19 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'] 20:42:19 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 20:42:20 INFO - Return code: 0 20:42:20 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 20:42:20 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')]} 20:42:20 INFO - https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:21 INFO - Downloaded 24385535 bytes. 20:42:21 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'] 20:42:21 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 20:42:23 INFO - Return code: 0 20:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:23 INFO - https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:24 INFO - Downloaded 10840194 bytes. 20:42:24 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'] 20:42:24 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 20:42:24 INFO - Return code: 0 20:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:24 INFO - https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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 20:42:25 INFO - Downloaded 58442429 bytes. 20:42:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:42:25 INFO - mkdir: /builds/slave/test/properties 20:42:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:42:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:42:25 INFO - Contents: 20:42:25 INFO - build_url:https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:42:26 INFO - Running post-action listener: _resource_record_post_action 20:42:26 INFO - Running post-action listener: set_extra_try_arguments 20:42:26 INFO - ##### 20:42:26 INFO - ##### Finished download-and-extract step (success) 20:42:26 INFO - ##### 20:42:26 INFO - ##### 20:42:26 INFO - ##### Running populate-webroot step. 20:42:26 INFO - ##### 20:42:26 INFO - Running pre-action listener: _resource_record_pre_action 20:42:26 INFO - Running main action method: populate_webroot 20:42:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:26 INFO - '--tppagecycles', 20:42:26 INFO - '7'], 20:42:26 INFO - 'tests': ['tsvgm']}}, 20:42:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:42:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:42:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:42:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['damp', 'tps']}, 20:42:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'tests': ['damp', 'tps']}, 20:42:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['dromaeo_dom']}, 20:42:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['a11yr', 20:42:26 INFO - 'ts_paint', 20:42:26 INFO - 'tpaint', 20:42:26 INFO - 'sessionrestore', 20:42:26 INFO - 'sessionrestore_no_auto_restore', 20:42:26 INFO - 'tabpaint']}, 20:42:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['tsvgx', 20:42:26 INFO - 'tsvgr_opacity', 20:42:26 INFO - 'tart', 20:42:26 INFO - 'tscrollx', 20:42:26 INFO - 'cart']}, 20:42:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:42:26 INFO - 'tsvgr_opacity', 20:42:26 INFO - 'tart', 20:42:26 INFO - 'tscrollx', 20:42:26 INFO - 'cart']}, 20:42:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'talos_options': ['--disable-e10s'], 20:42:26 INFO - 'tests': ['tp5o']}, 20:42:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'tests': ['tp5o']}, 20:42:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'talos_options': ['--disable-e10s', 20:42:26 INFO - '--xperf_path', 20:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:26 INFO - 'tests': ['tp5n']}, 20:42:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:26 INFO - 'talos_options': ['--xperf_path', 20:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:26 INFO - 'tests': ['tp5n']}}, 20:42:26 INFO - 'talos.zip': {'path': '', 20:42:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:26 INFO - Running post-action listener: _resource_record_post_action 20:42:26 INFO - ##### 20:42:26 INFO - ##### Finished populate-webroot step (success) 20:42:26 INFO - ##### 20:42:26 INFO - ##### 20:42:26 INFO - ##### Running create-virtualenv step. 20:42:26 INFO - ##### 20:42:26 INFO - Running pre-action listener: _resource_record_pre_action 20:42:26 INFO - Running main action method: create_virtualenv 20:42:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:42:26 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 20:42:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:42:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:26 INFO - Using real prefix '/usr' 20:42:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:42:27 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:29 INFO - Installing pip.................done. 20:42:29 INFO - Return code: 0 20:42:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:42:29 INFO - Using env: {'DISPLAY': ':0', 20:42:29 INFO - 'HOME': '/home/cltbld', 20:42:29 INFO - 'LANG': 'en_US.UTF-8', 20:42:29 INFO - 'LANGUAGE': 'en_US:en', 20:42:29 INFO - 'LOGNAME': 'cltbld', 20:42:29 INFO - 'MAIL': '/var/mail/cltbld', 20:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:29 INFO - 'MOZ_NO_REMOTE': '1', 20:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:29 INFO - 'NO_EM_RESTART': '1', 20:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:29 INFO - 'PWD': '/builds/slave/test', 20:42:29 INFO - 'SHELL': '/bin/bash', 20:42:29 INFO - 'SHLVL': '1', 20:42:29 INFO - 'TERM': 'linux', 20:42:29 INFO - 'TMOUT': '86400', 20:42:29 INFO - 'USER': 'cltbld', 20:42:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:29 INFO - '_': '/tools/buildbot/bin/python'} 20:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:42:29 INFO - Cleaning up... 20:42:29 INFO - Return code: 0 20:42:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:42:29 INFO - Using env: {'DISPLAY': ':0', 20:42:29 INFO - 'HOME': '/home/cltbld', 20:42:29 INFO - 'LANG': 'en_US.UTF-8', 20:42:29 INFO - 'LANGUAGE': 'en_US:en', 20:42:29 INFO - 'LOGNAME': 'cltbld', 20:42:29 INFO - 'MAIL': '/var/mail/cltbld', 20:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:29 INFO - 'MOZ_NO_REMOTE': '1', 20:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:29 INFO - 'NO_EM_RESTART': '1', 20:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:29 INFO - 'PWD': '/builds/slave/test', 20:42:29 INFO - 'SHELL': '/bin/bash', 20:42:29 INFO - 'SHLVL': '1', 20:42:29 INFO - 'TERM': 'linux', 20:42:29 INFO - 'TMOUT': '86400', 20:42:29 INFO - 'USER': 'cltbld', 20:42:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:29 INFO - '_': '/tools/buildbot/bin/python'} 20:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:29 INFO - Downloading/unpacking psutil>=3.1.1 20:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:42:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:31 INFO - Installing collected packages: psutil 20:42:31 INFO - Running setup.py install for psutil 20:42:31 INFO - building 'psutil._psutil_linux' extension 20:42:31 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 20:42:31 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 20:42:31 INFO - building 'psutil._psutil_posix' extension 20:42:31 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 20:42:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:42:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:32 INFO - Successfully installed psutil 20:42:32 INFO - Cleaning up... 20:42:32 INFO - Return code: 0 20:42:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:42:32 INFO - Using env: {'DISPLAY': ':0', 20:42:32 INFO - 'HOME': '/home/cltbld', 20:42:32 INFO - 'LANG': 'en_US.UTF-8', 20:42:32 INFO - 'LANGUAGE': 'en_US:en', 20:42:32 INFO - 'LOGNAME': 'cltbld', 20:42:32 INFO - 'MAIL': '/var/mail/cltbld', 20:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:32 INFO - 'MOZ_NO_REMOTE': '1', 20:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:32 INFO - 'NO_EM_RESTART': '1', 20:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:32 INFO - 'PWD': '/builds/slave/test', 20:42:32 INFO - 'SHELL': '/bin/bash', 20:42:32 INFO - 'SHLVL': '1', 20:42:32 INFO - 'TERM': 'linux', 20:42:32 INFO - 'TMOUT': '86400', 20:42:32 INFO - 'USER': 'cltbld', 20:42:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:32 INFO - '_': '/tools/buildbot/bin/python'} 20:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:42:34 INFO - Installing collected packages: mozsystemmonitor 20:42:34 INFO - Running setup.py install for mozsystemmonitor 20:42:34 INFO - Successfully installed mozsystemmonitor 20:42:34 INFO - Cleaning up... 20:42:34 INFO - Return code: 0 20:42:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:42:34 INFO - Using env: {'DISPLAY': ':0', 20:42:34 INFO - 'HOME': '/home/cltbld', 20:42:34 INFO - 'LANG': 'en_US.UTF-8', 20:42:34 INFO - 'LANGUAGE': 'en_US:en', 20:42:34 INFO - 'LOGNAME': 'cltbld', 20:42:34 INFO - 'MAIL': '/var/mail/cltbld', 20:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:34 INFO - 'MOZ_NO_REMOTE': '1', 20:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:34 INFO - 'NO_EM_RESTART': '1', 20:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:34 INFO - 'PWD': '/builds/slave/test', 20:42:34 INFO - 'SHELL': '/bin/bash', 20:42:34 INFO - 'SHLVL': '1', 20:42:34 INFO - 'TERM': 'linux', 20:42:34 INFO - 'TMOUT': '86400', 20:42:34 INFO - 'USER': 'cltbld', 20:42:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:34 INFO - '_': '/tools/buildbot/bin/python'} 20:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:36 INFO - Downloading blobuploader-1.2.4.tar.gz 20:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:42:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:42:36 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 20:42:36 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 20:42:36 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 20:42:36 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 20:42:36 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 20:42:36 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 20:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:42:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:37 INFO - Downloading docopt-0.6.1.tar.gz 20:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:42:37 INFO - Installing collected packages: blobuploader, requests, docopt 20:42:37 INFO - Running setup.py install for blobuploader 20:42:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:42:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:42:37 INFO - Running setup.py install for requests 20:42:38 INFO - Running setup.py install for docopt 20:42:38 INFO - Successfully installed blobuploader requests docopt 20:42:38 INFO - Cleaning up... 20:42:38 INFO - Return code: 0 20:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:42:38 INFO - Using env: {'DISPLAY': ':0', 20:42:38 INFO - 'HOME': '/home/cltbld', 20:42:38 INFO - 'LANG': 'en_US.UTF-8', 20:42:38 INFO - 'LANGUAGE': 'en_US:en', 20:42:38 INFO - 'LOGNAME': 'cltbld', 20:42:38 INFO - 'MAIL': '/var/mail/cltbld', 20:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:38 INFO - 'MOZ_NO_REMOTE': '1', 20:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:38 INFO - 'NO_EM_RESTART': '1', 20:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:38 INFO - 'PWD': '/builds/slave/test', 20:42:38 INFO - 'SHELL': '/bin/bash', 20:42:38 INFO - 'SHLVL': '1', 20:42:38 INFO - 'TERM': 'linux', 20:42:38 INFO - 'TMOUT': '86400', 20:42:38 INFO - 'USER': 'cltbld', 20:42:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:38 INFO - '_': '/tools/buildbot/bin/python'} 20:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:42:38 INFO - Running setup.py (path:/tmp/pip-aLzqWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:42:38 INFO - Running setup.py (path:/tmp/pip-b9TDpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:42:38 INFO - Running setup.py (path:/tmp/pip-yTZI9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:42:38 INFO - Running setup.py (path:/tmp/pip-FNdvRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:38 INFO - Running setup.py (path:/tmp/pip-Fpsoqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:38 INFO - Running setup.py (path:/tmp/pip-Tbaskd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:38 INFO - Running setup.py (path:/tmp/pip-U8l7Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:38 INFO - Running setup.py (path:/tmp/pip-5t0j8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:38 INFO - Running setup.py (path:/tmp/pip-iyqiP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:39 INFO - Running setup.py (path:/tmp/pip-hvFQ_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:39 INFO - Running setup.py (path:/tmp/pip-DRDnZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:39 INFO - Running setup.py (path:/tmp/pip-M4N7lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:39 INFO - Running setup.py (path:/tmp/pip-GfWJew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:39 INFO - Running setup.py (path:/tmp/pip-DORRfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:39 INFO - Running setup.py (path:/tmp/pip-UJMrDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:39 INFO - Running setup.py (path:/tmp/pip-7BtYXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:39 INFO - Running setup.py (path:/tmp/pip-KvL_F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:39 INFO - Running setup.py install for manifestparser 20:42:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:42:39 INFO - Running setup.py install for mozcrash 20:42:39 INFO - Running setup.py install for mozdebug 20:42:39 INFO - Running setup.py install for mozdevice 20:42:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:42:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:42:39 INFO - Running setup.py install for mozfile 20:42:40 INFO - Running setup.py install for mozhttpd 20:42:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for mozinfo 20:42:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for mozInstall 20:42:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for mozleak 20:42:40 INFO - Running setup.py install for mozlog 20:42:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for moznetwork 20:42:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for mozprocess 20:42:40 INFO - Running setup.py install for mozprofile 20:42:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:42:40 INFO - Running setup.py install for mozrunner 20:42:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:42:41 INFO - Running setup.py install for mozscreenshot 20:42:41 INFO - Running setup.py install for moztest 20:42:41 INFO - Running setup.py install for mozversion 20:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:41 INFO - Cleaning up... 20:42:41 INFO - Return code: 0 20:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:42:41 INFO - Using env: {'DISPLAY': ':0', 20:42:41 INFO - 'HOME': '/home/cltbld', 20:42:41 INFO - 'LANG': 'en_US.UTF-8', 20:42:41 INFO - 'LANGUAGE': 'en_US:en', 20:42:41 INFO - 'LOGNAME': 'cltbld', 20:42:41 INFO - 'MAIL': '/var/mail/cltbld', 20:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:41 INFO - 'MOZ_NO_REMOTE': '1', 20:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:41 INFO - 'NO_EM_RESTART': '1', 20:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:41 INFO - 'PWD': '/builds/slave/test', 20:42:41 INFO - 'SHELL': '/bin/bash', 20:42:41 INFO - 'SHLVL': '1', 20:42:41 INFO - 'TERM': 'linux', 20:42:41 INFO - 'TMOUT': '86400', 20:42:41 INFO - 'USER': 'cltbld', 20:42:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:41 INFO - '_': '/tools/buildbot/bin/python'} 20:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:42:41 INFO - Running setup.py (path:/tmp/pip-Q3GbgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:42:41 INFO - Running setup.py (path:/tmp/pip-qxX0Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:42:41 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)) 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:42:41 INFO - Running setup.py (path:/tmp/pip-7BfBEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:42:41 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)) 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:42:41 INFO - Running setup.py (path:/tmp/pip-Glqcdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:41 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)) 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:41 INFO - Running setup.py (path:/tmp/pip-uocvlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:41 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)) 20:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:41 INFO - Running setup.py (path:/tmp/pip-Y2ltGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:42 INFO - Running setup.py (path:/tmp/pip-QxDzip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:42 INFO - Running setup.py (path:/tmp/pip-gIMobU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:42 INFO - Running setup.py (path:/tmp/pip-qOF0ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:42 INFO - Running setup.py (path:/tmp/pip-1KThzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:42 INFO - Running setup.py (path:/tmp/pip-_V3ajH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:42 INFO - Running setup.py (path:/tmp/pip-bInKBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:42 INFO - Running setup.py (path:/tmp/pip-UwLi6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:42 INFO - Running setup.py (path:/tmp/pip-jlSGcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:42 INFO - Running setup.py (path:/tmp/pip-UBfU4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:42 INFO - Running setup.py (path:/tmp/pip-xRlfcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:42 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)) 20:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:42 INFO - Running setup.py (path:/tmp/pip-oOPnPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:42 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)) 20:42:42 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)) 20:42:42 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)) 20:42:42 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)) 20:42:42 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)) 20:42:42 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)) 20:42:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:42 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 20:42:42 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 20:42:42 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 20:42:42 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 20:42:42 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 20:42:42 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 20:42:44 INFO - Downloading blessings-1.6.tar.gz 20:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:44 INFO - Installing collected packages: blessings 20:42:44 INFO - Running setup.py install for blessings 20:42:44 INFO - Successfully installed blessings 20:42:44 INFO - Cleaning up... 20:42:44 INFO - Return code: 0 20:42:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:45 INFO - Reading from file tmpfile_stdout 20:42:45 INFO - Current package versions: 20:42:45 INFO - argparse == 1.2.1 20:42:45 INFO - blessings == 1.6 20:42:45 INFO - blobuploader == 1.2.4 20:42:45 INFO - docopt == 0.6.1 20:42:45 INFO - manifestparser == 1.1 20:42:45 INFO - mozInstall == 1.12 20:42:45 INFO - mozcrash == 0.17 20:42:45 INFO - mozdebug == 0.1 20:42:45 INFO - mozdevice == 0.48 20:42:45 INFO - mozfile == 1.2 20:42:45 INFO - mozhttpd == 0.7 20:42:45 INFO - mozinfo == 0.9 20:42:45 INFO - mozleak == 0.1 20:42:45 INFO - mozlog == 3.2 20:42:45 INFO - moznetwork == 0.27 20:42:45 INFO - mozprocess == 0.22 20:42:45 INFO - mozprofile == 0.28 20:42:45 INFO - mozrunner == 6.11 20:42:45 INFO - mozscreenshot == 0.1 20:42:45 INFO - mozsystemmonitor == 0.3 20:42:45 INFO - moztest == 0.7 20:42:45 INFO - mozversion == 1.4 20:42:45 INFO - psutil == 3.1.1 20:42:45 INFO - requests == 1.2.3 20:42:45 INFO - wsgiref == 0.1.2 20:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:42:45 INFO - Using env: {'DISPLAY': ':0', 20:42:45 INFO - 'HOME': '/home/cltbld', 20:42:45 INFO - 'LANG': 'en_US.UTF-8', 20:42:45 INFO - 'LANGUAGE': 'en_US:en', 20:42:45 INFO - 'LOGNAME': 'cltbld', 20:42:45 INFO - 'MAIL': '/var/mail/cltbld', 20:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:45 INFO - 'MOZ_NO_REMOTE': '1', 20:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:45 INFO - 'NO_EM_RESTART': '1', 20:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:45 INFO - 'PWD': '/builds/slave/test', 20:42:45 INFO - 'SHELL': '/bin/bash', 20:42:45 INFO - 'SHLVL': '1', 20:42:45 INFO - 'TERM': 'linux', 20:42:45 INFO - 'TMOUT': '86400', 20:42:45 INFO - 'USER': 'cltbld', 20:42:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:45 INFO - '_': '/tools/buildbot/bin/python'} 20:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:42:45 INFO - Cleaning up... 20:42:45 INFO - Return code: 0 20:42:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:42:45 INFO - Using env: {'DISPLAY': ':0', 20:42:45 INFO - 'HOME': '/home/cltbld', 20:42:45 INFO - 'LANG': 'en_US.UTF-8', 20:42:45 INFO - 'LANGUAGE': 'en_US:en', 20:42:45 INFO - 'LOGNAME': 'cltbld', 20:42:45 INFO - 'MAIL': '/var/mail/cltbld', 20:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:45 INFO - 'MOZ_NO_REMOTE': '1', 20:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:45 INFO - 'NO_EM_RESTART': '1', 20:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:45 INFO - 'PWD': '/builds/slave/test', 20:42:45 INFO - 'SHELL': '/bin/bash', 20:42:45 INFO - 'SHLVL': '1', 20:42:45 INFO - 'TERM': 'linux', 20:42:45 INFO - 'TMOUT': '86400', 20:42:45 INFO - 'USER': 'cltbld', 20:42:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:45 INFO - '_': '/tools/buildbot/bin/python'} 20:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:45 INFO - Downloading/unpacking jsonschema 20:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:42:47 INFO - Downloading/unpacking functools32 (from jsonschema) 20:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:47 INFO - Downloading functools32-3.2.3-2.tar.gz 20:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:42:47 INFO - warning: no files found matching '*.txt' 20:42:47 INFO - no previously-included directories found matching 'build' 20:42:47 INFO - no previously-included directories found matching 'dist' 20:42:47 INFO - no previously-included directories found matching '.git*' 20:42:47 INFO - Installing collected packages: jsonschema, functools32 20:42:47 INFO - Running setup.py install for functools32 20:42:47 INFO - warning: no files found matching '*.txt' 20:42:47 INFO - no previously-included directories found matching 'build' 20:42:47 INFO - no previously-included directories found matching 'dist' 20:42:47 INFO - no previously-included directories found matching '.git*' 20:42:47 INFO - Successfully installed jsonschema functools32 20:42:47 INFO - Cleaning up... 20:42:47 INFO - Return code: 0 20:42:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:42:47 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')]} 20:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:47 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')]} 20:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:47 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 0x7f83a70aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x232b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', '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 20:42:47 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 20:42:47 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 20:42:47 INFO - Using env: {'DISPLAY': ':0', 20:42:47 INFO - 'HOME': '/home/cltbld', 20:42:47 INFO - 'LANG': 'en_US.UTF-8', 20:42:47 INFO - 'LANGUAGE': 'en_US:en', 20:42:47 INFO - 'LOGNAME': 'cltbld', 20:42:47 INFO - 'MAIL': '/var/mail/cltbld', 20:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:47 INFO - 'MOZ_NO_REMOTE': '1', 20:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:47 INFO - 'NO_EM_RESTART': '1', 20:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:47 INFO - 'PWD': '/builds/slave/test', 20:42:47 INFO - 'SHELL': '/bin/bash', 20:42:47 INFO - 'SHLVL': '1', 20:42:47 INFO - 'TERM': 'linux', 20:42:47 INFO - 'TMOUT': '86400', 20:42:47 INFO - 'USER': 'cltbld', 20:42:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:47 INFO - '_': '/tools/buildbot/bin/python'} 20:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:48 INFO - Downloading/unpacking flake8 20:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:42:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:42:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:42:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:42:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:42:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:42:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:42:50 INFO - no previously-included directories found matching 'docs/_build' 20:42:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:42:50 INFO - Running setup.py install for pep8 20:42:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:42:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:42:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:42:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:42:50 INFO - no previously-included directories found matching 'docs/_build' 20:42:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:42:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:42:51 INFO - Cleaning up... 20:42:51 INFO - Return code: 0 20:42:51 INFO - Running post-action listener: _resource_record_post_action 20:42:51 INFO - Running post-action listener: _start_resource_monitoring 20:42:51 INFO - Starting resource monitoring. 20:42:51 INFO - ##### 20:42:51 INFO - ##### Finished create-virtualenv step (success) 20:42:51 INFO - ##### 20:42:51 INFO - ##### 20:42:51 INFO - ##### Running install step. 20:42:51 INFO - ##### 20:42:51 INFO - Running pre-action listener: _resource_record_pre_action 20:42:51 INFO - Running main action method: install 20:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:51 INFO - Reading from file tmpfile_stdout 20:42:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:42:51 INFO - Reading from file tmpfile_stdout 20:42:51 INFO - Output received: 20:42:51 INFO - Usage: mozinstall [options] installer 20:42:51 INFO - Options: 20:42:51 INFO - -h, --help show this help message and exit 20:42:51 INFO - -d DEST, --destination=DEST 20:42:51 INFO - Directory to install application into. [default: 20:42:51 INFO - "/builds/slave/test"] 20:42:51 INFO - --app=APP Application being installed. [default: firefox] 20:42:51 INFO - mkdir: /builds/slave/test/build/application 20:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:43:07 INFO - Reading from file tmpfile_stdout 20:43:07 INFO - Output received: 20:43:07 INFO - /builds/slave/test/build/application/firefox/firefox 20:43:07 INFO - Running post-action listener: _resource_record_post_action 20:43:07 INFO - ##### 20:43:07 INFO - ##### Finished install step (success) 20:43:07 INFO - ##### 20:43:07 INFO - ##### 20:43:07 INFO - ##### Running run-tests step. 20:43:07 INFO - ##### 20:43:07 INFO - Running pre-action listener: _resource_record_pre_action 20:43:07 INFO - Running main action method: run_tests 20:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:43:07 INFO - Python 2.7.3 20:43:07 INFO - Return code: 0 20:43:07 INFO - grabbing minidump binary from tooltool 20:43:07 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')]} 20:43:07 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 0x23ba9c0>, '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 0x23bb8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bbd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:43:07 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 20:43:07 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 20:43:07 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 20:43:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:43:08 INFO - Return code: 0 20:43:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:43:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:43:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:43:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:43:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:43:08 INFO - Return code: 0 20:43:08 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/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 20:43:08 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/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 20:43:08 INFO - Using env: {'DISPLAY': ':0', 20:43:08 INFO - 'HOME': '/home/cltbld', 20:43:08 INFO - 'LANG': 'en_US.UTF-8', 20:43:08 INFO - 'LANGUAGE': 'en_US:en', 20:43:08 INFO - 'LOGNAME': 'cltbld', 20:43:08 INFO - 'MAIL': '/var/mail/cltbld', 20:43:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:43:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:43:08 INFO - 'MOZ_NO_REMOTE': '1', 20:43:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:43:08 INFO - 'NO_EM_RESTART': '1', 20:43:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:43:08 INFO - 'PWD': '/builds/slave/test', 20:43:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:43:08 INFO - 'SHELL': '/bin/bash', 20:43:08 INFO - 'SHLVL': '1', 20:43:08 INFO - 'TERM': 'linux', 20:43:08 INFO - 'TMOUT': '86400', 20:43:08 INFO - 'USER': 'cltbld', 20:43:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306', 20:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:43:08 INFO - '_': '/tools/buildbot/bin/python'} 20:43:08 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/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 20:43:09 INFO - mozversion application_buildid: 20160518173013 20:43:09 INFO - mozversion application_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 20:43:09 INFO - mozversion application_display_name: Nightly 20:43:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:43:09 INFO - mozversion application_name: Firefox 20:43:09 INFO - mozversion application_remotingname: firefox 20:43:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:43:09 INFO - mozversion application_vendor: Mozilla 20:43:09 INFO - mozversion application_version: 49.0a1 20:43:09 INFO - mozversion platform_buildid: 20160518173013 20:43:09 INFO - mozversion platform_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 20:43:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:43:09 INFO - mozversion platform_version: 49.0a1 20:43:09 INFO - using testdate: 1463629389 20:43:09 INFO - actual date: 1463629389 20:43:09 INFO - starting webserver on 'localhost:34369' 20:43:09 INFO - SUITE-START | Running 2 tests 20:43:09 INFO - TEST-START | dromaeo_css 20:43:09 INFO - operating with platform_type : linux_ 20:43:09 INFO - Initialising browser for dromaeo_css test... 20:43:09 INFO - TEST-INFO | started process 30660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxVhjC/profile http://localhost:34369/getInfo.html) 20:43:13 INFO - PROCESS | 30660 | __metrics Screen width/height:1600/1200 20:43:13 INFO - PROCESS | 30660 | colorDepth:24 20:43:13 INFO - PROCESS | 30660 | Browser inner width/height: 1024/697 20:43:13 INFO - PROCESS | 30660 | __metrics 20:43:14 ERROR - PROCESS | 30660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:43:14 INFO - TEST-INFO | 30660: exit 0 20:43:14 INFO - Browser initialized. 20:43:14 INFO - Running cycle 1/1 for dromaeo_css test... 20:43:14 INFO - TEST-INFO | started process 30738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXxVhjC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:26 INFO - PROCESS | 30738 | RSS: Main: 152961024 20:43:26 INFO - PROCESS | 30738 | 20:44:17 INFO - PROCESS | 30738 | 1463629457770 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] 20:46:26 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34369/tests/dromaeo/cssquery-ext.html) 20:46:27 INFO - PROCESS | 30738 | RSS: Main: 281911296 20:46:27 INFO - PROCESS | 30738 | 20:49:29 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-ext.html (next: http://localhost:34369/tests/dromaeo/cssquery-jquery.html) 20:49:30 INFO - PROCESS | 30738 | RSS: Main: 236036096 20:49:30 INFO - PROCESS | 30738 | 20:52:32 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34369/tests/dromaeo/cssquery-mootools.html) 20:52:32 INFO - PROCESS | 30738 | RSS: Main: 239759360 20:52:32 INFO - PROCESS | 30738 | 20:55:34 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34369/tests/dromaeo/cssquery-prototype.html) 20:55:35 INFO - PROCESS | 30738 | RSS: Main: 227733504 20:55:35 INFO - PROCESS | 30738 | 20:58:38 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34369/tests/dromaeo/cssquery-yui.html) 20:58:38 INFO - PROCESS | 30738 | RSS: Main: 221515776 20:58:38 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-yui.html (next: http://localhost:34369/tests/dromaeo/cssquery-dojo.html) 21:01:41 INFO - PROCESS | 30738 | RSS: Main: 272662528 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | __start_tp_report 21:01:41 INFO - PROCESS | 30738 | _x_x_mozilla_page_load 21:01:41 INFO - PROCESS | 30738 | _x_x_mozilla_page_load_details 21:01:41 INFO - PROCESS | 30738 | |i|pagename|runs| 21:01:41 INFO - PROCESS | 30738 | |0;dojo.html;3147.543606177104;3160.4469217886867;3168.207948012997;3200.343929494451;3222.806631602104;5285.286486324345;5327.2808170897015;5442.61901666883;5524.530414914732;5552.333719953611;5347.1177255752755;5383.596230282725;5413.891722165564;5476.014317422862;5526.806561770339;4863.927041094377;4864;5020.7489625518765;5051.823186188484;5073.619478539106;4993.375828021497;5024.949750502503;5032.748362581856;5050.949490505103;5055.292259083732;4762.452317983424;4912.7297998610065;4917.311576379292;4976;4976.900461990776;4959.330490383824;4973.204287314013;4978.850634480971;4986.4514903360605;5019;4772.904541909143;4918.188498897677;4944.777485013147;4953.405591329064;4981.252812078181;5266.34170728659;5338.119210330291;5359.598030147755;5362.65142765719;5363.034653762321;5775.537956963432;5817.854553636151;5821.592488525805;5831.825045248649;5852.941470585282;5816.214811000503;5820.621659592113;5825.475707186373;5853;5880.8235752927485;5544.805931792408;5555.583331250132;5559;5559.027170245191;5561.277033985596;5715.714214289269;5970.432808883149;5973.402659733992;6032.095185722177;6032.426919442646;5852.034414321674;5859.472647461749;5869.383714709979;5869.765209391577;5878.088896221007;5891.499222566044;5892.29292484896;5904.763809447574;5912.940870591325;5948.940510594925;5622.606417550732;5790.855228619318;5849.941500585025;5857.384974577693;5894.32215295238;5870.5010074144175;5879.823605291848;5885.087811389156;5889.94110058894;5890.381509941394;4319.308910574293;4455.287154055336;4459.487158976694;4464.352668862996;4508.256137737302;3905.160390515996;3920.764754114762;3944.8224829882724;3944.881653550398;3980.422838688432;5507.531859791962;5511;5530.972345138249;5532.225488431623;5533.972330138324;5685.943140568541;5803.970980145073;5841.970790146107;5917.911231331534;5922.822315330547;5473.8357849264585;5491.121420572689;5502.862428439241;5505.862353441196;5540.63985840919;5033.3205017322925;5045.066662667345;5046.62150338726;5048.646594738407;5093.439721630618;5829.271341082364;6035.788747393908;6067.514598832083;6075.635461872302;6102.481289090389;5914.792982245601;5953.345132035559;5966.224390829165;5966.254218222723;5970.58205925581;6119.082137679384;6128.111423843428;6141.048137538689;6145.877082458236;6146.200993870768;5649.237352957298;5684.175794509691;5703.08750599902;5721;5750.511206547323;5856.385079566584;5857.326407463196;5858.238429004202;5858.970705146447;5867.794627188198;5600.579956503197;5682.090865461506;5687.857803554944;5691.288588926384;5697.287839020122;5691.3170419549915;5709.172170035405;5759.280089988752;5767.480926716616;5769.480746732815;5605.5795815313195;5635.492805647347;5636.379998200113;5644.379118297066;5661.745221464962;5591.9720401397735;5725.141228815711;5808.186853840381;5816.1857339973285;5879.676617786063;5506.752196151263;5570.721463926869;5613.494785469327;5659.292588426447;5749 21:01:41 INFO - PROCESS | 30738 | |1;ext.html;590.6898878089003;623.5821999260495;631.1605564599083;637.5760119520517;650.3821369698782;42653;44189.116217675706;44221.77889110554;44298.77850610746;47940.52059479404;45429.7728511357;46132.30801537979;46192.76903615486;46237;46263;8996.640134394616;9204.769880752969;9229;9231.984481707006;9232.446053236794;8912.955435222815;8980;9007.459552426842;9012.639494420215;9013.684521041765;9041.683541076063;9067.727968160965;9079.727608171765;9082.545872706338;9086;8997.415168014091;9015.819683606356;9032.45805251687;9034.503102329369;9038.909610903906;8966.148215919477;9098.63605455781;9100.317476189246;9101.408408453495;9107.36248462608;42926.1414771706;43367.783161084306;43379.34930976038;43394.34908476375;43417.56582434198;3534.9116272093147;3886.4753258310334;4076.5311989121333;4183.45615070042;4357.9128417431475;32935;33199.502007469666;33302.6669733302;33517.83241083803;34990.300193996234;4280.721753086071;4306.138772245564;4323.675724320657;4326.242907491176;4330.588594083557;360796;361255;361452.1927390373;362194;362425;52075;57356.71321643365;59157.40842591605;59906;60203.09695354573;63719;63874.361256386845;64051.679741600994;64072;64132.35867641357;17390.3043878246;17638.118094095244;17652.470425887244;17653.205605747517;17681.646367072844;12378.071644626689;13310.66723331905;13453.394597243148;13488.730225395437;13513.256770877499;17658.91170544139;17659.554262694026;17704.645907082046;17705.557361066076;17722.91138544299;6160.784372546939;6203.348648391944;6209.472194863397;6261.217347831521;6459.967700161469;1005.5776573839005;1019.0471908765328;1028.9073983341534;1043.8903915088958;1087.1465899269035;32520.512192317135;32930.835345823114;33330.16674583106;33405.16487087842;33876.1530961723;1130.5195292000867;1203.6990752311922;1219.2745316536646;1240.0389697984135;1277.8211050452944;17325.7401138983;17427.825721742873;17549.245075492603;17566.260977044218;17786.822131778776;502396;506344.0241981866;506795;509805;520267;58246.41753582495;58709.41290587039;58881.41118588759;58889;58920.41079589235;1261.7539579781856;1309.7118633900718;1338.9129706569042;1380.9642767924056;1395.5464474045975;30456.543151853184;34903.65096349004;34964;34971.825140874134;35022.29955400827;44451;44808;44815.32777008413;44936.77531612321;45111.54888451073;399727;400900;403038;403300;404072;33861.66138338684;36807.63192368042;40978.59021409748;41525.792371037955;41714;48587.46361497791;49030.26454603255;49277.50722492729;49670;49813;38339.2332153361;41481;41737.37393939154;42310.096045677405;42590.14819703527;40998.1800363997;41077.1784564313;41545.584544154175;41730.37404438875;41893.58106418897;40772.59227407688;41387;41898;42006.57993420149;42262.57737422586;34923.30153396969;36718.8164059178;37835.62164378431;39895.40156897591;40204;29153.125406237847;29263.56104658389;29266.70733292725;29511.852440737657;29580.55629165521 21:01:41 INFO - PROCESS | 30738 | |2;jquery.html;392.5662143331618;398.44417038231666;400.2255635345605;404.2440636010659;410.8110269276133;13128.82048770381;18570.257189712396;20085.29701460451;20099.296524621623;20984.265550705728;19016.809831901675;19103.713444298348;19681.114349854255;19877.40367788965;19923.40229793105;5720.599558030929;5813.912791308134;5853.180554722342;5865.384134665863;5905.438983296602;5801.883962320751;5816.418358164171;5842.766289348442;5859.501942334907;5861.472467477926;4117.897052573695;6029.487493563052;6304.054391841215;6309.968450157743;6408.038794180864;6114.388561143895;6343.365663433666;6378.744850205986;6417.582857114273;6445.1943507061615;5546.91679624806;5552.7223638817895;5558.999380111578;5563.082091454905;5569.916451253234;22431;22775.08899644012;23203.187888423825;23394.7660523396;23432.06271749128;2463.5935070713313;2512.610545365453;2588.585826267788;2907.389448215877;3115.8286294253808;14353.282335883165;14642.41430342785;14733.778993315109;14901.403943842233;15129.243537823066;1886.4057821786093;1944.3292064237814;2036.1448191759496;2092.1422216891;2114.756802967663;51608;71492.6425367875;77051.61474192649;79900.60049699772;82985.17014829894;9987.750306242257;10176.236782241214;10292.845607315747;10429.843552346721;10552.050315471644;13639.727205455836;13695.178289302674;13713.862861371259;13733.244671542961;13755.587332380044;8290.29532489733;8465.449745766506;8495.66017359311;8582.527960962083;8610.569471526398;8466;8472.322214222848;8505.574721264036;8505.829883402297;8633.69782057625;6359.777407790705;6442.516811239176;6543.869122617616;6571.868562628816;6602.801915942433;1789.498940296719;1826.2056005637326;1826.415547024966;1837.4120281510056;1840.245499345262;1025.6767377311728;1028.280203857303;1097.9011888929874;1104.447776111944;1125.6172901213627;19539.804601953798;20088.69866951997;20166.19335226604;20369.898150509154;20389.89805050965;1022.1107636356269;1049.8530205771046;1054.926155169146;1070.5236169904317;1103.61925135828;10041;11564.653060408202;11688.824667629993;11755.294682319089;11791.469383877746;447693;453586;467116.59506443795;473957;475622;58252.4174758247;82137;85503.57248213718;85509.57245213859;85566.57216713877;1053.752368193474;1083.7019819549687;1089.760252744395;1090.6019302954523;1116.9497372618252;18033;18278.908605456887;18395.81604183941;18455.354062607745;18749;38661.61338386693;40777.796111019255;40991.385129222486;41115.588844111175;41284.1743165141;52572.21141682801;53159.468405317;55891;64243.357566423736;64555.354446454934;8705.303575714055;8855.158759917798;8873.29013678917;9239.491827949527;9441.480718560546;8166.673333066611;11610.361430121424;12547.49810007626;12826.807597885852;13701.725965480435;12017.939910300393;12221.633350999484;12231.877681223074;12302.0773441994;12334.136610437183;11382.430878456209;11508.079353651521;11813.586524471602;12058.457369418573;12071.336076515876;11479.540818367172;11823.172377933462;12184.51261949512;12219.38903054826;12325.075619328407;8960.955195224244;8964.775880603038;9003.819923601623;9029.90970090317;9279.907200928174;8829.823403532022;11043.944780276048;11324.207305488537;11328.546858125583;11332.6033588824 21:01:41 INFO - PROCESS | 30738 | |3;mootools.html;1362.5503583817342;1522.6574020845312;1562.8124625044993;1706.5562953632052;1850.731643911632;8593.140685931403;8862.556872156398;8881.60032798524;9129;9138;8915.910840891589;9107.68123115691;9112.407693499934;9112.954435227815;9124.726258212248;2036.4094412620323;2301.42464383904;2348.0842471436067;2359.304005318427;2396.808255339569;2390.1156572068357;2393.56915755164;2395.4490467192554;2397.9040838366445;2399.400149962509;2314.8726820024976;2317.3048085574346;2334.731505876829;2348.037304705071;2348.0842471436154;1989.7114918336904;2233.6649502574583;2285.6571514272828;2290.679304897316;2298.138198175684;2299.057386471539;2306.2274138163566;2319.350581837088;2320.7447180810095;2326.7673232676766;8965.820683586357;9012.143846334588;9014;9023.187913087788;9027.187553120251;5230.189320655304;5350.839474815762;5362.624616276862;5366.6779993200535;5368.70472124033;3314.685104915029;3408.403529382348;3439.466882633196;3449.7412694047794;3463.8960831174854;1106.3251416635846;1115.553778488611;1154.7632735289246;1178.3401295274589;1182.657029461455;12436.81344779829;12537.74924501514;12543.184692994926;12543.43554540057;12570.497180112785;4481.417415735934;4502.077074199781;4603.861884143481;4616.169089563844;4618.1918164321105;10029.79940401188;10030.147437467751;10054;10058.54736536843;10058.949705251427;5270.604704647167;5347.759350829222;5349.491798279158;5355.732213389315;5355.785768569292;4396.362527433568;4909.729964851896;5009.974950125226;5037.974810125999;5043.344365232496;3752.099496120911;3809.6190380961684;3823.9292997960615;3832.4826148470156;3878.6509214170296;1142.828575713633;1148.5405837665;1154;1157.7568710570706;1164.6622479480855;940.7224868663624;1019.8470229465491;1020.83666613343;1024.6516184497157;1034.3070143004054;5985.730642121115;6178;6235.75056997715;6297.842553936097;6322.71547780351;427.6984725768326;440.43624161073876;444.1849206705731;444.34237328753625;449.6313023320911;4230.725002874803;4240.448741663564;4263.616274535307;4278.572142785696;4281.400603915455;11081.778364432666;11488.48301826403;11514.596989105508;11532.25040372373;11536.480858361227;11318.434078296052;11324.94337528307;11340.886591134147;11428.714282143013;11440.771184576428;7662.118856331482;7907.406944479187;7925.167857375008;8119.472234304633;8376.623051962677;5856.765729370777;5982.790602329072;6011.158437818622;6037.909431358621;6122.020476723703;10357.63748268807;10363.844542332023;10513.158947284352;10514.842277365693;10554.10290125348;9855.507224638883;10308.12380947628;10371.118454931415;10381.584736610452;10635.787284254116;7174.1032370953635;7635.847283054419;7695.846083078419;7847.725329613436;7851.332636725942;8773.298136148966;8851.64593416282;8884.37809353339;8921;8944.105589441004;7888;8187.26314631686;8197.344212463107;8265.793355166168;8273.710420135507;7703.075630924101;7763.844723105619;7856.37149028065;7888.7633370998965;8111.107778144517;7184.928150718426;7271.563706177646;7449.994250776076;7526.962365188139;7529.849403012018;5432.320959880015;5439.129739241703;5449.754761035842;5505.559555235492;5509.3664228614225;5438.700871452108;5458.426865179258;5515.145152501369;5546.972265138648;5633.492985631313 21:01:41 INFO - PROCESS | 30738 | |4;prototype.html;300.35873410269085;315.6874694052887;317.4048658764816;319.691497704715;320.781868329536;5082.720450375228;5280.759021629914;5350.73246337683;5382.273393091937;5419.891602167959;5418.4039755626845;5419.620626556142;5460.808871689492;5468.179773034047;5483.341998960131;4222.8522001730025;4224.429701990222;4225.387318838767;4249.213895429355;4256.723312984646;4068.9186216275803;4071.3282308419075;4191.916161676764;4240.491141063077;4265.189613973351;4138.834446622147;4158.563350848162;4161.708680392374;4166.854160104397;4176.436181115556;4078.3066878630557;4102.200070986159;4108.732932359387;4128.318827393477;4134.524529679095;3550.3254381667402;3637.8181090945614;3646.2889736501393;3662.377395842713;3670.4861319415304;5131.794728210867;5137.588992880561;5144.871378215537;5145;5169.405518365398;4854.49027852074;4900.166971614834;4902.28916807061;4904.969956309179;4914.557689807899;5434.864128396782;5649.4633009864;5666.914996275059;5670.68811215383;5677.347105082886;4088.325426304656;4090.5091389033505;4100.753954762694;4112.712110152291;4120.649744771698;5632.620008098002;5755.280589926301;5862.706864656793;5870.589058765888;5891.231121372991;4133.937990930139;4143.627073563393;4162.854300099542;4170.124273902454;4178.979105104516;4175.603317684815;4198.769067701306;4224.302990006676;4238.131183107455;4252.574742525784;4669.066186762661;4818.02460990999;4819.373481447459;4842.95157048425;4853.466118726938;5652.519535839418;5711.514521265656;5730;5743.253377060955;5744.454276843693;1465.9853401465848;1478.8077549918657;1485.6434455730546;1487.4793822162158;1498.3182651893362;934.56075644447;954.7062633913027;984.5126662302063;984.7444508252036;991.504247876062;4856.660033797601;4941.5669455858115;4955.331030310862;4972.825951091694;4986;5166.741662916839;5229.294045303911;5314.7608357624;5318.377894742141;5322.547583455373;4998.175665881927;5011.3986321640905;5018.673786203885;5140.306058682105;5617.21359009739;3102.255458689898;3115.7818952673547;3125.1718294651937;3142.9371412571622;3153.7003984621424;6011.849703757441;6037.788677396358;6112.358202388774;6136.23297087864;6141.508679305645;5647.830565082972;5973.193618861398;5989.880202396015;5995.770866972261;5996.610220335664;6028.216331876828;6045.365236650088;6072.271327440735;6125.387461253839;6129.724162412702;5557.583181261502;5895.351511333835;5903.734331955158;5912.763489460545;5965.508622844289;5761.337446193741;5795.913061304168;5804.419558044331;5831.542114471382;5842.620229685057;5720.485156335783;5893.823185304448;6076.321232650923;6076.848078798065;6124.846878828065;4171.0823618803815;4171.916561668811;4191.721524934802;4201.474815648044;4212.178625168062;5649.435056494318;5863.442972917566;5875.14810352488;5988.431099045583;6012.248468941382;5709.5734312917675;5717.198572699431;5719.370869204467;5719.685417301922;5731.426857314235;5703.144528320785;5715.971420143039;5730.455606717355;5731;5744.684042377709;5369;5635.690037048002;5649.774009039593;5660.773569057192;5669.773209071756;5784.537237021113;5791.247137872049;5803.274590676166;5810.215620891295;5814.447627475383;5364.892702146013;5654.575906807088;5671.617920473329;5685.687287199244;5690.231818704422 21:01:41 INFO - PROCESS | 30738 | |5;yui.html;777.7511196417145;789.0353020977767;801.8075661841158;811.2860682599312;828.2049232736573;14988.550343489685;15754.133522656279;15775.921120394396;15942.760858587131;15994.960327578714;14667;14983.77524337133;15003.099814011168;15005;15007.92496037521;693.6289085339345;823.2672921100195;828.3000864269683;832.6128350317086;835.0230230630146;831.9084900660922;833.6332013913858;836.4145098431092;838.4508147163588;839.75227307944;876.3909083187187;877.3463769491738;877.9946960729992;878.0341624213346;878.2885862451435;715.3490323805338;855.5123579559591;856.1395797223781;861.2980420956932;873.6985739919718;636.2778246689994;636.6530241018656;636.6593872278308;636.723025483916;637.1812221295659;14619;14673.559793206221;14676.853231467656;14680.26598670073;14733.484328048575;14023.85976140246;14111.647208819759;14116;14334.498292559814;14531.927340363336;11611.129165312552;12266.141370104096;12506.74986500274;12537.937310313482;12875.098743087987;4188.476440444944;4213.97893010533;4215.283401821667;4215.852445164404;4223.957760422387;58448;60248.698756506376;60252.99999999956;60496.39503604996;60647.39352606462;10497.790044199073;10574.15406767472;10645.84031239532;10817;10853.620123295646;19271.22915083409;19387.61224775525;19466;19476;19566.804331956784;8006.319462845607;8185.181481851767;8282.8343433131;8356.122607126286;8548.230659240699;4465.821367145343;4606.539346065367;4615.26155815068;4684.461286952044;4718.952810471851;3473.374792537317;3596.2987217492337;3604.044928094057;3646.361886669822;3647.744657873923;562.7439515020656;624.3974564545235;633.9651319177398;636.8726254749068;642.5341627320156;658.2627457247818;728.8141523911369;750.9098908131059;752.3003606645763;752.9811754706067;9501.524923753785;9684.273679474067;9893.60425582983;9988.30081894275;10201.13290370312;751.8609057324412;755.7808235611722;767.3170877918657;781.6912319633713;790.2650535002388;4831.396075490564;4834.734089625104;4852;4861.9027619447415;4887.535684110004;76354.23645763472;76529;77300;78437;78561.60719196367;44704;55780.16329755057;68249.3175068243;68892.655536723;70741.64629176821;57729;57838.7108064457;60250.39749602448;60329.39670603326;60774.39225607776;9171.954140229524;9295;9297.953510232406;9430.95284523573;9577.185939194967;39019.609803902735;39358.803205983786;39453.802730986165;39574.2085158301;40976.590234097275;51021.48978510167;54815.72592137014;54928;55635.44364556303;55773.163402549806;11591.826122608;11706.70733231676;11834.171607987702;12064.457099430721;12181.147319687538;12823.679408014874;12967.092303539039;13052.15161014531;13387.263700496565;14069.859301406856;12017.519299227934;12458.626241212778;12944.676383090498;13090.869091308965;13109.737805244033;12078;13116.475340986253;13253.86746132565;13409.195448273134;13710.862891371358;12432.564860229848;13165.210087394787;13418.597442076752;13482.19106853592;13501.797473037715;10053.748656283651;10326.380417174994;10549.314294570828;10802.89197108019;10904.672859814218;9760.316777825485;10349.9482502587;10567.682969510926;10573.4713264338;10680.786384272116 21:01:41 INFO - PROCESS | 30738 | __end_tp_report 21:01:41 INFO - PROCESS | 30738 | __start_cc_report 21:01:41 INFO - PROCESS | 30738 | _x_x_mozilla_cycle_collect,1031 21:01:41 INFO - PROCESS | 30738 | __end_cc_report 21:01:41 INFO - PROCESS | 30738 | __startTimestamp1463630501781__endTimestamp 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | ------- Summary: start ------- 21:01:41 INFO - PROCESS | 30738 | Number of tests: 6 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#0] dojo.html Cycles:165 Average:5430.57 Median:5635.49 stddev:626.97 (11.1%) stddev-sans-first:602.77 21:01:41 INFO - PROCESS | 30738 | Values: 3147.5 3160.4 3168.2 3200.3 3222.8 5285.3 5327.3 5442.6 5524.5 5552.3 5347.1 5383.6 5413.9 5476.0 5526.8 4863.9 4864.0 5020.7 5051.8 5073.6 4993.4 5024.9 5032.7 5050.9 5055.3 4762.5 4912.7 4917.3 4976.0 4976.9 4959.3 4973.2 4978.9 4986.5 5019.0 4772.9 4918.2 4944.8 4953.4 4981.3 5266.3 5338.1 5359.6 5362.7 5363.0 5775.5 5817.9 5821.6 5831.8 5852.9 5816.2 5820.6 5825.5 5853.0 5880.8 5544.8 5555.6 5559.0 5559.0 5561.3 5715.7 5970.4 5973.4 6032.1 6032.4 5852.0 5859.5 5869.4 5869.8 5878.1 5891.5 5892.3 5904.8 5912.9 5948.9 5622.6 5790.9 5849.9 5857.4 5894.3 5870.5 5879.8 5885.1 5889.9 5890.4 4319.3 4455.3 4459.5 4464.4 4508.3 3905.2 3920.8 3944.8 3944.9 3980.4 5507.5 5511.0 5531.0 5532.2 5534.0 5685.9 5804.0 5842.0 5917.9 5922.8 5473.8 5491.1 5502.9 5505.9 5540.6 5033.3 5045.1 5046.6 5048.6 5093.4 5829.3 6035.8 6067.5 6075.6 6102.5 5914.8 5953.3 5966.2 5966.3 5970.6 6119.1 6128.1 6141.0 6145.9 6146.2 5649.2 5684.2 5703.1 5721.0 5750.5 5856.4 5857.3 5858.2 5859.0 5867.8 5600.6 5682.1 5687.9 5691.3 5697.3 5691.3 5709.2 5759.3 5767.5 5769.5 5605.6 5635.5 5636.4 5644.4 5661.7 5592.0 5725.1 5808.2 5816.2 5879.7 5506.8 5570.7 5613.5 5659.3 5749.0 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#1] ext.html Cycles:180 Average:59533.44 Median:42134.58 stddev:113291.86 (268.9%) stddev-sans-first:113523.24 21:01:41 INFO - PROCESS | 30738 | Values: 590.7 623.6 631.2 637.6 650.4 42653.0 44189.1 44221.8 44298.8 47940.5 45429.8 46132.3 46192.8 46237.0 46263.0 8996.6 9204.8 9229.0 9232.0 9232.4 8913.0 8980.0 9007.5 9012.6 9013.7 9041.7 9067.7 9079.7 9082.5 9086.0 8997.4 9015.8 9032.5 9034.5 9038.9 8966.1 9098.6 9100.3 9101.4 9107.4 42926.1 43367.8 43379.3 43394.3 43417.6 3534.9 3886.5 4076.5 4183.5 4357.9 32935.0 33199.5 33302.7 33517.8 34990.3 4280.7 4306.1 4323.7 4326.2 4330.6 360796.0 361255.0 361452.2 362194.0 362425.0 52075.0 57356.7 59157.4 59906.0 60203.1 63719.0 63874.4 64051.7 64072.0 64132.4 17390.3 17638.1 17652.5 17653.2 17681.6 12378.1 13310.7 13453.4 13488.7 13513.3 17658.9 17659.6 17704.6 17705.6 17722.9 6160.8 6203.3 6209.5 6261.2 6460.0 1005.6 1019.0 1028.9 1043.9 1087.1 32520.5 32930.8 33330.2 33405.2 33876.2 1130.5 1203.7 1219.3 1240.0 1277.8 17325.7 17427.8 17549.2 17566.3 17786.8 502396.0 506344.0 506795.0 509805.0 520267.0 58246.4 58709.4 58881.4 58889.0 58920.4 1261.8 1309.7 1338.9 1381.0 1395.5 30456.5 34903.7 34964.0 34971.8 35022.3 44451.0 44808.0 44815.3 44936.8 45111.5 399727.0 400900.0 403038.0 403300.0 404072.0 33861.7 36807.6 40978.6 41525.8 41714.0 48587.5 49030.3 49277.5 49670.0 49813.0 38339.2 41481.0 41737.4 42310.1 42590.1 40998.2 41077.2 41545.6 41730.4 41893.6 40772.6 41387.0 41898.0 42006.6 42262.6 34923.3 36718.8 37835.6 39895.4 40204.0 29153.1 29263.6 29266.7 29511.9 29580.6 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#2] jquery.html Cycles:180 Average:27880.44 Median:23413.41 stddev:76187.99 (325.4%) stddev-sans-first:76373.76 21:01:41 INFO - PROCESS | 30738 | Values: 392.6 398.4 400.2 404.2 410.8 13128.8 18570.3 20085.3 20099.3 20984.3 19016.8 19103.7 19681.1 19877.4 19923.4 5720.6 5813.9 5853.2 5865.4 5905.4 5801.9 5816.4 5842.8 5859.5 5861.5 4117.9 6029.5 6304.1 6310.0 6408.0 6114.4 6343.4 6378.7 6417.6 6445.2 5546.9 5552.7 5559.0 5563.1 5569.9 22431.0 22775.1 23203.2 23394.8 23432.1 2463.6 2512.6 2588.6 2907.4 3115.8 14353.3 14642.4 14733.8 14901.4 15129.2 1886.4 1944.3 2036.1 2092.1 2114.8 51608.0 71492.6 77051.6 79900.6 82985.2 9987.8 10176.2 10292.8 10429.8 10552.1 13639.7 13695.2 13713.9 13733.2 13755.6 8290.3 8465.4 8495.7 8582.5 8610.6 8466.0 8472.3 8505.6 8505.8 8633.7 6359.8 6442.5 6543.9 6571.9 6602.8 1789.5 1826.2 1826.4 1837.4 1840.2 1025.7 1028.3 1097.9 1104.4 1125.6 19539.8 20088.7 20166.2 20369.9 20389.9 1022.1 1049.9 1054.9 1070.5 1103.6 10041.0 11564.7 11688.8 11755.3 11791.5 447693.0 453586.0 467116.6 473957.0 475622.0 58252.4 82137.0 85503.6 85509.6 85566.6 1053.8 1083.7 1089.8 1090.6 1116.9 18033.0 18278.9 18395.8 18455.4 18749.0 38661.6 40777.8 40991.4 41115.6 41284.2 52572.2 53159.5 55891.0 64243.4 64555.4 8705.3 8855.2 8873.3 9239.5 9441.5 8166.7 11610.4 12547.5 12826.8 13701.7 12017.9 12221.6 12231.9 12302.1 12334.1 11382.4 11508.1 11813.6 12058.5 12071.3 11479.5 11823.2 12184.5 12219.4 12325.1 8961.0 8964.8 9003.8 9029.9 9279.9 8829.8 11043.9 11324.2 11328.5 11332.6 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#3] mootools.html Cycles:180 Average:5910.72 Median:442.31 stddev:3415.35 (772.2%) stddev-sans-first:3407.83 21:01:41 INFO - PROCESS | 30738 | Values: 1362.6 1522.7 1562.8 1706.6 1850.7 8593.1 8862.6 8881.6 9129.0 9138.0 8915.9 9107.7 9112.4 9113.0 9124.7 2036.4 2301.4 2348.1 2359.3 2396.8 2390.1 2393.6 2395.4 2397.9 2399.4 2314.9 2317.3 2334.7 2348.0 2348.1 1989.7 2233.7 2285.7 2290.7 2298.1 2299.1 2306.2 2319.4 2320.7 2326.8 8965.8 9012.1 9014.0 9023.2 9027.2 5230.2 5350.8 5362.6 5366.7 5368.7 3314.7 3408.4 3439.5 3449.7 3463.9 1106.3 1115.6 1154.8 1178.3 1182.7 12436.8 12537.7 12543.2 12543.4 12570.5 4481.4 4502.1 4603.9 4616.2 4618.2 10029.8 10030.1 10054.0 10058.5 10058.9 5270.6 5347.8 5349.5 5355.7 5355.8 4396.4 4909.7 5010.0 5038.0 5043.3 3752.1 3809.6 3823.9 3832.5 3878.7 1142.8 1148.5 1154.0 1157.8 1164.7 940.7 1019.8 1020.8 1024.7 1034.3 5985.7 6178.0 6235.8 6297.8 6322.7 427.7 440.4 444.2 444.3 449.6 4230.7 4240.4 4263.6 4278.6 4281.4 11081.8 11488.5 11514.6 11532.3 11536.5 11318.4 11324.9 11340.9 11428.7 11440.8 7662.1 7907.4 7925.2 8119.5 8376.6 5856.8 5982.8 6011.2 6037.9 6122.0 10357.6 10363.8 10513.2 10514.8 10554.1 9855.5 10308.1 10371.1 10381.6 10635.8 7174.1 7635.8 7695.8 7847.7 7851.3 8773.3 8851.6 8884.4 8921.0 8944.1 7888.0 8187.3 8197.3 8265.8 8273.7 7703.1 7763.8 7856.4 7888.8 8111.1 7184.9 7271.6 7450.0 7527.0 7529.8 5432.3 5439.1 5449.8 5505.6 5509.4 5438.7 5458.4 5515.1 5547.0 5633.5 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#4] prototype.html Cycles:180 Average:4750.84 Median:5336.64 stddev:1400.32 (26.2%) stddev-sans-first:1363.83 21:01:41 INFO - PROCESS | 30738 | Values: 300.4 315.7 317.4 319.7 320.8 5082.7 5280.8 5350.7 5382.3 5419.9 5418.4 5419.6 5460.8 5468.2 5483.3 4222.9 4224.4 4225.4 4249.2 4256.7 4068.9 4071.3 4191.9 4240.5 4265.2 4138.8 4158.6 4161.7 4166.9 4176.4 4078.3 4102.2 4108.7 4128.3 4134.5 3550.3 3637.8 3646.3 3662.4 3670.5 5131.8 5137.6 5144.9 5145.0 5169.4 4854.5 4900.2 4902.3 4905.0 4914.6 5434.9 5649.5 5666.9 5670.7 5677.3 4088.3 4090.5 4100.8 4112.7 4120.6 5632.6 5755.3 5862.7 5870.6 5891.2 4133.9 4143.6 4162.9 4170.1 4179.0 4175.6 4198.8 4224.3 4238.1 4252.6 4669.1 4818.0 4819.4 4843.0 4853.5 5652.5 5711.5 5730.0 5743.3 5744.5 1466.0 1478.8 1485.6 1487.5 1498.3 934.6 954.7 984.5 984.7 991.5 4856.7 4941.6 4955.3 4972.8 4986.0 5166.7 5229.3 5314.8 5318.4 5322.5 4998.2 5011.4 5018.7 5140.3 5617.2 3102.3 3115.8 3125.2 3142.9 3153.7 6011.8 6037.8 6112.4 6136.2 6141.5 5647.8 5973.2 5989.9 5995.8 5996.6 6028.2 6045.4 6072.3 6125.4 6129.7 5557.6 5895.4 5903.7 5912.8 5965.5 5761.3 5795.9 5804.4 5831.5 5842.6 5720.5 5893.8 6076.3 6076.8 6124.8 4171.1 4171.9 4191.7 4201.5 4212.2 5649.4 5863.4 5875.1 5988.4 6012.2 5709.6 5717.2 5719.4 5719.7 5731.4 5703.1 5716.0 5730.5 5731.0 5744.7 5369.0 5635.7 5649.8 5660.8 5669.8 5784.5 5791.2 5803.3 5810.2 5814.4 5364.9 5654.6 5671.6 5685.7 5690.2 21:01:41 INFO - PROCESS | 30738 | 21:01:41 INFO - PROCESS | 30738 | [#5] yui.html Cycles:180 Average:16427.04 Median:4775.17 stddev:20311.19 (425.3%) stddev-sans-first:20334.18 21:01:41 INFO - PROCESS | 30738 | Values: 777.8 789.0 801.8 811.3 828.2 14988.6 15754.1 15775.9 15942.8 15995.0 14667.0 14983.8 15003.1 15005.0 15007.9 693.6 823.3 828.3 832.6 835.0 831.9 833.6 836.4 838.5 839.8 876.4 877.3 878.0 878.0 878.3 715.3 855.5 856.1 861.3 873.7 636.3 636.7 636.7 636.7 637.2 14619.0 14673.6 14676.9 14680.3 14733.5 14023.9 14111.6 14116.0 14334.5 14531.9 11611.1 12266.1 12506.7 12537.9 12875.1 4188.5 4214.0 4215.3 4215.9 4224.0 58448.0 60248.7 60253.0 60496.4 60647.4 10497.8 10574.2 10645.8 10817.0 10853.6 19271.2 19387.6 19466.0 19476.0 19566.8 8006.3 8185.2 8282.8 8356.1 8548.2 4465.8 4606.5 4615.3 4684.5 4719.0 3473.4 3596.3 3604.0 3646.4 3647.7 562.7 624.4 634.0 636.9 642.5 658.3 728.8 750.9 752.3 753.0 9501.5 9684.3 9893.6 9988.3 10201.1 751.9 755.8 767.3 781.7 790.3 4831.4 4834.7 4852.0 4861.9 4887.5 76354.2 76529.0 77300.0 78437.0 78561.6 44704.0 55780.2 68249.3 68892.7 70741.6 57729.0 57838.7 60250.4 60329.4 60774.4 9172.0 9295.0 9298.0 9431.0 9577.2 39019.6 39358.8 39453.8 39574.2 40976.6 51021.5 54815.7 54928.0 55635.4 55773.2 11591.8 11706.7 11834.2 12064.5 12181.1 12823.7 12967.1 13052.2 13387.3 14069.9 12017.5 12458.6 12944.7 13090.9 13109.7 12078.0 13116.5 13253.9 13409.2 13710.9 12432.6 13165.2 13418.6 13482.2 13501.8 10053.7 10326.4 10549.3 10802.9 10904.7 9760.3 10349.9 10567.7 10573.5 10680.8 21:01:41 INFO - PROCESS | 30738 | -------- Summary: end -------- 21:01:41 INFO - PROCESS | 30738 | 21:01:42 INFO - TEST-INFO | 30738: exit 0 21:01:42 INFO - TEST-OK | dromaeo_css | took 1113257ms 21:01:42 INFO - TEST-START | kraken 21:01:42 INFO - operating with platform_type : linux_ 21:01:42 INFO - Initialising browser for kraken test... 21:01:42 INFO - TEST-INFO | started process 30934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCOyFUs/profile http://localhost:34369/getInfo.html) 21:01:46 INFO - PROCESS | 30934 | __metrics Screen width/height:1600/1200 21:01:46 INFO - PROCESS | 30934 | colorDepth:24 21:01:46 INFO - PROCESS | 30934 | Browser inner width/height: 1024/697 21:01:46 INFO - PROCESS | 30934 | __metrics 21:01:47 ERROR - PROCESS | 30934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:01:48 INFO - TEST-INFO | 30934: exit 0 21:01:48 INFO - Browser initialized. 21:01:48 INFO - Running cycle 1/1 for kraken test... 21:01:48 INFO - TEST-INFO | started process 31014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCOyFUs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:00 INFO - PROCESS | 31014 | RSS: Main: 152731648 21:02:00 INFO - PROCESS | 31014 | 21:02:02 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-beat-detection) 21:02:03 INFO - PROCESS | 31014 | RSS: Main: 208814080 21:02:03 INFO - PROCESS | 31014 | 21:02:06 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-dft) 21:02:06 INFO - PROCESS | 31014 | RSS: Main: 198205440 21:02:06 INFO - PROCESS | 31014 | 21:02:10 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-fft) 21:02:10 INFO - PROCESS | 31014 | RSS: Main: 265998336 21:02:10 INFO - PROCESS | 31014 | 21:02:12 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-oscillator) 21:02:13 INFO - PROCESS | 31014 | RSS: Main: 174792704 21:02:13 INFO - PROCESS | 31014 | 21:02:15 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:02:16 INFO - PROCESS | 31014 | RSS: Main: 179085312 21:02:16 INFO - PROCESS | 31014 | 21:02:19 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-darkroom) 21:02:20 INFO - PROCESS | 31014 | RSS: Main: 214765568 21:02:20 INFO - PROCESS | 31014 | 21:02:23 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-desaturate) 21:02:24 INFO - PROCESS | 31014 | RSS: Main: 212914176 21:02:24 INFO - PROCESS | 31014 | 21:02:27 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34369/tests/kraken/driver.html?testName=json-parse-financial) 21:02:27 INFO - PROCESS | 31014 | RSS: Main: 213696512 21:02:27 INFO - PROCESS | 31014 | 21:02:29 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:02:30 INFO - PROCESS | 31014 | RSS: Main: 204795904 21:02:30 INFO - PROCESS | 31014 | 21:02:31 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:02:32 INFO - PROCESS | 31014 | RSS: Main: 208138240 21:02:32 INFO - PROCESS | 31014 | 21:02:34 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:02:35 INFO - PROCESS | 31014 | RSS: Main: 217620480 21:02:35 INFO - PROCESS | 31014 | 21:02:37 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:02:38 INFO - PROCESS | 31014 | RSS: Main: 223571968 21:02:38 INFO - PROCESS | 31014 | 21:02:41 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:02:42 INFO - PROCESS | 31014 | RSS: Main: 219541504 21:02:42 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34369/tests/kraken/driver.html?testName=ai-astar) 21:02:43 INFO - PROCESS | 31014 | RSS: Main: 265940992 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | __start_tp_report 21:02:43 INFO - PROCESS | 31014 | _x_x_mozilla_page_load 21:02:43 INFO - PROCESS | 31014 | _x_x_mozilla_page_load_details 21:02:43 INFO - PROCESS | 31014 | |i|pagename|runs| 21:02:43 INFO - PROCESS | 31014 | |0;ai-astar;110;104;110;110;110;110;111;113;109;110 21:02:43 INFO - PROCESS | 31014 | |1;audio-beat-detection;155;124;151;212;124;162;151;125;194;127 21:02:43 INFO - PROCESS | 31014 | |2;audio-dft;160;161;161;160;160;161;162;161;163;162 21:02:43 INFO - PROCESS | 31014 | |3;audio-fft;74;73;75;150;76;73;76;75;129;74 21:02:43 INFO - PROCESS | 31014 | |4;audio-oscillator;92;93;152;93;92;92;127;92;93;127 21:02:43 INFO - PROCESS | 31014 | |5;imaging-gaussian-blur;116;117;117;118;116;117;117;117;116;117 21:02:43 INFO - PROCESS | 31014 | |6;imaging-darkroom;146;145;146;146;146;145;146;147;146;147 21:02:43 INFO - PROCESS | 31014 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 21:02:43 INFO - PROCESS | 31014 | |8;json-parse-financial;55;53;54;54;55;53;60;105;52;53 21:02:43 INFO - PROCESS | 31014 | |9;json-stringify-tinderbox;59;59;60;59;60;59;60;59;60;59 21:02:43 INFO - PROCESS | 31014 | |10;stanford-crypto-aes;78;78;79;77;78;85;79;78;79;85 21:02:43 INFO - PROCESS | 31014 | |11;stanford-crypto-ccm;118;121;119;118;123;127;130;124;190;122 21:02:43 INFO - PROCESS | 31014 | |12;stanford-crypto-pbkdf2;161;158;157;158;167;160;165;160;158;157 21:02:43 INFO - PROCESS | 31014 | |13;stanford-crypto-sha256-iterative;63;63;68;63;63;62;63;61;61;65 21:02:43 INFO - PROCESS | 31014 | __end_tp_report 21:02:43 INFO - PROCESS | 31014 | __start_cc_report 21:02:43 INFO - PROCESS | 31014 | _x_x_mozilla_cycle_collect,1868 21:02:43 INFO - PROCESS | 31014 | __end_cc_report 21:02:43 INFO - PROCESS | 31014 | __startTimestamp1463630563925__endTimestamp 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | ------- Summary: start ------- 21:02:43 INFO - PROCESS | 31014 | Number of tests: 14 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.26 (2.1%) stddev-sans-first:2.40 21:02:43 INFO - PROCESS | 31014 | Values: 110.0 104.0 110.0 110.0 110.0 110.0 111.0 113.0 109.0 110.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:153.00 stddev:30.54 (20.0%) stddev-sans-first:32.38 21:02:43 INFO - PROCESS | 31014 | Values: 155.0 124.0 151.0 212.0 124.0 162.0 151.0 125.0 194.0 127.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 21:02:43 INFO - PROCESS | 31014 | Values: 160.0 161.0 161.0 160.0 160.0 161.0 162.0 161.0 163.0 162.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#3] audio-fft Cycles:10 Average:87.50 Median:74.50 stddev:27.87 (37.4%) stddev-sans-first:29.13 21:02:43 INFO - PROCESS | 31014 | Values: 74.0 73.0 75.0 150.0 76.0 73.0 76.0 75.0 129.0 74.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:92.00 stddev:21.82 (23.7%) stddev-sans-first:22.60 21:02:43 INFO - PROCESS | 31014 | Values: 92.0 93.0 152.0 93.0 92.0 92.0 127.0 92.0 93.0 127.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 21:02:43 INFO - PROCESS | 31014 | Values: 116.0 117.0 117.0 118.0 116.0 117.0 117.0 117.0 116.0 117.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:02:43 INFO - PROCESS | 31014 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 147.0 146.0 147.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:02:43 INFO - PROCESS | 31014 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:54.00 stddev:16.17 (30.0%) stddev-sans-first:17.08 21:02:43 INFO - PROCESS | 31014 | Values: 55.0 53.0 54.0 54.0 55.0 53.0 60.0 105.0 52.0 53.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 21:02:43 INFO - PROCESS | 31014 | Values: 59.0 59.0 60.0 59.0 60.0 59.0 60.0 59.0 60.0 59.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.91 (3.7%) stddev-sans-first:3.03 21:02:43 INFO - PROCESS | 31014 | Values: 78.0 78.0 79.0 77.0 78.0 85.0 79.0 78.0 79.0 85.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:123.50 stddev:21.71 (17.6%) stddev-sans-first:22.64 21:02:43 INFO - PROCESS | 31014 | Values: 118.0 121.0 119.0 118.0 123.0 127.0 130.0 124.0 190.0 122.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:3.41 (2.1%) stddev-sans-first:3.61 21:02:43 INFO - PROCESS | 31014 | Values: 161.0 158.0 157.0 158.0 167.0 160.0 165.0 160.0 158.0 157.0 21:02:43 INFO - PROCESS | 31014 | 21:02:43 INFO - PROCESS | 31014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.04 (3.2%) stddev-sans-first:2.17 21:02:43 INFO - PROCESS | 31014 | Values: 63.0 63.0 68.0 63.0 63.0 62.0 63.0 61.0 61.0 65.0 21:02:43 INFO - PROCESS | 31014 | -------- Summary: end -------- 21:02:43 INFO - PROCESS | 31014 | 21:02:44 INFO - TEST-INFO | 31014: exit 0 21:02:44 INFO - TEST-OK | kraken | took 62466ms 21:02:44 INFO - SUITE-END | took 1175s 21:02:45 INFO - Completed test suite (00:19:35) 21:02:45 INFO - javascript benchmark 21:02:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.543606177104, 3160.4469217886867, 3168.207948012997, 3200.343929494451, 3222.806631602104, 5285.286486324345, 5327.2808170897015, 5442.61901666883, 5524.530414914732, 5552.333719953611, 5347.1177255752755, 5383.596230282725, 5413.891722165564, 5476.014317422862, 5526.806561770339, 4863.927041094377, 4864.0, 5020.7489625518765, 5051.823186188484, 5073.619478539106, 4993.375828021497, 5024.949750502503, 5032.748362581856, 5050.949490505103, 5055.292259083732, 4762.452317983424, 4912.7297998610065, 4917.311576379292, 4976.0, 4976.900461990776, 4959.330490383824, 4973.204287314013, 4978.850634480971, 4986.4514903360605, 5019.0, 4772.904541909143, 4918.188498897677, 4944.777485013147, 4953.405591329064, 4981.252812078181, 5266.34170728659, 5338.119210330291, 5359.598030147755, 5362.65142765719, 5363.034653762321, 5775.537956963432, 5817.854553636151, 5821.592488525805, 5831.825045248649, 5852.941470585282, 5816.214811000503, 5820.621659592113, 5825.475707186373, 5853.0, 5880.8235752927485, 5544.805931792408, 5555.583331250132, 5559.0, 5559.027170245191, 5561.277033985596, 5715.714214289269, 5970.432808883149, 5973.402659733992, 6032.095185722177, 6032.426919442646, 5852.034414321674, 5859.472647461749, 5869.383714709979, 5869.765209391577, 5878.088896221007, 5891.499222566044, 5892.29292484896, 5904.763809447574, 5912.940870591325, 5948.940510594925, 5622.606417550732, 5790.855228619318, 5849.941500585025, 5857.384974577693, 5894.32215295238, 5870.5010074144175, 5879.823605291848, 5885.087811389156, 5889.94110058894, 5890.381509941394, 4319.308910574293, 4455.287154055336, 4459.487158976694, 4464.352668862996, 4508.256137737302, 3905.160390515996, 3920.764754114762, 3944.8224829882724, 3944.881653550398, 3980.422838688432, 5507.531859791962, 5511.0, 5530.972345138249, 5532.225488431623, 5533.972330138324, 5685.943140568541, 5803.970980145073, 5841.970790146107, 5917.911231331534, 5922.822315330547, 5473.8357849264585, 5491.121420572689, 5502.862428439241, 5505.862353441196, 5540.63985840919, 5033.3205017322925, 5045.066662667345, 5046.62150338726, 5048.646594738407, 5093.439721630618, 5829.271341082364, 6035.788747393908, 6067.514598832083, 6075.635461872302, 6102.481289090389, 5914.792982245601, 5953.345132035559, 5966.224390829165, 5966.254218222723, 5970.58205925581, 6119.082137679384, 6128.111423843428, 6141.048137538689, 6145.877082458236, 6146.200993870768, 5649.237352957298, 5684.175794509691, 5703.08750599902, 5721.0, 5750.511206547323, 5856.385079566584, 5857.326407463196, 5858.238429004202, 5858.970705146447, 5867.794627188198, 5600.579956503197, 5682.090865461506, 5687.857803554944, 5691.288588926384, 5697.287839020122, 5691.3170419549915, 5709.172170035405, 5759.280089988752, 5767.480926716616, 5769.480746732815, 5605.5795815313195, 5635.492805647347, 5636.379998200113, 5644.379118297066, 5661.745221464962, 5591.9720401397735, 5725.141228815711, 5808.186853840381, 5816.1857339973285, 5879.676617786063, 5506.752196151263, 5570.721463926869, 5613.494785469327, 5659.292588426447, 5749.0], "value": 5387.800815538283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6898878089003, 623.5821999260495, 631.1605564599083, 637.5760119520517, 650.3821369698782, 42653.0, 44189.116217675706, 44221.77889110554, 44298.77850610746, 47940.52059479404, 45429.7728511357, 46132.30801537979, 46192.76903615486, 46237.0, 46263.0, 8996.640134394616, 9204.769880752969, 9229.0, 9231.984481707006, 9232.446053236794, 8912.955435222815, 8980.0, 9007.459552426842, 9012.639494420215, 9013.684521041765, 9041.683541076063, 9067.727968160965, 9079.727608171765, 9082.545872706338, 9086.0, 8997.415168014091, 9015.819683606356, 9032.45805251687, 9034.503102329369, 9038.909610903906, 8966.148215919477, 9098.63605455781, 9100.317476189246, 9101.408408453495, 9107.36248462608, 42926.1414771706, 43367.783161084306, 43379.34930976038, 43394.34908476375, 43417.56582434198, 3534.9116272093147, 3886.4753258310334, 4076.5311989121333, 4183.45615070042, 4357.9128417431475, 32935.0, 33199.502007469666, 33302.6669733302, 33517.83241083803, 34990.300193996234, 4280.721753086071, 4306.138772245564, 4323.675724320657, 4326.242907491176, 4330.588594083557, 360796.0, 361255.0, 361452.1927390373, 362194.0, 362425.0, 52075.0, 57356.71321643365, 59157.40842591605, 59906.0, 60203.09695354573, 63719.0, 63874.361256386845, 64051.679741600994, 64072.0, 64132.35867641357, 17390.3043878246, 17638.118094095244, 17652.470425887244, 17653.205605747517, 17681.646367072844, 12378.071644626689, 13310.66723331905, 13453.394597243148, 13488.730225395437, 13513.256770877499, 17658.91170544139, 17659.554262694026, 17704.645907082046, 17705.557361066076, 17722.91138544299, 6160.784372546939, 6203.348648391944, 6209.472194863397, 6261.217347831521, 6459.967700161469, 1005.5776573839005, 1019.0471908765328, 1028.9073983341534, 1043.8903915088958, 1087.1465899269035, 32520.512192317135, 32930.835345823114, 33330.16674583106, 33405.16487087842, 33876.1530961723, 1130.5195292000867, 1203.6990752311922, 1219.2745316536646, 1240.0389697984135, 1277.8211050452944, 17325.7401138983, 17427.825721742873, 17549.245075492603, 17566.260977044218, 17786.822131778776, 502396.0, 506344.0241981866, 506795.0, 509805.0, 520267.0, 58246.41753582495, 58709.41290587039, 58881.41118588759, 58889.0, 58920.41079589235, 1261.7539579781856, 1309.7118633900718, 1338.9129706569042, 1380.9642767924056, 1395.5464474045975, 30456.543151853184, 34903.65096349004, 34964.0, 34971.825140874134, 35022.29955400827, 44451.0, 44808.0, 44815.32777008413, 44936.77531612321, 45111.54888451073, 399727.0, 400900.0, 403038.0, 403300.0, 404072.0, 33861.66138338684, 36807.63192368042, 40978.59021409748, 41525.792371037955, 41714.0, 48587.46361497791, 49030.26454603255, 49277.50722492729, 49670.0, 49813.0, 38339.2332153361, 41481.0, 41737.37393939154, 42310.096045677405, 42590.14819703527, 40998.1800363997, 41077.1784564313, 41545.584544154175, 41730.37404438875, 41893.58106418897, 40772.59227407688, 41387.0, 41898.0, 42006.57993420149, 42262.57737422586, 34923.30153396969, 36718.8164059178, 37835.62164378431, 39895.40156897591, 40204.0, 29153.125406237847, 29263.56104658389, 29266.70733292725, 29511.852440737657, 29580.55629165521], "value": 20568.364117310553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5662143331618, 398.44417038231666, 400.2255635345605, 404.2440636010659, 410.8110269276133, 13128.82048770381, 18570.257189712396, 20085.29701460451, 20099.296524621623, 20984.265550705728, 19016.809831901675, 19103.713444298348, 19681.114349854255, 19877.40367788965, 19923.40229793105, 5720.599558030929, 5813.912791308134, 5853.180554722342, 5865.384134665863, 5905.438983296602, 5801.883962320751, 5816.418358164171, 5842.766289348442, 5859.501942334907, 5861.472467477926, 4117.897052573695, 6029.487493563052, 6304.054391841215, 6309.968450157743, 6408.038794180864, 6114.388561143895, 6343.365663433666, 6378.744850205986, 6417.582857114273, 6445.1943507061615, 5546.91679624806, 5552.7223638817895, 5558.999380111578, 5563.082091454905, 5569.916451253234, 22431.0, 22775.08899644012, 23203.187888423825, 23394.7660523396, 23432.06271749128, 2463.5935070713313, 2512.610545365453, 2588.585826267788, 2907.389448215877, 3115.8286294253808, 14353.282335883165, 14642.41430342785, 14733.778993315109, 14901.403943842233, 15129.243537823066, 1886.4057821786093, 1944.3292064237814, 2036.1448191759496, 2092.1422216891, 2114.756802967663, 51608.0, 71492.6425367875, 77051.61474192649, 79900.60049699772, 82985.17014829894, 9987.750306242257, 10176.236782241214, 10292.845607315747, 10429.843552346721, 10552.050315471644, 13639.727205455836, 13695.178289302674, 13713.862861371259, 13733.244671542961, 13755.587332380044, 8290.29532489733, 8465.449745766506, 8495.66017359311, 8582.527960962083, 8610.569471526398, 8466.0, 8472.322214222848, 8505.574721264036, 8505.829883402297, 8633.69782057625, 6359.777407790705, 6442.516811239176, 6543.869122617616, 6571.868562628816, 6602.801915942433, 1789.498940296719, 1826.2056005637326, 1826.415547024966, 1837.4120281510056, 1840.245499345262, 1025.6767377311728, 1028.280203857303, 1097.9011888929874, 1104.447776111944, 1125.6172901213627, 19539.804601953798, 20088.69866951997, 20166.19335226604, 20369.898150509154, 20389.89805050965, 1022.1107636356269, 1049.8530205771046, 1054.926155169146, 1070.5236169904317, 1103.61925135828, 10041.0, 11564.653060408202, 11688.824667629993, 11755.294682319089, 11791.469383877746, 447693.0, 453586.0, 467116.59506443795, 473957.0, 475622.0, 58252.4174758247, 82137.0, 85503.57248213718, 85509.57245213859, 85566.57216713877, 1053.752368193474, 1083.7019819549687, 1089.760252744395, 1090.6019302954523, 1116.9497372618252, 18033.0, 18278.908605456887, 18395.81604183941, 18455.354062607745, 18749.0, 38661.61338386693, 40777.796111019255, 40991.385129222486, 41115.588844111175, 41284.1743165141, 52572.21141682801, 53159.468405317, 55891.0, 64243.357566423736, 64555.354446454934, 8705.303575714055, 8855.158759917798, 8873.29013678917, 9239.491827949527, 9441.480718560546, 8166.673333066611, 11610.361430121424, 12547.49810007626, 12826.807597885852, 13701.725965480435, 12017.939910300393, 12221.633350999484, 12231.877681223074, 12302.0773441994, 12334.136610437183, 11382.430878456209, 11508.079353651521, 11813.586524471602, 12058.457369418573, 12071.336076515876, 11479.540818367172, 11823.172377933462, 12184.51261949512, 12219.38903054826, 12325.075619328407, 8960.955195224244, 8964.775880603038, 9003.819923601623, 9029.90970090317, 9279.907200928174, 8829.823403532022, 11043.944780276048, 11324.207305488537, 11328.546858125583, 11332.6033588824], "value": 9459.332585680977, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.5503583817342, 1522.6574020845312, 1562.8124625044993, 1706.5562953632052, 1850.731643911632, 8593.140685931403, 8862.556872156398, 8881.60032798524, 9129.0, 9138.0, 8915.910840891589, 9107.68123115691, 9112.407693499934, 9112.954435227815, 9124.726258212248, 2036.4094412620323, 2301.42464383904, 2348.0842471436067, 2359.304005318427, 2396.808255339569, 2390.1156572068357, 2393.56915755164, 2395.4490467192554, 2397.9040838366445, 2399.400149962509, 2314.8726820024976, 2317.3048085574346, 2334.731505876829, 2348.037304705071, 2348.0842471436154, 1989.7114918336904, 2233.6649502574583, 2285.6571514272828, 2290.679304897316, 2298.138198175684, 2299.057386471539, 2306.2274138163566, 2319.350581837088, 2320.7447180810095, 2326.7673232676766, 8965.820683586357, 9012.143846334588, 9014.0, 9023.187913087788, 9027.187553120251, 5230.189320655304, 5350.839474815762, 5362.624616276862, 5366.6779993200535, 5368.70472124033, 3314.685104915029, 3408.403529382348, 3439.466882633196, 3449.7412694047794, 3463.8960831174854, 1106.3251416635846, 1115.553778488611, 1154.7632735289246, 1178.3401295274589, 1182.657029461455, 12436.81344779829, 12537.74924501514, 12543.184692994926, 12543.43554540057, 12570.497180112785, 4481.417415735934, 4502.077074199781, 4603.861884143481, 4616.169089563844, 4618.1918164321105, 10029.79940401188, 10030.147437467751, 10054.0, 10058.54736536843, 10058.949705251427, 5270.604704647167, 5347.759350829222, 5349.491798279158, 5355.732213389315, 5355.785768569292, 4396.362527433568, 4909.729964851896, 5009.974950125226, 5037.974810125999, 5043.344365232496, 3752.099496120911, 3809.6190380961684, 3823.9292997960615, 3832.4826148470156, 3878.6509214170296, 1142.828575713633, 1148.5405837665, 1154.0, 1157.7568710570706, 1164.6622479480855, 940.7224868663624, 1019.8470229465491, 1020.83666613343, 1024.6516184497157, 1034.3070143004054, 5985.730642121115, 6178.0, 6235.75056997715, 6297.842553936097, 6322.71547780351, 427.6984725768326, 440.43624161073876, 444.1849206705731, 444.34237328753625, 449.6313023320911, 4230.725002874803, 4240.448741663564, 4263.616274535307, 4278.572142785696, 4281.400603915455, 11081.778364432666, 11488.48301826403, 11514.596989105508, 11532.25040372373, 11536.480858361227, 11318.434078296052, 11324.94337528307, 11340.886591134147, 11428.714282143013, 11440.771184576428, 7662.118856331482, 7907.406944479187, 7925.167857375008, 8119.472234304633, 8376.623051962677, 5856.765729370777, 5982.790602329072, 6011.158437818622, 6037.909431358621, 6122.020476723703, 10357.63748268807, 10363.844542332023, 10513.158947284352, 10514.842277365693, 10554.10290125348, 9855.507224638883, 10308.12380947628, 10371.118454931415, 10381.584736610452, 10635.787284254116, 7174.1032370953635, 7635.847283054419, 7695.846083078419, 7847.725329613436, 7851.332636725942, 8773.298136148966, 8851.64593416282, 8884.37809353339, 8921.0, 8944.105589441004, 7888.0, 8187.26314631686, 8197.344212463107, 8265.793355166168, 8273.710420135507, 7703.075630924101, 7763.844723105619, 7856.37149028065, 7888.7633370998965, 8111.107778144517, 7184.928150718426, 7271.563706177646, 7449.994250776076, 7526.962365188139, 7529.849403012018, 5432.320959880015, 5439.129739241703, 5449.754761035842, 5505.559555235492, 5509.3664228614225, 5438.700871452108, 5458.426865179258, 5515.145152501369, 5546.972265138648, 5633.492985631313], "value": 4615.240367442485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.35873410269085, 315.6874694052887, 317.4048658764816, 319.691497704715, 320.781868329536, 5082.720450375228, 5280.759021629914, 5350.73246337683, 5382.273393091937, 5419.891602167959, 5418.4039755626845, 5419.620626556142, 5460.808871689492, 5468.179773034047, 5483.341998960131, 4222.8522001730025, 4224.429701990222, 4225.387318838767, 4249.213895429355, 4256.723312984646, 4068.9186216275803, 4071.3282308419075, 4191.916161676764, 4240.491141063077, 4265.189613973351, 4138.834446622147, 4158.563350848162, 4161.708680392374, 4166.854160104397, 4176.436181115556, 4078.3066878630557, 4102.200070986159, 4108.732932359387, 4128.318827393477, 4134.524529679095, 3550.3254381667402, 3637.8181090945614, 3646.2889736501393, 3662.377395842713, 3670.4861319415304, 5131.794728210867, 5137.588992880561, 5144.871378215537, 5145.0, 5169.405518365398, 4854.49027852074, 4900.166971614834, 4902.28916807061, 4904.969956309179, 4914.557689807899, 5434.864128396782, 5649.4633009864, 5666.914996275059, 5670.68811215383, 5677.347105082886, 4088.325426304656, 4090.5091389033505, 4100.753954762694, 4112.712110152291, 4120.649744771698, 5632.620008098002, 5755.280589926301, 5862.706864656793, 5870.589058765888, 5891.231121372991, 4133.937990930139, 4143.627073563393, 4162.854300099542, 4170.124273902454, 4178.979105104516, 4175.603317684815, 4198.769067701306, 4224.302990006676, 4238.131183107455, 4252.574742525784, 4669.066186762661, 4818.02460990999, 4819.373481447459, 4842.95157048425, 4853.466118726938, 5652.519535839418, 5711.514521265656, 5730.0, 5743.253377060955, 5744.454276843693, 1465.9853401465848, 1478.8077549918657, 1485.6434455730546, 1487.4793822162158, 1498.3182651893362, 934.56075644447, 954.7062633913027, 984.5126662302063, 984.7444508252036, 991.504247876062, 4856.660033797601, 4941.5669455858115, 4955.331030310862, 4972.825951091694, 4986.0, 5166.741662916839, 5229.294045303911, 5314.7608357624, 5318.377894742141, 5322.547583455373, 4998.175665881927, 5011.3986321640905, 5018.673786203885, 5140.306058682105, 5617.21359009739, 3102.255458689898, 3115.7818952673547, 3125.1718294651937, 3142.9371412571622, 3153.7003984621424, 6011.849703757441, 6037.788677396358, 6112.358202388774, 6136.23297087864, 6141.508679305645, 5647.830565082972, 5973.193618861398, 5989.880202396015, 5995.770866972261, 5996.610220335664, 6028.216331876828, 6045.365236650088, 6072.271327440735, 6125.387461253839, 6129.724162412702, 5557.583181261502, 5895.351511333835, 5903.734331955158, 5912.763489460545, 5965.508622844289, 5761.337446193741, 5795.913061304168, 5804.419558044331, 5831.542114471382, 5842.620229685057, 5720.485156335783, 5893.823185304448, 6076.321232650923, 6076.848078798065, 6124.846878828065, 4171.0823618803815, 4171.916561668811, 4191.721524934802, 4201.474815648044, 4212.178625168062, 5649.435056494318, 5863.442972917566, 5875.14810352488, 5988.431099045583, 6012.248468941382, 5709.5734312917675, 5717.198572699431, 5719.370869204467, 5719.685417301922, 5731.426857314235, 5703.144528320785, 5715.971420143039, 5730.455606717355, 5731.0, 5744.684042377709, 5369.0, 5635.690037048002, 5649.774009039593, 5660.773569057192, 5669.773209071756, 5784.537237021113, 5791.247137872049, 5803.274590676166, 5810.215620891295, 5814.447627475383, 5364.892702146013, 5654.575906807088, 5671.617920473329, 5685.687287199244, 5690.231818704422], "value": 4300.691166537877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.7511196417145, 789.0353020977767, 801.8075661841158, 811.2860682599312, 828.2049232736573, 14988.550343489685, 15754.133522656279, 15775.921120394396, 15942.760858587131, 15994.960327578714, 14667.0, 14983.77524337133, 15003.099814011168, 15005.0, 15007.92496037521, 693.6289085339345, 823.2672921100195, 828.3000864269683, 832.6128350317086, 835.0230230630146, 831.9084900660922, 833.6332013913858, 836.4145098431092, 838.4508147163588, 839.75227307944, 876.3909083187187, 877.3463769491738, 877.9946960729992, 878.0341624213346, 878.2885862451435, 715.3490323805338, 855.5123579559591, 856.1395797223781, 861.2980420956932, 873.6985739919718, 636.2778246689994, 636.6530241018656, 636.6593872278308, 636.723025483916, 637.1812221295659, 14619.0, 14673.559793206221, 14676.853231467656, 14680.26598670073, 14733.484328048575, 14023.85976140246, 14111.647208819759, 14116.0, 14334.498292559814, 14531.927340363336, 11611.129165312552, 12266.141370104096, 12506.74986500274, 12537.937310313482, 12875.098743087987, 4188.476440444944, 4213.97893010533, 4215.283401821667, 4215.852445164404, 4223.957760422387, 58448.0, 60248.698756506376, 60252.99999999956, 60496.39503604996, 60647.39352606462, 10497.790044199073, 10574.15406767472, 10645.84031239532, 10817.0, 10853.620123295646, 19271.22915083409, 19387.61224775525, 19466.0, 19476.0, 19566.804331956784, 8006.319462845607, 8185.181481851767, 8282.8343433131, 8356.122607126286, 8548.230659240699, 4465.821367145343, 4606.539346065367, 4615.26155815068, 4684.461286952044, 4718.952810471851, 3473.374792537317, 3596.2987217492337, 3604.044928094057, 3646.361886669822, 3647.744657873923, 562.7439515020656, 624.3974564545235, 633.9651319177398, 636.8726254749068, 642.5341627320156, 658.2627457247818, 728.8141523911369, 750.9098908131059, 752.3003606645763, 752.9811754706067, 9501.524923753785, 9684.273679474067, 9893.60425582983, 9988.30081894275, 10201.13290370312, 751.8609057324412, 755.7808235611722, 767.3170877918657, 781.6912319633713, 790.2650535002388, 4831.396075490564, 4834.734089625104, 4852.0, 4861.9027619447415, 4887.535684110004, 76354.23645763472, 76529.0, 77300.0, 78437.0, 78561.60719196367, 44704.0, 55780.16329755057, 68249.3175068243, 68892.655536723, 70741.64629176821, 57729.0, 57838.7108064457, 60250.39749602448, 60329.39670603326, 60774.39225607776, 9171.954140229524, 9295.0, 9297.953510232406, 9430.95284523573, 9577.185939194967, 39019.609803902735, 39358.803205983786, 39453.802730986165, 39574.2085158301, 40976.590234097275, 51021.48978510167, 54815.72592137014, 54928.0, 55635.44364556303, 55773.163402549806, 11591.826122608, 11706.70733231676, 11834.171607987702, 12064.457099430721, 12181.147319687538, 12823.679408014874, 12967.092303539039, 13052.15161014531, 13387.263700496565, 14069.859301406856, 12017.519299227934, 12458.626241212778, 12944.676383090498, 13090.869091308965, 13109.737805244033, 12078.0, 13116.475340986253, 13253.86746132565, 13409.195448273134, 13710.862891371358, 12432.564860229848, 13165.210087394787, 13418.597442076752, 13482.19106853592, 13501.797473037715, 10053.748656283651, 10326.380417174994, 10549.314294570828, 10802.89197108019, 10904.672859814218, 9760.316777825485, 10349.9482502587, 10567.682969510926, 10573.4713264338, 10680.786384272116], "value": 7079.06066327199, "unit": "score"}], "name": "dromaeo_css", "value": 7267.263614780788, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 110.0, 110.0, 110.0, 111.0, 113.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 151.0, 212.0, 124.0, 162.0, 151.0, 125.0, 194.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 163.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 150.0, 76.0, 73.0, 76.0, 75.0, 129.0, 74.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 152.0, 93.0, 92.0, 92.0, 127.0, 92.0, 93.0, 127.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 55.0, 53.0, 60.0, 105.0, 52.0, 53.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 78.0, 85.0, 79.0, 78.0, 79.0, 85.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 119.0, 118.0, 123.0, 127.0, 130.0, 124.0, 190.0, 122.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 158.0, 167.0, 160.0, 165.0, 160.0, 158.0, 157.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 63.0, 63.0, 62.0, 63.0, 61.0, 61.0, 65.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1524.8999999999999, "alertThreshold": 2.0}]} 21:02:45 INFO - Return code: 0 21:02:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:02:45 ERROR - # TBPL SUCCESS # 21:02:45 INFO - Running post-action listener: _resource_record_post_action 21:02:45 INFO - ##### 21:02:45 INFO - ##### Finished run-tests step (success) 21:02:45 INFO - ##### 21:02:45 INFO - Running post-run listener: _resource_record_post_run 21:02:45 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 536469504; Read time: 0; Write time: 388860 21:02:45 INFO - TinderboxPrint: CPU usage
13.1% 21:02:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:02:45 INFO - TinderboxPrint: I/O write bytes / time
536,469,504 / 388,860 21:02:45 INFO - TinderboxPrint: CPU idle
8,279.2 (86.9%) 21:02:45 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 21:02:45 INFO - TinderboxPrint: Swap in / out
0 / 0 21:02:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247070720; Read time: 0; Write time: 218556 21:02:45 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289398784; Read time: 0; Write time: 170304 21:02:45 INFO - Running post-run listener: _upload_blobber_files 21:02:45 INFO - Blob upload gear active. 21:02:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:02:45 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 21:02:45 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'] 21:02:45 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 21:02:46 INFO - (blobuploader) - INFO - Open directory for files ... 21:02:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:02:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:49 INFO - (blobuploader) - INFO - Done attempting. 21:02:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:02:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:50 INFO - (blobuploader) - INFO - Done attempting. 21:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:51 INFO - (blobuploader) - INFO - Done attempting. 21:02:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:02:51 INFO - Return code: 0 21:02:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:02:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:02:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c303add11f8b3dc591a5ed031dec97f93eb4723999e170bdad2c89d6c856a537f85d5f6cdea6614d5c5058617556a1cb3a8da224a2d02ad28514d533198d25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdaa45fdea2139a250f66c4e3c2980b67d9d23c0626bc9d705d1a6333b28820267ca40aaa9d82f89de5bd9fc203a179f2534bf2a832b8b582ed8798835269c94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a34ca174bd73e9a7fec0ab9e0e9306282e63481b0c1fbb39464729b78aacd828d48a3955a7647ecb30acafa11a78ba4f838b93f468736a4d20ebc1af671838ef"} 21:02:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:02:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:02:51 INFO - Contents: 21:02:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c303add11f8b3dc591a5ed031dec97f93eb4723999e170bdad2c89d6c856a537f85d5f6cdea6614d5c5058617556a1cb3a8da224a2d02ad28514d533198d25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdaa45fdea2139a250f66c4e3c2980b67d9d23c0626bc9d705d1a6333b28820267ca40aaa9d82f89de5bd9fc203a179f2534bf2a832b8b582ed8798835269c94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a34ca174bd73e9a7fec0ab9e0e9306282e63481b0c1fbb39464729b78aacd828d48a3955a7647ecb30acafa11a78ba4f838b93f468736a4d20ebc1af671838ef"} 21:02:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:02:51 INFO - Copying logs to upload dir... 21:02:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:02:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.671295 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-18 21:02:51.137238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 21:02:51.141313) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 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/6c303add11f8b3dc591a5ed031dec97f93eb4723999e170bdad2c89d6c856a537f85d5f6cdea6614d5c5058617556a1cb3a8da224a2d02ad28514d533198d25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdaa45fdea2139a250f66c4e3c2980b67d9d23c0626bc9d705d1a6333b28820267ca40aaa9d82f89de5bd9fc203a179f2534bf2a832b8b582ed8798835269c94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a34ca174bd73e9a7fec0ab9e0e9306282e63481b0c1fbb39464729b78aacd828d48a3955a7647ecb30acafa11a78ba4f838b93f468736a4d20ebc1af671838ef"} build_url:https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/cLr3FO4mTj-ZIVq8-qTwIw/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/6c303add11f8b3dc591a5ed031dec97f93eb4723999e170bdad2c89d6c856a537f85d5f6cdea6614d5c5058617556a1cb3a8da224a2d02ad28514d533198d25e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdaa45fdea2139a250f66c4e3c2980b67d9d23c0626bc9d705d1a6333b28820267ca40aaa9d82f89de5bd9fc203a179f2534bf2a832b8b582ed8798835269c94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a34ca174bd73e9a7fec0ab9e0e9306282e63481b0c1fbb39464729b78aacd828d48a3955a7647ecb30acafa11a78ba4f838b93f468736a4d20ebc1af671838ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 21:02:51.166563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:02:51.166910) ========= 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=8887e36bb8e381bfd44124ac000001a8-1463629334.740282-2085965306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 21:02:51.250726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 21:02:51.251069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 21:02:51.251428) ========= ========= Total master_lag: 0.17 =========