builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1464367773.09 results: success (0) buildid: 20160527091541 builduid: ea10b0c054ac40e1be19952977d41872 revision: eec76f75c79a0a597131357ec1eed49683183c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.090002) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.090817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.091811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.182938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.183368) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 09:49:33-- 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% 114M=0s 2016-05-27 09:49:33 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109549 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.326909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.327288) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016714 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.382010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:33.382318) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eec76f75c79a0a597131357ec1eed49683183c30 --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 eec76f75c79a0a597131357ec1eed49683183c30 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 09:49:33,671 truncating revision to first 12 chars 2016-05-27 09:49:33,671 Setting DEBUG logging. 2016-05-27 09:49:33,671 attempt 1/10 2016-05-27 09:49:33,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eec76f75c79a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 09:49:34,297 unpacking tar archive at: fx-team-eec76f75c79a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:34.377868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:34.378306) ========= script_repo_revision: eec76f75c79a0a597131357ec1eed49683183c30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:34.378703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:34.379047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 09:49:34.390593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-27 09:49:34.391042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:34 INFO - MultiFileLogger online at 20160527 09:49:34 in /builds/slave/test 09:49:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:49:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:49:34 INFO - {'append_to_log': False, 09:49:34 INFO - 'base_work_dir': '/builds/slave/test', 09:49:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:49:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:49:34 INFO - 'branch': 'Fx-Team-Non-PGO', 09:49:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:34 INFO - 'config_files': ('talos/linux_config.py',), 09:49:34 INFO - 'default_actions': ('clobber', 09:49:34 INFO - 'read-buildbot-config', 09:49:34 INFO - 'download-and-extract', 09:49:34 INFO - 'populate-webroot', 09:49:34 INFO - 'create-virtualenv', 09:49:34 INFO - 'install', 09:49:34 INFO - 'run-tests'), 09:49:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:34 INFO - 'download_minidump_stackwalk': True, 09:49:34 INFO - 'download_symbols': 'ondemand', 09:49:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:34 INFO - 'installer_path': 'installer.exe', 09:49:34 INFO - 'log_level': 'info', 09:49:34 INFO - 'log_name': 'talos', 09:49:34 INFO - 'log_to_console': True, 09:49:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:34 INFO - 'opt_config_files': (), 09:49:34 INFO - 'pip_index': False, 09:49:34 INFO - 'sps_profile': False, 09:49:34 INFO - 'sps_profile_interval': 0, 09:49:34 INFO - 'suite': 'dromaeojs', 09:49:34 INFO - 'system_bits': '32', 09:49:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:34 INFO - 'title': 'talos-linux64-ix-041', 09:49:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:34 INFO - 'use_talos_json': True, 09:49:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:49:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:34 INFO - 'work_dir': 'build'} 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running clobber step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: clobber 09:49:34 INFO - rmtree: /builds/slave/test/build 09:49:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:49:35 INFO - Running post-action listener: _resource_record_post_action 09:49:35 INFO - ##### 09:49:35 INFO - ##### Finished clobber step (success) 09:49:35 INFO - ##### 09:49:35 INFO - ##### 09:49:35 INFO - ##### Running read-buildbot-config step. 09:49:35 INFO - ##### 09:49:35 INFO - Running pre-action listener: _resource_record_pre_action 09:49:35 INFO - Running main action method: read_buildbot_config 09:49:35 INFO - Using buildbot properties: 09:49:35 INFO - { 09:49:35 INFO - "project": "", 09:49:35 INFO - "product": "firefox", 09:49:35 INFO - "script_repo_revision": "production", 09:49:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:49:35 INFO - "repository": "", 09:49:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:49:35 INFO - "buildid": "20160527091541", 09:49:35 INFO - "pgo_build": "False", 09:49:35 INFO - "basedir": "/builds/slave/test", 09:49:35 INFO - "buildnumber": 1732, 09:49:35 INFO - "slavename": "talos-linux64-ix-041", 09:49:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:49:35 INFO - "platform": "ubuntu64_hw", 09:49:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:49:35 INFO - "branch": "fx-team", 09:49:35 INFO - "repo_path": "integration/fx-team", 09:49:35 INFO - "revision": "eec76f75c79a0a597131357ec1eed49683183c30", 09:49:35 INFO - "stage_platform": "linux64", 09:49:35 INFO - "builduid": "ea10b0c054ac40e1be19952977d41872", 09:49:35 INFO - "slavebuilddir": "test" 09:49:35 INFO - } 09:49:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:49:35 INFO - Running post-action listener: _resource_record_post_action 09:49:35 INFO - ##### 09:49:35 INFO - ##### Finished read-buildbot-config step (success) 09:49:35 INFO - ##### 09:49:35 INFO - ##### 09:49:35 INFO - ##### Running download-and-extract step. 09:49:35 INFO - ##### 09:49:35 INFO - Running pre-action listener: _resource_record_pre_action 09:49:35 INFO - Running main action method: download_and_extract 09:49:35 INFO - mkdir: /builds/slave/test/build/tests 09:49:35 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')]} 09:49:35 INFO - https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:49:49 INFO - Downloaded 1361 bytes. 09:49:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:49:49 INFO - Using the following test package requirements: 09:49:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:49:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'jsshell-linux-x86_64.zip'], 09:49:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:49:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:49:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:49 INFO - https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:49:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:49:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:49:59 INFO - Downloaded 22837963 bytes. 09:49:59 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'] 09:49:59 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 09:50:00 INFO - Return code: 0 09:50:00 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 09:50:00 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')]} 09:50:00 INFO - https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:01 INFO - Downloaded 22837963 bytes. 09:50:01 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'] 09:50:01 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 09:50:03 INFO - Return code: 0 09:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:03 INFO - https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:50:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:04 INFO - Downloaded 10834034 bytes. 09:50:04 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'] 09:50:04 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 09:50:04 INFO - Return code: 0 09:50:04 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')]} 09:50:04 INFO - https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d621uzjdQjmG2yvXJf0RCA/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 09:50:06 INFO - Downloaded 54834866 bytes. 09:50:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:06 INFO - mkdir: /builds/slave/test/properties 09:50:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:06 INFO - Contents: 09:50:06 INFO - build_url:https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:50:07 INFO - Running post-action listener: _resource_record_post_action 09:50:07 INFO - Running post-action listener: set_extra_try_arguments 09:50:07 INFO - ##### 09:50:07 INFO - ##### Finished download-and-extract step (success) 09:50:07 INFO - ##### 09:50:07 INFO - ##### 09:50:07 INFO - ##### Running populate-webroot step. 09:50:07 INFO - ##### 09:50:07 INFO - Running pre-action listener: _resource_record_pre_action 09:50:07 INFO - Running main action method: populate_webroot 09:50:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:07 INFO - '--tppagecycles', 09:50:07 INFO - '7'], 09:50:07 INFO - 'tests': ['tsvgm']}}, 09:50:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['damp', 'tps']}, 09:50:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'tests': ['damp', 'tps']}, 09:50:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['dromaeo_dom']}, 09:50:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['a11yr', 09:50:07 INFO - 'ts_paint', 09:50:07 INFO - 'tpaint', 09:50:07 INFO - 'sessionrestore', 09:50:07 INFO - 'sessionrestore_no_auto_restore', 09:50:07 INFO - 'tabpaint']}, 09:50:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['tsvgx', 09:50:07 INFO - 'tsvgr_opacity', 09:50:07 INFO - 'tart', 09:50:07 INFO - 'tscrollx', 09:50:07 INFO - 'cart']}, 09:50:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:07 INFO - 'tsvgr_opacity', 09:50:07 INFO - 'tart', 09:50:07 INFO - 'tscrollx', 09:50:07 INFO - 'cart']}, 09:50:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'talos_options': ['--disable-e10s'], 09:50:07 INFO - 'tests': ['tp5o']}, 09:50:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'tests': ['tp5o']}, 09:50:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'talos_options': ['--disable-e10s', 09:50:07 INFO - '--xperf_path', 09:50:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:07 INFO - 'tests': ['tp5n']}, 09:50:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:07 INFO - 'talos_options': ['--xperf_path', 09:50:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:07 INFO - 'tests': ['tp5n']}}, 09:50:07 INFO - 'talos.zip': {'path': '', 09:50:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:07 INFO - Running post-action listener: _resource_record_post_action 09:50:07 INFO - ##### 09:50:07 INFO - ##### Finished populate-webroot step (success) 09:50:07 INFO - ##### 09:50:07 INFO - ##### 09:50:07 INFO - ##### Running create-virtualenv step. 09:50:07 INFO - ##### 09:50:07 INFO - Running pre-action listener: _resource_record_pre_action 09:50:07 INFO - Running main action method: create_virtualenv 09:50:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:07 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 09:50:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:07 INFO - Using real prefix '/usr' 09:50:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:09 INFO - Installing pip.................done. 09:50:09 INFO - Return code: 0 09:50:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:09 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')]} 09:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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')]} 09:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:09 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 09:50:09 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 09:50:09 INFO - Using env: {'DISPLAY': ':0', 09:50:09 INFO - 'HOME': '/home/cltbld', 09:50:09 INFO - 'LANG': 'en_US.UTF-8', 09:50:09 INFO - 'LANGUAGE': 'en_US:en', 09:50:09 INFO - 'LOGNAME': 'cltbld', 09:50:09 INFO - 'MAIL': '/var/mail/cltbld', 09:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:09 INFO - 'MOZ_NO_REMOTE': '1', 09:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:09 INFO - 'NO_EM_RESTART': '1', 09:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:09 INFO - 'PWD': '/builds/slave/test', 09:50:09 INFO - 'SHELL': '/bin/bash', 09:50:09 INFO - 'SHLVL': '1', 09:50:09 INFO - 'TERM': 'linux', 09:50:09 INFO - 'TMOUT': '86400', 09:50:09 INFO - 'USER': 'cltbld', 09:50:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:09 INFO - '_': '/tools/buildbot/bin/python'} 09:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:09 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 09:50:09 INFO - Cleaning up... 09:50:09 INFO - Return code: 0 09:50:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:50:09 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')]} 09:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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')]} 09:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:09 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 09:50:09 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 09:50:09 INFO - Using env: {'DISPLAY': ':0', 09:50:09 INFO - 'HOME': '/home/cltbld', 09:50:09 INFO - 'LANG': 'en_US.UTF-8', 09:50:09 INFO - 'LANGUAGE': 'en_US:en', 09:50:09 INFO - 'LOGNAME': 'cltbld', 09:50:09 INFO - 'MAIL': '/var/mail/cltbld', 09:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:09 INFO - 'MOZ_NO_REMOTE': '1', 09:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:09 INFO - 'NO_EM_RESTART': '1', 09:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:09 INFO - 'PWD': '/builds/slave/test', 09:50:09 INFO - 'SHELL': '/bin/bash', 09:50:09 INFO - 'SHLVL': '1', 09:50:09 INFO - 'TERM': 'linux', 09:50:09 INFO - 'TMOUT': '86400', 09:50:09 INFO - 'USER': 'cltbld', 09:50:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:09 INFO - '_': '/tools/buildbot/bin/python'} 09:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:10 INFO - Downloading/unpacking psutil>=3.1.1 09:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:12 INFO - Installing collected packages: psutil 09:50:12 INFO - Running setup.py install for psutil 09:50:12 INFO - building 'psutil._psutil_linux' extension 09:50:12 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 09:50:12 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 09:50:12 INFO - building 'psutil._psutil_posix' extension 09:50:12 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 09:50:12 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 09:50:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:12 INFO - Successfully installed psutil 09:50:12 INFO - Cleaning up... 09:50:12 INFO - Return code: 0 09:50:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:12 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:12 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 09:50:12 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 09:50:12 INFO - Using env: {'DISPLAY': ':0', 09:50:12 INFO - 'HOME': '/home/cltbld', 09:50:12 INFO - 'LANG': 'en_US.UTF-8', 09:50:12 INFO - 'LANGUAGE': 'en_US:en', 09:50:12 INFO - 'LOGNAME': 'cltbld', 09:50:12 INFO - 'MAIL': '/var/mail/cltbld', 09:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:12 INFO - 'MOZ_NO_REMOTE': '1', 09:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:12 INFO - 'NO_EM_RESTART': '1', 09:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:12 INFO - 'PWD': '/builds/slave/test', 09:50:12 INFO - 'SHELL': '/bin/bash', 09:50:12 INFO - 'SHLVL': '1', 09:50:12 INFO - 'TERM': 'linux', 09:50:12 INFO - 'TMOUT': '86400', 09:50:12 INFO - 'USER': 'cltbld', 09:50:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:12 INFO - '_': '/tools/buildbot/bin/python'} 09:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:50:14 INFO - Installing collected packages: mozsystemmonitor 09:50:14 INFO - Running setup.py install for mozsystemmonitor 09:50:14 INFO - Successfully installed mozsystemmonitor 09:50:14 INFO - Cleaning up... 09:50:14 INFO - Return code: 0 09:50:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:50:14 INFO - Using env: {'DISPLAY': ':0', 09:50:14 INFO - 'HOME': '/home/cltbld', 09:50:14 INFO - 'LANG': 'en_US.UTF-8', 09:50:14 INFO - 'LANGUAGE': 'en_US:en', 09:50:14 INFO - 'LOGNAME': 'cltbld', 09:50:14 INFO - 'MAIL': '/var/mail/cltbld', 09:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:14 INFO - 'MOZ_NO_REMOTE': '1', 09:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:14 INFO - 'NO_EM_RESTART': '1', 09:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:14 INFO - 'PWD': '/builds/slave/test', 09:50:14 INFO - 'SHELL': '/bin/bash', 09:50:14 INFO - 'SHLVL': '1', 09:50:14 INFO - 'TERM': 'linux', 09:50:14 INFO - 'TMOUT': '86400', 09:50:14 INFO - 'USER': 'cltbld', 09:50:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:14 INFO - '_': '/tools/buildbot/bin/python'} 09:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:50:15 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 09:50:15 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 09:50:15 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 09:50:15 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 09:50:15 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 09:50:15 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 09:50:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:50:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 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 09:50:17 INFO - Downloading docopt-0.6.1.tar.gz 09:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:17 INFO - Running setup.py install for blobuploader 09:50:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:50:17 INFO - Running setup.py install for requests 09:50:18 INFO - Running setup.py install for docopt 09:50:18 INFO - Successfully installed blobuploader requests docopt 09:50:18 INFO - Cleaning up... 09:50:18 INFO - Return code: 0 09:50:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50: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')]} 09:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:18 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:18 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 09:50:18 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 09:50:18 INFO - Using env: {'DISPLAY': ':0', 09:50:18 INFO - 'HOME': '/home/cltbld', 09:50:18 INFO - 'LANG': 'en_US.UTF-8', 09:50:18 INFO - 'LANGUAGE': 'en_US:en', 09:50:18 INFO - 'LOGNAME': 'cltbld', 09:50:18 INFO - 'MAIL': '/var/mail/cltbld', 09:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:18 INFO - 'MOZ_NO_REMOTE': '1', 09:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:18 INFO - 'NO_EM_RESTART': '1', 09:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:18 INFO - 'PWD': '/builds/slave/test', 09:50:18 INFO - 'SHELL': '/bin/bash', 09:50:18 INFO - 'SHLVL': '1', 09:50:18 INFO - 'TERM': 'linux', 09:50:18 INFO - 'TMOUT': '86400', 09:50:18 INFO - 'USER': 'cltbld', 09:50:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:18 INFO - '_': '/tools/buildbot/bin/python'} 09:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:18 INFO - Running setup.py (path:/tmp/pip-HLLGXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:18 INFO - Running setup.py (path:/tmp/pip-vk74U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:18 INFO - Running setup.py (path:/tmp/pip-5Ukc4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:18 INFO - Running setup.py (path:/tmp/pip-i7Y7d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:18 INFO - Running setup.py (path:/tmp/pip-l_az2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:18 INFO - Running setup.py (path:/tmp/pip-mgSp7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:18 INFO - Running setup.py (path:/tmp/pip-MtVfKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:19 INFO - Running setup.py (path:/tmp/pip-pUqShA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:19 INFO - Running setup.py (path:/tmp/pip-0VIcwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:19 INFO - Running setup.py (path:/tmp/pip-M50nrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:19 INFO - Running setup.py (path:/tmp/pip-AMpzhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:19 INFO - Running setup.py (path:/tmp/pip-vEvX_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:19 INFO - Running setup.py (path:/tmp/pip-Za3g2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:19 INFO - Running setup.py (path:/tmp/pip-dfVKzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:19 INFO - Running setup.py (path:/tmp/pip-ljHMoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:19 INFO - Running setup.py (path:/tmp/pip-naSTaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:19 INFO - Running setup.py (path:/tmp/pip-WgVKdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:19 INFO - Running setup.py install for manifestparser 09:50:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:50:19 INFO - Running setup.py install for mozcrash 09:50:19 INFO - Running setup.py install for mozdebug 09:50:20 INFO - Running setup.py install for mozdevice 09:50:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for mozfile 09:50:20 INFO - Running setup.py install for mozhttpd 09:50:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for mozinfo 09:50:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for mozInstall 09:50:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for mozleak 09:50:20 INFO - Running setup.py install for mozlog 09:50:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for moznetwork 09:50:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:50:20 INFO - Running setup.py install for mozprocess 09:50:21 INFO - Running setup.py install for mozprofile 09:50:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:50:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:50:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:50:21 INFO - Running setup.py install for mozrunner 09:50:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:50:21 INFO - Running setup.py install for mozscreenshot 09:50:21 INFO - Running setup.py install for moztest 09:50:21 INFO - Running setup.py install for mozversion 09:50:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:50:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:21 INFO - Cleaning up... 09:50:21 INFO - Return code: 0 09:50:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:21 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:21 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 09:50:21 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 09:50:21 INFO - Using env: {'DISPLAY': ':0', 09:50:21 INFO - 'HOME': '/home/cltbld', 09:50:21 INFO - 'LANG': 'en_US.UTF-8', 09:50:21 INFO - 'LANGUAGE': 'en_US:en', 09:50:21 INFO - 'LOGNAME': 'cltbld', 09:50:21 INFO - 'MAIL': '/var/mail/cltbld', 09:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:21 INFO - 'MOZ_NO_REMOTE': '1', 09:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:21 INFO - 'NO_EM_RESTART': '1', 09:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:21 INFO - 'PWD': '/builds/slave/test', 09:50:21 INFO - 'SHELL': '/bin/bash', 09:50:21 INFO - 'SHLVL': '1', 09:50:21 INFO - 'TERM': 'linux', 09:50:21 INFO - 'TMOUT': '86400', 09:50:21 INFO - 'USER': 'cltbld', 09:50:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:21 INFO - '_': '/tools/buildbot/bin/python'} 09:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:21 INFO - Running setup.py (path:/tmp/pip-yPATq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:21 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)) 09:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:21 INFO - Running setup.py (path:/tmp/pip-i9K8ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:21 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)) 09:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:21 INFO - Running setup.py (path:/tmp/pip-sea0pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:22 INFO - Running setup.py (path:/tmp/pip-tpcnqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:22 INFO - Running setup.py (path:/tmp/pip-McmdD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:22 INFO - Running setup.py (path:/tmp/pip-y5wnVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:22 INFO - Running setup.py (path:/tmp/pip-MHSGMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:22 INFO - Running setup.py (path:/tmp/pip-zaFssX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:22 INFO - Running setup.py (path:/tmp/pip-w2j5ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:22 INFO - Running setup.py (path:/tmp/pip-AWUqcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:22 INFO - Running setup.py (path:/tmp/pip-QMfbvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:22 INFO - Running setup.py (path:/tmp/pip-Sjzxlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:22 INFO - Running setup.py (path:/tmp/pip-HWmzj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:22 INFO - Running setup.py (path:/tmp/pip-SdGfMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:22 INFO - Running setup.py (path:/tmp/pip-XwFJQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:22 INFO - Running setup.py (path:/tmp/pip-Dt5Nar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:22 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)) 09:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:22 INFO - Running setup.py (path:/tmp/pip-4ZsjyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:23 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)) 09:50:23 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)) 09:50:23 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)) 09:50:23 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)) 09:50:23 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)) 09:50:23 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)) 09:50:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:23 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 09:50:24 INFO - Downloading blessings-1.6.tar.gz 09:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:25 INFO - Installing collected packages: blessings 09:50:25 INFO - Running setup.py install for blessings 09:50:25 INFO - Successfully installed blessings 09:50:25 INFO - Cleaning up... 09:50:25 INFO - Return code: 0 09:50:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:25 INFO - Reading from file tmpfile_stdout 09:50:25 INFO - Current package versions: 09:50:25 INFO - argparse == 1.2.1 09:50:25 INFO - blessings == 1.6 09:50:25 INFO - blobuploader == 1.2.4 09:50:25 INFO - docopt == 0.6.1 09:50:25 INFO - manifestparser == 1.1 09:50:25 INFO - mozInstall == 1.12 09:50:25 INFO - mozcrash == 0.17 09:50:25 INFO - mozdebug == 0.1 09:50:25 INFO - mozdevice == 0.48 09:50:25 INFO - mozfile == 1.2 09:50:25 INFO - mozhttpd == 0.7 09:50:25 INFO - mozinfo == 0.9 09:50:25 INFO - mozleak == 0.1 09:50:25 INFO - mozlog == 3.2 09:50:25 INFO - moznetwork == 0.27 09:50:25 INFO - mozprocess == 0.22 09:50:25 INFO - mozprofile == 0.28 09:50:25 INFO - mozrunner == 6.11 09:50:25 INFO - mozscreenshot == 0.1 09:50:25 INFO - mozsystemmonitor == 0.3 09:50:25 INFO - moztest == 0.7 09:50:25 INFO - mozversion == 1.4 09:50:25 INFO - psutil == 3.1.1 09:50:25 INFO - requests == 1.2.3 09:50:25 INFO - wsgiref == 0.1.2 09:50:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:25 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')]} 09:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:25 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')]} 09:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:25 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:25 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 09:50:25 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 09:50:25 INFO - Using env: {'DISPLAY': ':0', 09:50:25 INFO - 'HOME': '/home/cltbld', 09:50:25 INFO - 'LANG': 'en_US.UTF-8', 09:50:25 INFO - 'LANGUAGE': 'en_US:en', 09:50:25 INFO - 'LOGNAME': 'cltbld', 09:50:25 INFO - 'MAIL': '/var/mail/cltbld', 09:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:25 INFO - 'MOZ_NO_REMOTE': '1', 09:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:25 INFO - 'NO_EM_RESTART': '1', 09:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:25 INFO - 'PWD': '/builds/slave/test', 09:50:25 INFO - 'SHELL': '/bin/bash', 09:50:25 INFO - 'SHLVL': '1', 09:50:25 INFO - 'TERM': 'linux', 09:50:25 INFO - 'TMOUT': '86400', 09:50:25 INFO - 'USER': 'cltbld', 09:50:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:25 INFO - '_': '/tools/buildbot/bin/python'} 09:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 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)) 09:50:25 INFO - Cleaning up... 09:50:25 INFO - Return code: 0 09:50:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:50:25 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')]} 09:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:25 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')]} 09:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:25 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:25 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 09:50:25 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 09:50:25 INFO - Using env: {'DISPLAY': ':0', 09:50:25 INFO - 'HOME': '/home/cltbld', 09:50:25 INFO - 'LANG': 'en_US.UTF-8', 09:50:25 INFO - 'LANGUAGE': 'en_US:en', 09:50:25 INFO - 'LOGNAME': 'cltbld', 09:50:25 INFO - 'MAIL': '/var/mail/cltbld', 09:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:25 INFO - 'MOZ_NO_REMOTE': '1', 09:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:25 INFO - 'NO_EM_RESTART': '1', 09:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:25 INFO - 'PWD': '/builds/slave/test', 09:50:25 INFO - 'SHELL': '/bin/bash', 09:50:25 INFO - 'SHLVL': '1', 09:50:25 INFO - 'TERM': 'linux', 09:50:25 INFO - 'TMOUT': '86400', 09:50:25 INFO - 'USER': 'cltbld', 09:50:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:25 INFO - '_': '/tools/buildbot/bin/python'} 09:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:25 INFO - Downloading/unpacking jsonschema 09:50:25 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 09:50:25 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 09:50:25 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 09:50:25 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 09:50:25 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 09:50:25 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 09:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:50:27 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 09:50:27 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 09:50:27 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 09:50:27 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 09:50:27 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 09:50:27 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 09:50:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:27 INFO - warning: no files found matching '*.txt' 09:50:27 INFO - no previously-included directories found matching 'build' 09:50:27 INFO - no previously-included directories found matching 'dist' 09:50:27 INFO - no previously-included directories found matching '.git*' 09:50:28 INFO - Installing collected packages: jsonschema, functools32 09:50:28 INFO - Running setup.py install for functools32 09:50:28 INFO - warning: no files found matching '*.txt' 09:50:28 INFO - no previously-included directories found matching 'build' 09:50:28 INFO - no previously-included directories found matching 'dist' 09:50:28 INFO - no previously-included directories found matching '.git*' 09:50:28 INFO - Successfully installed jsonschema functools32 09:50:28 INFO - Cleaning up... 09:50:28 INFO - Return code: 0 09:50:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:28 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 0x7fa82d81ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', '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 09:50:28 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 09:50:28 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 09:50:28 INFO - Using env: {'DISPLAY': ':0', 09:50:28 INFO - 'HOME': '/home/cltbld', 09:50:28 INFO - 'LANG': 'en_US.UTF-8', 09:50:28 INFO - 'LANGUAGE': 'en_US:en', 09:50:28 INFO - 'LOGNAME': 'cltbld', 09:50:28 INFO - 'MAIL': '/var/mail/cltbld', 09:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:28 INFO - 'MOZ_NO_REMOTE': '1', 09:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:28 INFO - 'NO_EM_RESTART': '1', 09:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:28 INFO - 'PWD': '/builds/slave/test', 09:50:28 INFO - 'SHELL': '/bin/bash', 09:50:28 INFO - 'SHLVL': '1', 09:50:28 INFO - 'TERM': 'linux', 09:50:28 INFO - 'TMOUT': '86400', 09:50:28 INFO - 'USER': 'cltbld', 09:50:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:28 INFO - '_': '/tools/buildbot/bin/python'} 09:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:28 INFO - Downloading/unpacking flake8 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:28 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 09:50:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:50:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:50:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:50:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:31 INFO - no previously-included directories found matching 'docs/_build' 09:50:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:50:31 INFO - Running setup.py install for pep8 09:50:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:31 INFO - no previously-included directories found matching 'docs/_build' 09:50:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:50:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:50:31 INFO - Cleaning up... 09:50:31 INFO - Return code: 0 09:50:31 INFO - Running post-action listener: _resource_record_post_action 09:50:31 INFO - Running post-action listener: _start_resource_monitoring 09:50:31 INFO - Starting resource monitoring. 09:50:31 INFO - ##### 09:50:31 INFO - ##### Finished create-virtualenv step (success) 09:50:31 INFO - ##### 09:50:31 INFO - ##### 09:50:31 INFO - ##### Running install step. 09:50:31 INFO - ##### 09:50:31 INFO - Running pre-action listener: _resource_record_pre_action 09:50:31 INFO - Running main action method: install 09:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:31 INFO - Reading from file tmpfile_stdout 09:50:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:50:31 INFO - Reading from file tmpfile_stdout 09:50:31 INFO - Output received: 09:50:31 INFO - Usage: mozinstall [options] installer 09:50:31 INFO - Options: 09:50:31 INFO - -h, --help show this help message and exit 09:50:31 INFO - -d DEST, --destination=DEST 09:50:31 INFO - Directory to install application into. [default: 09:50:31 INFO - "/builds/slave/test"] 09:50:31 INFO - --app=APP Application being installed. [default: firefox] 09:50:31 INFO - mkdir: /builds/slave/test/build/application 09:50:31 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'] 09:50:31 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 09:50:47 INFO - Reading from file tmpfile_stdout 09:50:47 INFO - Output received: 09:50:47 INFO - /builds/slave/test/build/application/firefox/firefox 09:50:47 INFO - Running post-action listener: _resource_record_post_action 09:50:47 INFO - ##### 09:50:47 INFO - ##### Finished install step (success) 09:50:47 INFO - ##### 09:50:47 INFO - ##### 09:50:47 INFO - ##### Running run-tests step. 09:50:47 INFO - ##### 09:50:47 INFO - Running pre-action listener: _resource_record_pre_action 09:50:47 INFO - Running main action method: run_tests 09:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:47 INFO - Python 2.7.3 09:50:47 INFO - Return code: 0 09:50:47 INFO - grabbing minidump binary from tooltool 09:50: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')]} 09:50:47 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 0x1d6a9c0>, '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 0x1d6b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50:47 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 09:50:47 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 09:50:47 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 09:50:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:47 INFO - Return code: 0 09:50:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:50:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:50:48 INFO - Return code: 0 09:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 09:50:48 INFO - Using env: {'DISPLAY': ':0', 09:50:48 INFO - 'HOME': '/home/cltbld', 09:50:48 INFO - 'LANG': 'en_US.UTF-8', 09:50:48 INFO - 'LANGUAGE': 'en_US:en', 09:50:48 INFO - 'LOGNAME': 'cltbld', 09:50:48 INFO - 'MAIL': '/var/mail/cltbld', 09:50:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:48 INFO - 'MOZ_NO_REMOTE': '1', 09:50:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:48 INFO - 'NO_EM_RESTART': '1', 09:50:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:48 INFO - 'PWD': '/builds/slave/test', 09:50:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:48 INFO - 'SHELL': '/bin/bash', 09:50:48 INFO - 'SHLVL': '1', 09:50:48 INFO - 'TERM': 'linux', 09:50:48 INFO - 'TMOUT': '86400', 09:50:48 INFO - 'USER': 'cltbld', 09:50:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883', 09:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:48 INFO - '_': '/tools/buildbot/bin/python'} 09:50:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:50:48 INFO - mozversion application_buildid: 20160527091541 09:50:48 INFO - mozversion application_changeset: eec76f75c79a0a597131357ec1eed49683183c30 09:50:48 INFO - mozversion application_display_name: Nightly 09:50:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:48 INFO - mozversion application_name: Firefox 09:50:48 INFO - mozversion application_remotingname: firefox 09:50:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:50:48 INFO - mozversion application_vendor: Mozilla 09:50:48 INFO - mozversion application_version: 49.0a1 09:50:48 INFO - mozversion platform_buildid: 20160527091541 09:50:48 INFO - mozversion platform_changeset: eec76f75c79a0a597131357ec1eed49683183c30 09:50:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:50:48 INFO - mozversion platform_version: 49.0a1 09:50:48 INFO - using testdate: 1464367848 09:50:48 INFO - actual date: 1464367848 09:50:48 INFO - starting webserver on 'localhost:50324' 09:50:48 INFO - SUITE-START | Running 2 tests 09:50:48 INFO - TEST-START | dromaeo_css 09:50:48 INFO - operating with platform_type : linux_ 09:50:48 INFO - Initialising browser for dromaeo_css test... 09:50:48 INFO - TEST-INFO | started process 10765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDgjdY/profile http://localhost:50324/getInfo.html) 09:50:53 INFO - PROCESS | 10765 | __metrics Screen width/height:1600/1200 09:50:53 INFO - PROCESS | 10765 | colorDepth:24 09:50:53 INFO - PROCESS | 10765 | Browser inner width/height: 1024/697 09:50:53 INFO - PROCESS | 10765 | __metrics 09:50:54 ERROR - PROCESS | 10765 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:50:55 INFO - TEST-INFO | 10765: exit 0 09:50:55 INFO - Browser initialized. 09:50:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:55 INFO - TEST-INFO | started process 10848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDgjdY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:07 INFO - PROCESS | 10848 | RSS: Main: 156835840 09:51:07 INFO - PROCESS | 10848 | 09:51:58 INFO - PROCESS | 10848 | 1464367918880 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] 09:54:10 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50324/tests/dromaeo/cssquery-ext.html) 09:54:11 INFO - PROCESS | 10848 | RSS: Main: 259293184 09:54:11 INFO - PROCESS | 10848 | 09:57:14 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-ext.html (next: http://localhost:50324/tests/dromaeo/cssquery-jquery.html) 09:57:15 INFO - PROCESS | 10848 | RSS: Main: 243523584 09:57:15 INFO - PROCESS | 10848 | 10:00:17 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50324/tests/dromaeo/cssquery-mootools.html) 10:00:17 INFO - PROCESS | 10848 | RSS: Main: 242331648 10:00:17 INFO - PROCESS | 10848 | 10:03:19 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50324/tests/dromaeo/cssquery-prototype.html) 10:03:20 INFO - PROCESS | 10848 | RSS: Main: 242741248 10:03:20 INFO - PROCESS | 10848 | 10:06:23 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50324/tests/dromaeo/cssquery-yui.html) 10:06:24 INFO - PROCESS | 10848 | RSS: Main: 211705856 10:06:24 INFO - PROCESS | 10848 | 10:09:26 INFO - PROCESS | 10848 | Cycle 1(1): loaded http://localhost:50324/tests/dromaeo/cssquery-yui.html (next: http://localhost:50324/tests/dromaeo/cssquery-dojo.html) 10:09:27 INFO - PROCESS | 10848 | RSS: Main: 272171008 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | __start_tp_report 10:09:27 INFO - PROCESS | 10848 | _x_x_mozilla_page_load 10:09:27 INFO - PROCESS | 10848 | _x_x_mozilla_page_load_details 10:09:27 INFO - PROCESS | 10848 | |i|pagename|runs| 10:09:27 INFO - PROCESS | 10848 | |0;dojo.html;2696.245051385612;2702.0272701827353;2718.320419895026;2734.4667789780974;2760.1443552498727;4611.146937816507;4710.2228132358205;4774.809007639695;4818.060478206751;4851.126797176506;4764.880877978052;4812.061647978646;4812.350332705084;4813.711177329363;4825.806967721296;4383.079553293812;4416.624586910117;4467.664925130612;4524.909501809978;4559.817607295704;4466.687331886769;4498.055408364247;4517.006258623114;4517.661175411858;4552.772361381918;4343.847965321214;4398.7580683062415;4436.046250056221;4495.595396414338;4510.751908645023;4369.6722745794195;4374.868753937387;4386.978065109686;4487.102579484083;4496.842610508649;4413.58070983256;4415.602595766364;4419.292913133883;4428.535003824616;4480.260756975095;4621.3299071634765;4624.213883639789;4674.953250467486;4707.105649926503;4787.80848766049;5205.037068142368;5206.713630750307;5206.947930520684;5217.660852044605;5222.190560463135;5232.424433312332;5242.475752424765;5245.475452454724;5262.736863156827;5264.263003179558;4714.057188562301;4839.249916262985;4870.1233777920315;4886.291487734258;4893.486183950705;5356.4107948125675;5366.329208848894;5379.058664733656;5391.595630327741;5392.676439413648;5152.6650767699975;5160.509751573594;5168.819091331786;5173.120569503193;5175.146100893386;5041.546260836542;5131.846044618667;5206;5207.29701490294;5239.056969745482;5138.717370544581;5174.275601415805;5176.042432149989;5188.792448302102;5245.659032162897;5022.42242142151;5172.689638621695;5183.481651834786;5187.144121219956;5187.896242075138;4309.095090031066;4337.566243375637;4393.956060439418;4402.471703395613;4406.515283318832;3815.3513902636064;3818.59904710007;3831.1954489557506;3894.883153505399;3905.5703872573995;4426.26966550522;4427.601515863587;4433.246348120827;4436.3567282743825;4479.417675702203;4980.302757613937;5077.949220507748;5206.245094461282;5214.504622060898;5217.139172036572;4381.671374646914;4419.0940857124215;4437.733735975788;4459.799309031101;4492.326151077365;4636.582707556337;4638.1187574360765;4641.698289611165;4645.558671926162;4686.929696054562;4877.5366340197625;4882.096812089775;4896.877578060506;4898.755062246944;4932.580730637936;5056.191009438472;5114.028334616411;5122.103631864335;5175.534201921845;5191.428942816212;4865.7323847188745;4896.4124305083615;4897.314375987294;4908.484609115992;4955.677880937727;5114.3862736471865;5118.513741194581;5123.077845987758;5130.563902068366;5134.05020071288;4985.202367621163;5107.6169287302855;5160.432352441304;5166.4058633257655;5188.22176673502;4998.425181104074;5025.597952163891;5032.3961124665275;5039.319691841701;5099.286099945936;4869.245266983623;5033.320501732219;5053.444121146597;5059.822906198266;5060.51925067118;4883.413990321184;4917.188663870565;4922.704637721748;4980.203167493184;4981.37732783402;5027;5037.445880953165;5043.5460808527405;5044.798208071636;5086.135356989246;4835.2505361669;4882.707037577757;4897.608191344612;4949.9257511138085;4997.85006449807 10:09:27 INFO - PROCESS | 10848 | |1;ext.html;548.5118244762162;590.1207201270107;599.1761328173761;599.1881001243313;620.8634100497891;30274.848625756895;44348.334774978364;45104;45221;45351.31973020407;42465.36301955473;43183.56816431835;43246.13507729844;43391.349129763075;43460.78269608648;7449.590272535009;7822.452428330019;7993.2806047455715;10073.143782778472;10344.172466202686;10206.744831379237;10327.380357178556;10350.896491035106;10357.223208259373;10357.689269321932;10338.431386273753;10421.68734937953;10422.687319380431;10440.321379110372;10443.73890652736;7523.510971786844;10055.849162262572;10402.427866467342;10407.115395191418;10695;10265.589376424934;10293.897061029369;10341.63804266847;10350.896491035068;10365.74085647865;38820.611793882264;39189.41215881764;39281.21437571233;39361.60638393608;39385.21229575421;2957.763378929702;3000.5499175123687;3059.938801223985;3087.9536806947913;3434.1733920879387;29844.70155298441;30259.546106808415;30553.694463055308;30777.53833692474;32018.359632807445;3403.694845932538;3553.6091029986683;3553.7157027437743;3569.6787289144104;3591.4612808078737;251133;252006;252113;252439;253730.73134634394;29242.122736317946;56210.71894640501;57014.42985570174;57030.429695702514;57050.714746426835;34789.652103479144;34919;34920.65079349174;34937;34964.125896852274;10907;11773.76452470963;11871.821922671166;11874.287542747463;11875.109366797353;9575.329726919048;9941;9952.10431061208;10160.54277557497;10170.542325595366;7963.203679631991;8045.637946292431;8047.83904321922;8087;8128.268455839003;3124.765642576816;3163.7943533670236;3164.0666003529013;3179.60254968129;3191.7765756397293;822.3421262989584;835.8202986357962;955.3980991975011;981.6073570571829;1005.5776573839005;27517.724822751516;28971.85514072416;29106.708932910824;29147.708522914923;29209.561856572167;930.7068273493828;939.9295052870925;956.8564715292623;968.4867020479157;1009.2783659683362;15020.324085416183;15275.770863437057;15324.157171355682;15362.615934601725;15620.140892251035;380116;380448;384343;384371;386345;52587.73706131445;53303.20045199325;53304.466955330725;53338.46661533335;53380.73309633427;1044.3525014491065;1161.959331423413;1164.057113737875;1182.148852825964;1185.851768528934;28492.857535713018;30061.398772024873;30118.54822177625;30233.244168895075;30674.07977760671;44456.33315500335;44542.3318650227;44835.77582112199;44957.325640116076;45034.0993180128;281499;281991;282126;282732;283003;22729.77270227343;25252;26304.736952630996;26421.207363779118;27595.586066209424;43586;43643.78178109089;45172.77413612911;45302;48548.757256213496;38163.42754858735;38280.234395312495;38926.2214755709;38949.6105038946;39859.202815944096;37253.62746372502;37790.62209377981;38281.4257786139;38325.61674383332;38471.80764096162;36797.63202368049;37724.43413348747;37802.62197377991;37833.62166378301;38149;32893.35764211367;34104.65895341015;34378;34587.65412345945;34700.30599388049;25562;26150.86924565365;26332.605010925236;26383.868080659475;26655 10:09:27 INFO - PROCESS | 10848 | |2;jquery.html;381.8243607940347;385.7704665723895;387.55818367061545;398.7089424719953;401.76295985368625;14074.366653500592;14771.778423323658;15868.127253001096;17951.73072403915;17988.740788144834;14230.71538569228;15925.601859953478;17368.56578585536;17399.3040278389;17531.73702394462;4633.351330813689;4823.903521929559;4852.4419691735375;4857.392825896763;4860.1980673189055;3524.2775231077567;4753.762311884409;5170.276161337416;5441.782328706847;5470.206820011116;5550.195221692852;5552.056150454432;5564.527015203713;5572.080606699889;5572.554195664337;5361.490658387447;5479.75341109651;5512.724363781815;5541.833744987657;5550.555955523549;5300.084953275683;5301.416844147141;5335.466453354672;5355.464453554613;5359.22291267764;12534.74930501394;12791.744165116646;12923.22460652364;12930.54743083997;12934;1737.6785294720517;1788.9105544722843;1822.8268314510233;1841.3279153109152;1959.931402400909;9177.449353038839;9685;9876.60493580256;11231.21381503295;13086.607401777961;1740.651869626067;1796.6765982123213;1812.646533925885;1814.528222662104;1827.0408035781188;66650.3334966649;70251.31385588693;71223;71344.6432767838;73128.26871731321;10176.949115254525;10349.586016559404;10373.325733827278;10525.36847789135;10539.419087136837;14134.929325353512;14271.286435678383;14339.426422943174;14369.928150359181;14373.6406589834;6797.490188235902;6980.371766541036;7069.257727938595;7140.5358651687475;7160.749373771893;6477.352264773485;6521.119648847345;6647.86704265912;6651.102101216371;6662;4289.935650965238;4341.479022517318;4370.060437006059;4480.193565158303;4519.141363140992;1791.4715159028117;1825.561865152354;1843.271907596492;1875.3061367294188;1917.8945158016163;846.272205902923;882.8057827278117;906.5784410249265;922.9030951749969;929.5073610986188;15967.201639917957;16375.918120409322;16623.08573028495;16806.57983550421;17000.744988825176;812.7236739508595;820.7619790260758;826.2192228344277;834.7579202031343;848.9957550212209;9165;9373.718788436357;9694.321397502106;9745.540856574435;9813.852792208123;370711.05897621374;379763;381487;383257;385752;77693;81077.18922810814;82477;82836.17163828405;83706.58146709349;918.5040078357612;918.5131880103556;923.4551614547449;941.5057095025167;944.2634744898852;14825.703485930437;14938.701225975637;15143.856143856145;15155.090694558361;15216.391344346102;34939.30121397507;35352;36006.459903102;36112.27775444529;36967.260654786216;48897.266541002624;49428.752856235486;49617;50434.49565504298;50892;6371.13989611415;6983.580985140908;7554.886676699964;7693.1922148173635;7818.882716759139;10021.298509104292;10664.680059598224;11002.449877505933;11383.772324553629;12084.45619947087;9069;9198.95400522993;9253.306002049738;9268.53657317145;9646.18007469345;9806.411615303105;9892.15916647093;9956.651517196864;10011.649592264235;10280.794384112425;8841.734747957571;9279.907200927904;9464.95267523658;9523.809523809623;9638.855417168608;7047.119110111236;7088.893666594902;7092.893606595802;7160.606166660884;7186.964065179641;7074;9009.954950225207;9322.766930826783;9717.757056073371;10002.399856008662 10:09:27 INFO - PROCESS | 10848 | |3;mootools.html;1250.7623551525214;1428.028940320582;1430.063308532911;1587.2777886061835;1786.9814205902633;6472.611643301405;7532.246775322472;7829.804254893624;7839.412044096687;8067.91932080679;7887.171846956073;7910.485818421813;7953.880691789628;7963.243491868263;7972.242636949481;2234.195689551764;2271.659251112338;2272.556851413967;2275.3628983884455;2275.8748268845206;2232.8771917544527;2257.7064981552376;2271.250487339174;2275.72691277047;2277.430642339415;2227.376334626299;2227.543353612514;2229.8996545155505;2233.229535810143;2264.083046366224;2150.9139634414605;2165.631842586756;2170.913163473459;2173.2502286711137;2173.739151301838;2110.461832232771;2114.4608124928045;2117.735283089614;2118.5127420693175;2118.5233322502468;7598.202188770155;7778.611069446505;7836.647350869168;7838.608069596497;7842.960785196095;4611.354410382549;4825.227963525819;4827.565519103297;4830.782614782343;4837.177679794443;2923.2107331020716;3038.3315670552442;3082.553029810665;3088.197068762138;3093.1184612385587;930.3952430919957;940.722486866376;958.942463452195;975.5268694683073;993.8310487217191;10288.33125846825;10362.533685984074;10369.429681367521;10369.792604147875;10375.221858360654;4105.548389677133;4137.745466866676;4156.45966024421;4215.59951804578;4226.661867050629;8294.502329860228;8318.750437486886;8328.042275138436;8335.333173346238;8338.791530211673;4581.839635612738;4622.237330840441;4704.411948506437;4707.599854012447;4709.128811169876;3735.7571757835653;4166.604172603597;4327.069680018748;4348.565143485626;4356;3407.931841363159;3437.3125374925116;3468.063622821824;3491.790492570454;3535.0808789714347;1050.7110544600296;1053.594366169015;1057.613970900631;1066.568039943824;1069.4599227390117;634.0552576660834;685.4310921934782;901.3600343756007;905.515549181198;931.6552875436132;5247.396549396792;5280.128778751463;5325.520703136736;5464.316960379952;5585.162225666182;840.7898025493627;862;865.9956700216459;927.888653361601;930.5672862119147;3470.5488286523096;3638.8180590970346;3648.179159689049;3658.579263384745;3738.2897249522503;9553.90446095544;9826.901730982741;9883.703488895344;9890.20878329732;9912.405255684682;9515.666951656658;9611.855822162674;9701.660441884642;9739.610415583298;9743.317967742332;7460.179380268166;7581.583012934341;7603.619819009027;7626.58053807046;7630.046244219473;4970.701757894538;5121.103806833715;5144.382674079135;5256.947430525645;5325.866853328543;8944.195022448012;9134.680286189952;9234.95382523083;9244.907550924405;9247.167754901822;9225.21585665226;9257.166854983085;9258.074192580689;9356.06439356059;9367.484788336435;6727.192736871411;7075.973983772221;7083.291670832876;7084.504084714021;7084.64576771149;7439;7534.284242996907;7539.321461068311;7542.170361260367;7546.3962882968135;5197.610179236497;6647.6676166192465;6694.196696396463;6725.49558783103;6946.826329341807;6617.8014659560295;6626.668666566556;6850.862982740417;6851.143607049119;6884.965575172092;6335.3981371769605;6395.744170233139;6447.387498187664;6467.611943283418;6480.546361754632;4679;4748.121597504472;4762.666613337033;4778.689385189951;4785.760711964457;4680.180968330596;4779.115863565252;4832.903341933212;4844.297576851407;4874.805007799649 10:09:27 INFO - PROCESS | 10848 | |4;prototype.html;304.36387949186195;308.0865234579471;308.270939228724;309.1529209964697;313.4170442976064;4874.805007799689;4877.341558889549;4886.8778280543;4896.681715688478;4932.358793356868;4851.490593487686;4863.951360486394;4872.683275587093;4872.7563621818945;4900.632452566063;3679.8344074516644;3760.52993375828;3771.377722675755;3774.188549461865;3807.8286477108595;3722.4416337549314;3747.775133491986;3871.4192871069286;3874.767513949172;3889.8249578769023;3767.585565587783;3817.351050321438;3827.9425808612755;3833.195029043904;3842.1739326044894;3663.725220608465;3836.827342769582;3840.2127563849344;3855.8457661693637;3857.4792403025795;3371.5954085509898;3392.677695618937;3401.9489707654407;3405.3019131078067;3405.3700065487965;4624.745638989854;4650.534946505356;4670.416197975253;4675.625949923998;4702.153612349775;4362;4362.541933097011;4364.192624364503;4399.912001759979;4399.978000109979;4954.455009948939;5083.517065878736;5108.361454818148;5112.772934495694;5121.385433747974;3713.535808023997;3720.4791329213663;3736.831842567091;3745.62543745626;3757.4551690004796;5309.840704778824;5399.811006614749;5411.83764487066;5414;5425.701586412746;3720.162963333228;3851.614838516126;3864.381698928158;3875.399313106473;3888.358420860583;3897.162110146332;3902.1415288636454;3902.726809123391;3913.1391093959282;3922.9793059344147;4367.31858234582;4388.144311859221;4390.53899340571;4390.978045109754;4405.361222622766;4974.477679843637;5066.847994560169;5098.515641014098;5118.692878427306;5120.61595380348;1329.3021163888843;1342.5301144599312;1345.3788185236767;1355.9694632079493;1356.220173400279;847.7922908887363;861.7414775567305;862.4394143806576;874.6807415293499;877.9868301975475;4370.519242883281;4452.977735111303;4458.264386376211;4459.130469558405;4462.44219472566;5201.713905735145;5231.319928409359;5234.895302093937;5235.947640523546;5241.13521268994;4488.483824360175;4513.435820522434;4518.344839998182;4518.502964673883;4519.276915693474;2614.516314481827;2778.0693467688147;2780.5968134620366;2791.5812628105946;2814.5074611942828;4930;4941.654084214142;4950.925736113961;4951.257311403247;4970.564423432492;5225.895482090337;5317.255584218213;5353.598480114007;5355.464453554613;5379.924015196976;4945.2582112683385;4952.702837829742;4965.627577931669;4969.211084009826;4981.501849814989;5254;5263.868403289795;5279.551238144801;5290.7354632269;5297.337832770903;4965.889496963849;5213.348331458567;5222.97388513055;5226.790928362823;5266.499682530153;4975.527324904128;5035.7985680572365;5041.521055499722;5046.394432668103;5069.518395752398;3745.382011967995;3765.2657731742047;3767.171222331083;3776.4524143999515;3800.277947190025;5054.573804573752;5335.67985920846;5360.597955153457;5360.812371566976;5362.436944120811;5080.695158290514;5106.812413820631;5108.182690769608;5158.174692049254;5166.767495462788;5074.695518268915;5080.644354895269;5111.718855462986;5116.616253781056;5134.383873935151;4896.608271338356;5056.873578160428;5063.392392912874;5063.772130254221;5079.187330027178;4909.410870695539;4970.478099799469;5105.591552675852;5136.512031357015;5140.845774626767;5026.597872170145;5028.798848046037;5032.3961124665275;5033.936086204639;5046.899062018812 10:09:27 INFO - PROCESS | 10848 | |5;yui.html;704.9883417296177;730.5069078372098;738.7008261654032;747.4805010517692;779.2713812585233;11381.089512838973;12119.27284362939;12139.57511487098;12143.57497487587;12206.084543659228;11889.108316876225;11911.58309459167;11919.880801191985;11929.22460040099;11934.7613047739;606.3663471672113;756.6141267953356;779.4738551477758;780.7462574663228;781.9609019549029;789.0176729971193;793.0641842625699;793.4168386236112;793.7936136604495;794.9244821741926;828.9171082891722;835.419383528448;836.8912041434636;837.1419295222415;837.6272558711346;640.6828619833166;812.959352032396;827.5365795154703;828.0642873552907;828.9958550207241;598.6198763784985;599.6252342286072;599.8290487211168;600.066895976756;601.6480358989996;12142.817857732052;12172.756544869142;12189.207701499374;12190.39048047603;12209.084318676134;12828.486860525567;13239.470421183141;13476.730465390736;13501.189928604315;13511.365283769668;9416.1525462708;9883.258755593288;10072.597096116147;10341.121004714609;10467.528961196764;4226.873193804191;4227.281362168439;4231.97884010581;4359.10638319147;4403.185410699031;47118;47902.52097479015;47928.52071479276;47974.52025479735;48363.75818120887;10553.47232638365;10573.687249845627;10602.204834637432;10650.082985062763;10674.946625266979;18204.36284730028;18257.726134107997;18289.359872404402;18308.725369119475;18311.35910243135;6625.933740662628;6691.79924602253;6796.422304104207;6908.447324214051;7060.752873649398;3666.816659167031;3676.117731744362;3690.7970061646865;3740.60723624021;3764.3036038333;2864.6848846626854;2941.058861164407;2969.079585328555;2974.8215107093642;2985.626796650419;498.8902441462872;502.5527280720162;508.4864287070012;512.1089304610026;513.9640225184202;475.46747642640463;585.4759989809097;598.5361344957693;609.6860117039728;610.0818268505959;7389.261073892675;7481.289277518627;7509.324160825443;7531.397488200931;7738.342240909473;578.8581797459649;589.8820235952827;591.4913174669781;606.7845914700218;609.326694003129;3554.6267641897743;3629.2015756534047;3663.9816800915823;3732.8320225589914;3751.5873253942045;53784.73107634437;56470.152947705814;56690;56757.71621141868;56849.43150568524;49055.26417103747;49600.751996239786;49903.75048124736;50682.74658626757;50907.745461273196;46254.306185407244;46388.536114638424;46503.76748116238;46838.063238735034;46965.76517117392;7591.772246832604;7594.848103038019;7696.7306144284685;7741.612919354123;7742.070951485633;30201.697983019887;31310;32250.677493224768;32274.838625806722;32491.18772030718;41509.37735933903;42034.78982605068;42106.578934210265;42406.36390454084;43423.13153736844;10281.691549253534;10422.478876056015;10547.52536135891;10644.414557199429;11250.887491124984;11758.941205293919;12071;12113.69715757113;12178.147529672839;12237.938810305892;10197.490125493843;10310.278280520291;10387.792244154924;10581.62964296246;10583.576656933636;10209.018482791866;10333.586656533655;10385.324953877975;10515.631952881613;10692.465376730977;10730.785384292427;10800.783984320113;10918.890811091787;11174.329540227613;11301.604443844426;8587.22714955657;8723.171298726611;8782.648694052166;9091.59087841062;9218.631254750004;8444.366672499464;8956.731298061068;8972.102789720975;9185.678501252423;9284.932232793046 10:09:27 INFO - PROCESS | 10848 | __end_tp_report 10:09:27 INFO - PROCESS | 10848 | __start_cc_report 10:09:27 INFO - PROCESS | 10848 | _x_x_mozilla_cycle_collect,911 10:09:27 INFO - PROCESS | 10848 | __end_cc_report 10:09:27 INFO - PROCESS | 10848 | __startTimestamp1464368967071__endTimestamp 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | ------- Summary: start ------- 10:09:27 INFO - PROCESS | 10848 | Number of tests: 6 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#0] dojo.html Cycles:165 Average:4775.89 Median:4896.41 stddev:501.52 (10.2%) stddev-sans-first:475.79 10:09:27 INFO - PROCESS | 10848 | Values: 2696.2 2702.0 2718.3 2734.5 2760.1 4611.1 4710.2 4774.8 4818.1 4851.1 4764.9 4812.1 4812.4 4813.7 4825.8 4383.1 4416.6 4467.7 4524.9 4559.8 4466.7 4498.1 4517.0 4517.7 4552.8 4343.8 4398.8 4436.0 4495.6 4510.8 4369.7 4374.9 4387.0 4487.1 4496.8 4413.6 4415.6 4419.3 4428.5 4480.3 4621.3 4624.2 4675.0 4707.1 4787.8 5205.0 5206.7 5206.9 5217.7 5222.2 5232.4 5242.5 5245.5 5262.7 5264.3 4714.1 4839.2 4870.1 4886.3 4893.5 5356.4 5366.3 5379.1 5391.6 5392.7 5152.7 5160.5 5168.8 5173.1 5175.1 5041.5 5131.8 5206.0 5207.3 5239.1 5138.7 5174.3 5176.0 5188.8 5245.7 5022.4 5172.7 5183.5 5187.1 5187.9 4309.1 4337.6 4394.0 4402.5 4406.5 3815.4 3818.6 3831.2 3894.9 3905.6 4426.3 4427.6 4433.2 4436.4 4479.4 4980.3 5077.9 5206.2 5214.5 5217.1 4381.7 4419.1 4437.7 4459.8 4492.3 4636.6 4638.1 4641.7 4645.6 4686.9 4877.5 4882.1 4896.9 4898.8 4932.6 5056.2 5114.0 5122.1 5175.5 5191.4 4865.7 4896.4 4897.3 4908.5 4955.7 5114.4 5118.5 5123.1 5130.6 5134.1 4985.2 5107.6 5160.4 5166.4 5188.2 4998.4 5025.6 5032.4 5039.3 5099.3 4869.2 5033.3 5053.4 5059.8 5060.5 4883.4 4917.2 4922.7 4980.2 4981.4 5027.0 5037.4 5043.5 5044.8 5086.1 4835.3 4882.7 4897.6 4949.9 4997.9 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#1] ext.html Cycles:180 Average:46374.27 Median:34482.83 stddev:81770.98 (237.1%) stddev-sans-first:81927.98 10:09:27 INFO - PROCESS | 10848 | Values: 548.5 590.1 599.2 599.2 620.9 30274.8 44348.3 45104.0 45221.0 45351.3 42465.4 43183.6 43246.1 43391.3 43460.8 7449.6 7822.5 7993.3 10073.1 10344.2 10206.7 10327.4 10350.9 10357.2 10357.7 10338.4 10421.7 10422.7 10440.3 10443.7 7523.5 10055.8 10402.4 10407.1 10695.0 10265.6 10293.9 10341.6 10350.9 10365.7 38820.6 39189.4 39281.2 39361.6 39385.2 2957.8 3000.5 3059.9 3088.0 3434.2 29844.7 30259.5 30553.7 30777.5 32018.4 3403.7 3553.6 3553.7 3569.7 3591.5 251133.0 252006.0 252113.0 252439.0 253730.7 29242.1 56210.7 57014.4 57030.4 57050.7 34789.7 34919.0 34920.7 34937.0 34964.1 10907.0 11773.8 11871.8 11874.3 11875.1 9575.3 9941.0 9952.1 10160.5 10170.5 7963.2 8045.6 8047.8 8087.0 8128.3 3124.8 3163.8 3164.1 3179.6 3191.8 822.3 835.8 955.4 981.6 1005.6 27517.7 28971.9 29106.7 29147.7 29209.6 930.7 939.9 956.9 968.5 1009.3 15020.3 15275.8 15324.2 15362.6 15620.1 380116.0 380448.0 384343.0 384371.0 386345.0 52587.7 53303.2 53304.5 53338.5 53380.7 1044.4 1162.0 1164.1 1182.1 1185.9 28492.9 30061.4 30118.5 30233.2 30674.1 44456.3 44542.3 44835.8 44957.3 45034.1 281499.0 281991.0 282126.0 282732.0 283003.0 22729.8 25252.0 26304.7 26421.2 27595.6 43586.0 43643.8 45172.8 45302.0 48548.8 38163.4 38280.2 38926.2 38949.6 39859.2 37253.6 37790.6 38281.4 38325.6 38471.8 36797.6 37724.4 37802.6 37833.6 38149.0 32893.4 34104.7 34378.0 34587.7 34700.3 25562.0 26150.9 26332.6 26383.9 26655.0 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#2] jquery.html Cycles:180 Average:23766.86 Median:50663.25 stddev:63026.58 (124.4%) stddev-sans-first:63178.93 10:09:27 INFO - PROCESS | 10848 | Values: 381.8 385.8 387.6 398.7 401.8 14074.4 14771.8 15868.1 17951.7 17988.7 14230.7 15925.6 17368.6 17399.3 17531.7 4633.4 4823.9 4852.4 4857.4 4860.2 3524.3 4753.8 5170.3 5441.8 5470.2 5550.2 5552.1 5564.5 5572.1 5572.6 5361.5 5479.8 5512.7 5541.8 5550.6 5300.1 5301.4 5335.5 5355.5 5359.2 12534.7 12791.7 12923.2 12930.5 12934.0 1737.7 1788.9 1822.8 1841.3 1959.9 9177.4 9685.0 9876.6 11231.2 13086.6 1740.7 1796.7 1812.6 1814.5 1827.0 66650.3 70251.3 71223.0 71344.6 73128.3 10176.9 10349.6 10373.3 10525.4 10539.4 14134.9 14271.3 14339.4 14369.9 14373.6 6797.5 6980.4 7069.3 7140.5 7160.7 6477.4 6521.1 6647.9 6651.1 6662.0 4289.9 4341.5 4370.1 4480.2 4519.1 1791.5 1825.6 1843.3 1875.3 1917.9 846.3 882.8 906.6 922.9 929.5 15967.2 16375.9 16623.1 16806.6 17000.7 812.7 820.8 826.2 834.8 849.0 9165.0 9373.7 9694.3 9745.5 9813.9 370711.1 379763.0 381487.0 383257.0 385752.0 77693.0 81077.2 82477.0 82836.2 83706.6 918.5 918.5 923.5 941.5 944.3 14825.7 14938.7 15143.9 15155.1 15216.4 34939.3 35352.0 36006.5 36112.3 36967.3 48897.3 49428.8 49617.0 50434.5 50892.0 6371.1 6983.6 7554.9 7693.2 7818.9 10021.3 10664.7 11002.4 11383.8 12084.5 9069.0 9199.0 9253.3 9268.5 9646.2 9806.4 9892.2 9956.7 10011.6 10280.8 8841.7 9279.9 9465.0 9523.8 9638.9 7047.1 7088.9 7092.9 7160.6 7187.0 7074.0 9010.0 9322.8 9717.8 10002.4 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#3] mootools.html Cycles:180 Average:5164.61 Median:5268.54 stddev:2869.88 (54.5%) stddev-sans-first:2862.86 10:09:27 INFO - PROCESS | 10848 | Values: 1250.8 1428.0 1430.1 1587.3 1787.0 6472.6 7532.2 7829.8 7839.4 8067.9 7887.2 7910.5 7953.9 7963.2 7972.2 2234.2 2271.7 2272.6 2275.4 2275.9 2232.9 2257.7 2271.3 2275.7 2277.4 2227.4 2227.5 2229.9 2233.2 2264.1 2150.9 2165.6 2170.9 2173.3 2173.7 2110.5 2114.5 2117.7 2118.5 2118.5 7598.2 7778.6 7836.6 7838.6 7843.0 4611.4 4825.2 4827.6 4830.8 4837.2 2923.2 3038.3 3082.6 3088.2 3093.1 930.4 940.7 958.9 975.5 993.8 10288.3 10362.5 10369.4 10369.8 10375.2 4105.5 4137.7 4156.5 4215.6 4226.7 8294.5 8318.8 8328.0 8335.3 8338.8 4581.8 4622.2 4704.4 4707.6 4709.1 3735.8 4166.6 4327.1 4348.6 4356.0 3407.9 3437.3 3468.1 3491.8 3535.1 1050.7 1053.6 1057.6 1066.6 1069.5 634.1 685.4 901.4 905.5 931.7 5247.4 5280.1 5325.5 5464.3 5585.2 840.8 862.0 866.0 927.9 930.6 3470.5 3638.8 3648.2 3658.6 3738.3 9553.9 9826.9 9883.7 9890.2 9912.4 9515.7 9611.9 9701.7 9739.6 9743.3 7460.2 7581.6 7603.6 7626.6 7630.0 4970.7 5121.1 5144.4 5256.9 5325.9 8944.2 9134.7 9235.0 9244.9 9247.2 9225.2 9257.2 9258.1 9356.1 9367.5 6727.2 7076.0 7083.3 7084.5 7084.6 7439.0 7534.3 7539.3 7542.2 7546.4 5197.6 6647.7 6694.2 6725.5 6946.8 6617.8 6626.7 6850.9 6851.1 6885.0 6335.4 6395.7 6447.4 6467.6 6480.5 4679.0 4748.1 4762.7 4778.7 4785.8 4680.2 4779.1 4832.9 4844.3 4874.8 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#4] prototype.html Cycles:180 Average:4261.77 Median:4882.11 stddev:1227.41 (25.1%) stddev-sans-first:1194.37 10:09:27 INFO - PROCESS | 10848 | Values: 304.4 308.1 308.3 309.2 313.4 4874.8 4877.3 4886.9 4896.7 4932.4 4851.5 4864.0 4872.7 4872.8 4900.6 3679.8 3760.5 3771.4 3774.2 3807.8 3722.4 3747.8 3871.4 3874.8 3889.8 3767.6 3817.4 3827.9 3833.2 3842.2 3663.7 3836.8 3840.2 3855.8 3857.5 3371.6 3392.7 3401.9 3405.3 3405.4 4624.7 4650.5 4670.4 4675.6 4702.2 4362.0 4362.5 4364.2 4399.9 4400.0 4954.5 5083.5 5108.4 5112.8 5121.4 3713.5 3720.5 3736.8 3745.6 3757.5 5309.8 5399.8 5411.8 5414.0 5425.7 3720.2 3851.6 3864.4 3875.4 3888.4 3897.2 3902.1 3902.7 3913.1 3923.0 4367.3 4388.1 4390.5 4391.0 4405.4 4974.5 5066.8 5098.5 5118.7 5120.6 1329.3 1342.5 1345.4 1356.0 1356.2 847.8 861.7 862.4 874.7 878.0 4370.5 4453.0 4458.3 4459.1 4462.4 5201.7 5231.3 5234.9 5235.9 5241.1 4488.5 4513.4 4518.3 4518.5 4519.3 2614.5 2778.1 2780.6 2791.6 2814.5 4930.0 4941.7 4950.9 4951.3 4970.6 5225.9 5317.3 5353.6 5355.5 5379.9 4945.3 4952.7 4965.6 4969.2 4981.5 5254.0 5263.9 5279.6 5290.7 5297.3 4965.9 5213.3 5223.0 5226.8 5266.5 4975.5 5035.8 5041.5 5046.4 5069.5 3745.4 3765.3 3767.2 3776.5 3800.3 5054.6 5335.7 5360.6 5360.8 5362.4 5080.7 5106.8 5108.2 5158.2 5166.8 5074.7 5080.6 5111.7 5116.6 5134.4 4896.6 5056.9 5063.4 5063.8 5079.2 4909.4 4970.5 5105.6 5136.5 5140.8 5026.6 5028.8 5032.4 5033.9 5046.9 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - PROCESS | 10848 | [#5] yui.html Cycles:180 Average:13280.55 Median:46670.92 stddev:15585.77 (33.4%) stddev-sans-first:15600.88 10:09:27 INFO - PROCESS | 10848 | Values: 705.0 730.5 738.7 747.5 779.3 11381.1 12119.3 12139.6 12143.6 12206.1 11889.1 11911.6 11919.9 11929.2 11934.8 606.4 756.6 779.5 780.7 782.0 789.0 793.1 793.4 793.8 794.9 828.9 835.4 836.9 837.1 837.6 640.7 813.0 827.5 828.1 829.0 598.6 599.6 599.8 600.1 601.6 12142.8 12172.8 12189.2 12190.4 12209.1 12828.5 13239.5 13476.7 13501.2 13511.4 9416.2 9883.3 10072.6 10341.1 10467.5 4226.9 4227.3 4232.0 4359.1 4403.2 47118.0 47902.5 47928.5 47974.5 48363.8 10553.5 10573.7 10602.2 10650.1 10674.9 18204.4 18257.7 18289.4 18308.7 18311.4 6625.9 6691.8 6796.4 6908.4 7060.8 3666.8 3676.1 3690.8 3740.6 3764.3 2864.7 2941.1 2969.1 2974.8 2985.6 498.9 502.6 508.5 512.1 514.0 475.5 585.5 598.5 609.7 610.1 7389.3 7481.3 7509.3 7531.4 7738.3 578.9 589.9 591.5 606.8 609.3 3554.6 3629.2 3664.0 3732.8 3751.6 53784.7 56470.2 56690.0 56757.7 56849.4 49055.3 49600.8 49903.8 50682.7 50907.7 46254.3 46388.5 46503.8 46838.1 46965.8 7591.8 7594.8 7696.7 7741.6 7742.1 30201.7 31310.0 32250.7 32274.8 32491.2 41509.4 42034.8 42106.6 42406.4 43423.1 10281.7 10422.5 10547.5 10644.4 11250.9 11758.9 12071.0 12113.7 12178.1 12237.9 10197.5 10310.3 10387.8 10581.6 10583.6 10209.0 10333.6 10385.3 10515.6 10692.5 10730.8 10800.8 10918.9 11174.3 11301.6 8587.2 8723.2 8782.6 9091.6 9218.6 8444.4 8956.7 8972.1 9185.7 9284.9 10:09:27 INFO - PROCESS | 10848 | -------- Summary: end -------- 10:09:27 INFO - PROCESS | 10848 | 10:09:27 INFO - TEST-INFO | 10848: exit 0 10:09:27 INFO - TEST-OK | dromaeo_css | took 1119284ms 10:09:27 INFO - TEST-START | kraken 10:09:27 INFO - operating with platform_type : linux_ 10:09:27 INFO - Initialising browser for kraken test... 10:09:27 INFO - TEST-INFO | started process 11028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1c5pb/profile http://localhost:50324/getInfo.html) 10:09:32 INFO - PROCESS | 11028 | __metrics Screen width/height:1600/1200 10:09:32 INFO - PROCESS | 11028 | colorDepth:24 10:09:32 INFO - PROCESS | 11028 | Browser inner width/height: 1024/697 10:09:32 INFO - PROCESS | 11028 | __metrics 10:09:32 ERROR - PROCESS | 11028 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:09:33 INFO - TEST-INFO | 11028: exit 0 10:09:33 INFO - Browser initialized. 10:09:33 INFO - Running cycle 1/1 for kraken test... 10:09:33 INFO - TEST-INFO | started process 11109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg1c5pb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:45 INFO - PROCESS | 11109 | RSS: Main: 157679616 10:09:45 INFO - PROCESS | 11109 | 10:09:48 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:49 INFO - PROCESS | 11109 | RSS: Main: 215601152 10:09:49 INFO - PROCESS | 11109 | 10:09:52 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-dft) 10:09:52 INFO - PROCESS | 11109 | RSS: Main: 204926976 10:09:52 INFO - PROCESS | 11109 | 10:09:56 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-fft) 10:09:56 INFO - PROCESS | 11109 | RSS: Main: 270348288 10:09:56 INFO - PROCESS | 11109 | 10:09:58 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50324/tests/kraken/driver.html?testName=audio-oscillator) 10:09:59 INFO - PROCESS | 11109 | RSS: Main: 180858880 10:09:59 INFO - PROCESS | 11109 | 10:10:01 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:02 INFO - PROCESS | 11109 | RSS: Main: 185651200 10:10:02 INFO - PROCESS | 11109 | 10:10:05 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:06 INFO - PROCESS | 11109 | RSS: Main: 221057024 10:10:06 INFO - PROCESS | 11109 | 10:10:09 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50324/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:10 INFO - PROCESS | 11109 | RSS: Main: 221368320 10:10:10 INFO - PROCESS | 11109 | 10:10:13 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50324/tests/kraken/driver.html?testName=json-parse-financial) 10:10:13 INFO - PROCESS | 11109 | RSS: Main: 221589504 10:10:13 INFO - PROCESS | 11109 | 10:10:15 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:16 INFO - PROCESS | 11109 | RSS: Main: 210247680 10:10:16 INFO - PROCESS | 11109 | 10:10:18 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:18 INFO - PROCESS | 11109 | RSS: Main: 211570688 10:10:18 INFO - PROCESS | 11109 | 10:10:20 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:21 INFO - PROCESS | 11109 | RSS: Main: 216911872 10:10:21 INFO - PROCESS | 11109 | 10:10:24 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:24 INFO - PROCESS | 11109 | RSS: Main: 223420416 10:10:24 INFO - PROCESS | 11109 | 10:10:27 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:28 INFO - PROCESS | 11109 | RSS: Main: 223748096 10:10:28 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | Cycle 1(1): loaded http://localhost:50324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50324/tests/kraken/driver.html?testName=ai-astar) 10:10:30 INFO - PROCESS | 11109 | RSS: Main: 266870784 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | __start_tp_report 10:10:30 INFO - PROCESS | 11109 | _x_x_mozilla_page_load 10:10:30 INFO - PROCESS | 11109 | _x_x_mozilla_page_load_details 10:10:30 INFO - PROCESS | 11109 | |i|pagename|runs| 10:10:30 INFO - PROCESS | 11109 | |0;ai-astar;115;108;113;113;112;113;113;113;113;114 10:10:30 INFO - PROCESS | 11109 | |1;audio-beat-detection;163;129;136;190;139;133;157;132;161;136 10:10:30 INFO - PROCESS | 11109 | |2;audio-dft;161;161;162;161;162;163;162;161;162;162 10:10:30 INFO - PROCESS | 11109 | |3;audio-fft;75;75;75;109;76;78;77;75;100;75 10:10:30 INFO - PROCESS | 11109 | |4;audio-oscillator;84;84;114;84;86;86;124;84;84;142 10:10:30 INFO - PROCESS | 11109 | |5;imaging-gaussian-blur;117;116;116;117;117;117;116;117;117;117 10:10:30 INFO - PROCESS | 11109 | |6;imaging-darkroom;146;147;145;146;146;145;145;145;145;146 10:10:30 INFO - PROCESS | 11109 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;94;95 10:10:30 INFO - PROCESS | 11109 | |8;json-parse-financial;63;63;63;64;65;63;63;65;64;63 10:10:30 INFO - PROCESS | 11109 | |9;json-stringify-tinderbox;65;65;64;72;64;65;64;64;65;65 10:10:30 INFO - PROCESS | 11109 | |10;stanford-crypto-aes;82;84;83;82;90;84;90;84;126;84 10:10:30 INFO - PROCESS | 11109 | |11;stanford-crypto-ccm;132;131;129;135;137;141;139;138;134;131 10:10:30 INFO - PROCESS | 11109 | |12;stanford-crypto-pbkdf2;173;173;169;169;170;169;168;171;166;168 10:10:30 INFO - PROCESS | 11109 | |13;stanford-crypto-sha256-iterative;66;70;67;65;72;65;67;66;66;64 10:10:30 INFO - PROCESS | 11109 | __end_tp_report 10:10:30 INFO - PROCESS | 11109 | __start_cc_report 10:10:30 INFO - PROCESS | 11109 | _x_x_mozilla_cycle_collect,1857 10:10:30 INFO - PROCESS | 11109 | __end_cc_report 10:10:30 INFO - PROCESS | 11109 | __startTimestamp1464369030477__endTimestamp 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | ------- Summary: start ------- 10:10:30 INFO - PROCESS | 11109 | Number of tests: 14 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.83 (1.6%) stddev-sans-first:1.74 10:10:30 INFO - PROCESS | 11109 | Values: 115.0 108.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 114.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:148.00 stddev:19.57 (13.2%) stddev-sans-first:19.95 10:10:30 INFO - PROCESS | 11109 | Values: 163.0 129.0 136.0 190.0 139.0 133.0 157.0 132.0 161.0 136.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 10:10:30 INFO - PROCESS | 11109 | Values: 161.0 161.0 162.0 161.0 162.0 163.0 162.0 161.0 162.0 162.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:12.35 (16.5%) stddev-sans-first:12.87 10:10:30 INFO - PROCESS | 11109 | Values: 75.0 75.0 75.0 109.0 76.0 78.0 77.0 75.0 100.0 75.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:84.00 stddev:21.42 (25.5%) stddev-sans-first:22.18 10:10:30 INFO - PROCESS | 11109 | Values: 84.0 84.0 114.0 84.0 86.0 86.0 124.0 84.0 84.0 142.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:10:30 INFO - PROCESS | 11109 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:10:30 INFO - PROCESS | 11109 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:10:30 INFO - PROCESS | 11109 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 10:10:30 INFO - PROCESS | 11109 | Values: 63.0 63.0 63.0 64.0 65.0 63.0 63.0 65.0 64.0 63.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 10:10:30 INFO - PROCESS | 11109 | Values: 65.0 65.0 64.0 72.0 64.0 65.0 64.0 64.0 65.0 65.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:84.00 stddev:13.35 (15.9%) stddev-sans-first:13.93 10:10:30 INFO - PROCESS | 11109 | Values: 82.0 84.0 83.0 82.0 90.0 84.0 90.0 84.0 126.0 84.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:136.00 stddev:3.97 (2.9%) stddev-sans-first:4.09 10:10:30 INFO - PROCESS | 11109 | Values: 132.0 131.0 129.0 135.0 137.0 141.0 139.0 138.0 134.0 131.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:2.22 (1.3%) stddev-sans-first:1.99 10:10:30 INFO - PROCESS | 11109 | Values: 173.0 173.0 169.0 169.0 170.0 169.0 168.0 171.0 166.0 168.0 10:10:30 INFO - PROCESS | 11109 | 10:10:30 INFO - PROCESS | 11109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.44 (3.7%) stddev-sans-first:2.57 10:10:30 INFO - PROCESS | 11109 | Values: 66.0 70.0 67.0 65.0 72.0 65.0 67.0 66.0 66.0 64.0 10:10:30 INFO - PROCESS | 11109 | -------- Summary: end -------- 10:10:30 INFO - PROCESS | 11109 | 10:10:31 INFO - TEST-INFO | 11109: exit 0 10:10:31 INFO - TEST-OK | kraken | took 63608ms 10:10:31 INFO - SUITE-END | took 1182s 10:10:31 INFO - Completed test suite (00:19:43) 10:10:31 INFO - javascript benchmark 10:10:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2696.245051385612, 2702.0272701827353, 2718.320419895026, 2734.4667789780974, 2760.1443552498727, 4611.146937816507, 4710.2228132358205, 4774.809007639695, 4818.060478206751, 4851.126797176506, 4764.880877978052, 4812.061647978646, 4812.350332705084, 4813.711177329363, 4825.806967721296, 4383.079553293812, 4416.624586910117, 4467.664925130612, 4524.909501809978, 4559.817607295704, 4466.687331886769, 4498.055408364247, 4517.006258623114, 4517.661175411858, 4552.772361381918, 4343.847965321214, 4398.7580683062415, 4436.046250056221, 4495.595396414338, 4510.751908645023, 4369.6722745794195, 4374.868753937387, 4386.978065109686, 4487.102579484083, 4496.842610508649, 4413.58070983256, 4415.602595766364, 4419.292913133883, 4428.535003824616, 4480.260756975095, 4621.3299071634765, 4624.213883639789, 4674.953250467486, 4707.105649926503, 4787.80848766049, 5205.037068142368, 5206.713630750307, 5206.947930520684, 5217.660852044605, 5222.190560463135, 5232.424433312332, 5242.475752424765, 5245.475452454724, 5262.736863156827, 5264.263003179558, 4714.057188562301, 4839.249916262985, 4870.1233777920315, 4886.291487734258, 4893.486183950705, 5356.4107948125675, 5366.329208848894, 5379.058664733656, 5391.595630327741, 5392.676439413648, 5152.6650767699975, 5160.509751573594, 5168.819091331786, 5173.120569503193, 5175.146100893386, 5041.546260836542, 5131.846044618667, 5206.0, 5207.29701490294, 5239.056969745482, 5138.717370544581, 5174.275601415805, 5176.042432149989, 5188.792448302102, 5245.659032162897, 5022.42242142151, 5172.689638621695, 5183.481651834786, 5187.144121219956, 5187.896242075138, 4309.095090031066, 4337.566243375637, 4393.956060439418, 4402.471703395613, 4406.515283318832, 3815.3513902636064, 3818.59904710007, 3831.1954489557506, 3894.883153505399, 3905.5703872573995, 4426.26966550522, 4427.601515863587, 4433.246348120827, 4436.3567282743825, 4479.417675702203, 4980.302757613937, 5077.949220507748, 5206.245094461282, 5214.504622060898, 5217.139172036572, 4381.671374646914, 4419.0940857124215, 4437.733735975788, 4459.799309031101, 4492.326151077365, 4636.582707556337, 4638.1187574360765, 4641.698289611165, 4645.558671926162, 4686.929696054562, 4877.5366340197625, 4882.096812089775, 4896.877578060506, 4898.755062246944, 4932.580730637936, 5056.191009438472, 5114.028334616411, 5122.103631864335, 5175.534201921845, 5191.428942816212, 4865.7323847188745, 4896.4124305083615, 4897.314375987294, 4908.484609115992, 4955.677880937727, 5114.3862736471865, 5118.513741194581, 5123.077845987758, 5130.563902068366, 5134.05020071288, 4985.202367621163, 5107.6169287302855, 5160.432352441304, 5166.4058633257655, 5188.22176673502, 4998.425181104074, 5025.597952163891, 5032.3961124665275, 5039.319691841701, 5099.286099945936, 4869.245266983623, 5033.320501732219, 5053.444121146597, 5059.822906198266, 5060.51925067118, 4883.413990321184, 4917.188663870565, 4922.704637721748, 4980.203167493184, 4981.37732783402, 5027.0, 5037.445880953165, 5043.5460808527405, 5044.798208071636, 5086.135356989246, 4835.2505361669, 4882.707037577757, 4897.608191344612, 4949.9257511138085, 4997.85006449807], "value": 4744.142729679213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5118244762162, 590.1207201270107, 599.1761328173761, 599.1881001243313, 620.8634100497891, 30274.848625756895, 44348.334774978364, 45104.0, 45221.0, 45351.31973020407, 42465.36301955473, 43183.56816431835, 43246.13507729844, 43391.349129763075, 43460.78269608648, 7449.590272535009, 7822.452428330019, 7993.2806047455715, 10073.143782778472, 10344.172466202686, 10206.744831379237, 10327.380357178556, 10350.896491035106, 10357.223208259373, 10357.689269321932, 10338.431386273753, 10421.68734937953, 10422.687319380431, 10440.321379110372, 10443.73890652736, 7523.510971786844, 10055.849162262572, 10402.427866467342, 10407.115395191418, 10695.0, 10265.589376424934, 10293.897061029369, 10341.63804266847, 10350.896491035068, 10365.74085647865, 38820.611793882264, 39189.41215881764, 39281.21437571233, 39361.60638393608, 39385.21229575421, 2957.763378929702, 3000.5499175123687, 3059.938801223985, 3087.9536806947913, 3434.1733920879387, 29844.70155298441, 30259.546106808415, 30553.694463055308, 30777.53833692474, 32018.359632807445, 3403.694845932538, 3553.6091029986683, 3553.7157027437743, 3569.6787289144104, 3591.4612808078737, 251133.0, 252006.0, 252113.0, 252439.0, 253730.73134634394, 29242.122736317946, 56210.71894640501, 57014.42985570174, 57030.429695702514, 57050.714746426835, 34789.652103479144, 34919.0, 34920.65079349174, 34937.0, 34964.125896852274, 10907.0, 11773.76452470963, 11871.821922671166, 11874.287542747463, 11875.109366797353, 9575.329726919048, 9941.0, 9952.10431061208, 10160.54277557497, 10170.542325595366, 7963.203679631991, 8045.637946292431, 8047.83904321922, 8087.0, 8128.268455839003, 3124.765642576816, 3163.7943533670236, 3164.0666003529013, 3179.60254968129, 3191.7765756397293, 822.3421262989584, 835.8202986357962, 955.3980991975011, 981.6073570571829, 1005.5776573839005, 27517.724822751516, 28971.85514072416, 29106.708932910824, 29147.708522914923, 29209.561856572167, 930.7068273493828, 939.9295052870925, 956.8564715292623, 968.4867020479157, 1009.2783659683362, 15020.324085416183, 15275.770863437057, 15324.157171355682, 15362.615934601725, 15620.140892251035, 380116.0, 380448.0, 384343.0, 384371.0, 386345.0, 52587.73706131445, 53303.20045199325, 53304.466955330725, 53338.46661533335, 53380.73309633427, 1044.3525014491065, 1161.959331423413, 1164.057113737875, 1182.148852825964, 1185.851768528934, 28492.857535713018, 30061.398772024873, 30118.54822177625, 30233.244168895075, 30674.07977760671, 44456.33315500335, 44542.3318650227, 44835.77582112199, 44957.325640116076, 45034.0993180128, 281499.0, 281991.0, 282126.0, 282732.0, 283003.0, 22729.77270227343, 25252.0, 26304.736952630996, 26421.207363779118, 27595.586066209424, 43586.0, 43643.78178109089, 45172.77413612911, 45302.0, 48548.757256213496, 38163.42754858735, 38280.234395312495, 38926.2214755709, 38949.6105038946, 39859.202815944096, 37253.62746372502, 37790.62209377981, 38281.4257786139, 38325.61674383332, 38471.80764096162, 36797.63202368049, 37724.43413348747, 37802.62197377991, 37833.62166378301, 38149.0, 32893.35764211367, 34104.65895341015, 34378.0, 34587.65412345945, 34700.30599388049, 25562.0, 26150.86924565365, 26332.605010925236, 26383.868080659475, 26655.0], "value": 17287.457351131205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.8243607940347, 385.7704665723895, 387.55818367061545, 398.7089424719953, 401.76295985368625, 14074.366653500592, 14771.778423323658, 15868.127253001096, 17951.73072403915, 17988.740788144834, 14230.71538569228, 15925.601859953478, 17368.56578585536, 17399.3040278389, 17531.73702394462, 4633.351330813689, 4823.903521929559, 4852.4419691735375, 4857.392825896763, 4860.1980673189055, 3524.2775231077567, 4753.762311884409, 5170.276161337416, 5441.782328706847, 5470.206820011116, 5550.195221692852, 5552.056150454432, 5564.527015203713, 5572.080606699889, 5572.554195664337, 5361.490658387447, 5479.75341109651, 5512.724363781815, 5541.833744987657, 5550.555955523549, 5300.084953275683, 5301.416844147141, 5335.466453354672, 5355.464453554613, 5359.22291267764, 12534.74930501394, 12791.744165116646, 12923.22460652364, 12930.54743083997, 12934.0, 1737.6785294720517, 1788.9105544722843, 1822.8268314510233, 1841.3279153109152, 1959.931402400909, 9177.449353038839, 9685.0, 9876.60493580256, 11231.21381503295, 13086.607401777961, 1740.651869626067, 1796.6765982123213, 1812.646533925885, 1814.528222662104, 1827.0408035781188, 66650.3334966649, 70251.31385588693, 71223.0, 71344.6432767838, 73128.26871731321, 10176.949115254525, 10349.586016559404, 10373.325733827278, 10525.36847789135, 10539.419087136837, 14134.929325353512, 14271.286435678383, 14339.426422943174, 14369.928150359181, 14373.6406589834, 6797.490188235902, 6980.371766541036, 7069.257727938595, 7140.5358651687475, 7160.749373771893, 6477.352264773485, 6521.119648847345, 6647.86704265912, 6651.102101216371, 6662.0, 4289.935650965238, 4341.479022517318, 4370.060437006059, 4480.193565158303, 4519.141363140992, 1791.4715159028117, 1825.561865152354, 1843.271907596492, 1875.3061367294188, 1917.8945158016163, 846.272205902923, 882.8057827278117, 906.5784410249265, 922.9030951749969, 929.5073610986188, 15967.201639917957, 16375.918120409322, 16623.08573028495, 16806.57983550421, 17000.744988825176, 812.7236739508595, 820.7619790260758, 826.2192228344277, 834.7579202031343, 848.9957550212209, 9165.0, 9373.718788436357, 9694.321397502106, 9745.540856574435, 9813.852792208123, 370711.05897621374, 379763.0, 381487.0, 383257.0, 385752.0, 77693.0, 81077.18922810814, 82477.0, 82836.17163828405, 83706.58146709349, 918.5040078357612, 918.5131880103556, 923.4551614547449, 941.5057095025167, 944.2634744898852, 14825.703485930437, 14938.701225975637, 15143.856143856145, 15155.090694558361, 15216.391344346102, 34939.30121397507, 35352.0, 36006.459903102, 36112.27775444529, 36967.260654786216, 48897.266541002624, 49428.752856235486, 49617.0, 50434.49565504298, 50892.0, 6371.13989611415, 6983.580985140908, 7554.886676699964, 7693.1922148173635, 7818.882716759139, 10021.298509104292, 10664.680059598224, 11002.449877505933, 11383.772324553629, 12084.45619947087, 9069.0, 9198.95400522993, 9253.306002049738, 9268.53657317145, 9646.18007469345, 9806.411615303105, 9892.15916647093, 9956.651517196864, 10011.649592264235, 10280.794384112425, 8841.734747957571, 9279.907200927904, 9464.95267523658, 9523.809523809623, 9638.855417168608, 7047.119110111236, 7088.893666594902, 7092.893606595802, 7160.606166660884, 7186.964065179641, 7074.0, 9009.954950225207, 9322.766930826783, 9717.757056073371, 10002.399856008662], "value": 7974.099893659114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.7623551525214, 1428.028940320582, 1430.063308532911, 1587.2777886061835, 1786.9814205902633, 6472.611643301405, 7532.246775322472, 7829.804254893624, 7839.412044096687, 8067.91932080679, 7887.171846956073, 7910.485818421813, 7953.880691789628, 7963.243491868263, 7972.242636949481, 2234.195689551764, 2271.659251112338, 2272.556851413967, 2275.3628983884455, 2275.8748268845206, 2232.8771917544527, 2257.7064981552376, 2271.250487339174, 2275.72691277047, 2277.430642339415, 2227.376334626299, 2227.543353612514, 2229.8996545155505, 2233.229535810143, 2264.083046366224, 2150.9139634414605, 2165.631842586756, 2170.913163473459, 2173.2502286711137, 2173.739151301838, 2110.461832232771, 2114.4608124928045, 2117.735283089614, 2118.5127420693175, 2118.5233322502468, 7598.202188770155, 7778.611069446505, 7836.647350869168, 7838.608069596497, 7842.960785196095, 4611.354410382549, 4825.227963525819, 4827.565519103297, 4830.782614782343, 4837.177679794443, 2923.2107331020716, 3038.3315670552442, 3082.553029810665, 3088.197068762138, 3093.1184612385587, 930.3952430919957, 940.722486866376, 958.942463452195, 975.5268694683073, 993.8310487217191, 10288.33125846825, 10362.533685984074, 10369.429681367521, 10369.792604147875, 10375.221858360654, 4105.548389677133, 4137.745466866676, 4156.45966024421, 4215.59951804578, 4226.661867050629, 8294.502329860228, 8318.750437486886, 8328.042275138436, 8335.333173346238, 8338.791530211673, 4581.839635612738, 4622.237330840441, 4704.411948506437, 4707.599854012447, 4709.128811169876, 3735.7571757835653, 4166.604172603597, 4327.069680018748, 4348.565143485626, 4356.0, 3407.931841363159, 3437.3125374925116, 3468.063622821824, 3491.790492570454, 3535.0808789714347, 1050.7110544600296, 1053.594366169015, 1057.613970900631, 1066.568039943824, 1069.4599227390117, 634.0552576660834, 685.4310921934782, 901.3600343756007, 905.515549181198, 931.6552875436132, 5247.396549396792, 5280.128778751463, 5325.520703136736, 5464.316960379952, 5585.162225666182, 840.7898025493627, 862.0, 865.9956700216459, 927.888653361601, 930.5672862119147, 3470.5488286523096, 3638.8180590970346, 3648.179159689049, 3658.579263384745, 3738.2897249522503, 9553.90446095544, 9826.901730982741, 9883.703488895344, 9890.20878329732, 9912.405255684682, 9515.666951656658, 9611.855822162674, 9701.660441884642, 9739.610415583298, 9743.317967742332, 7460.179380268166, 7581.583012934341, 7603.619819009027, 7626.58053807046, 7630.046244219473, 4970.701757894538, 5121.103806833715, 5144.382674079135, 5256.947430525645, 5325.866853328543, 8944.195022448012, 9134.680286189952, 9234.95382523083, 9244.907550924405, 9247.167754901822, 9225.21585665226, 9257.166854983085, 9258.074192580689, 9356.06439356059, 9367.484788336435, 6727.192736871411, 7075.973983772221, 7083.291670832876, 7084.504084714021, 7084.64576771149, 7439.0, 7534.284242996907, 7539.321461068311, 7542.170361260367, 7546.3962882968135, 5197.610179236497, 6647.6676166192465, 6694.196696396463, 6725.49558783103, 6946.826329341807, 6617.8014659560295, 6626.668666566556, 6850.862982740417, 6851.143607049119, 6884.965575172092, 6335.3981371769605, 6395.744170233139, 6447.387498187664, 6467.611943283418, 6480.546361754632, 4679.0, 4748.121597504472, 4762.666613337033, 4778.689385189951, 4785.760711964457, 4680.180968330596, 4779.115863565252, 4832.903341933212, 4844.297576851407, 4874.805007799649], "value": 4162.670542401902, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.36387949186195, 308.0865234579471, 308.270939228724, 309.1529209964697, 313.4170442976064, 4874.805007799689, 4877.341558889549, 4886.8778280543, 4896.681715688478, 4932.358793356868, 4851.490593487686, 4863.951360486394, 4872.683275587093, 4872.7563621818945, 4900.632452566063, 3679.8344074516644, 3760.52993375828, 3771.377722675755, 3774.188549461865, 3807.8286477108595, 3722.4416337549314, 3747.775133491986, 3871.4192871069286, 3874.767513949172, 3889.8249578769023, 3767.585565587783, 3817.351050321438, 3827.9425808612755, 3833.195029043904, 3842.1739326044894, 3663.725220608465, 3836.827342769582, 3840.2127563849344, 3855.8457661693637, 3857.4792403025795, 3371.5954085509898, 3392.677695618937, 3401.9489707654407, 3405.3019131078067, 3405.3700065487965, 4624.745638989854, 4650.534946505356, 4670.416197975253, 4675.625949923998, 4702.153612349775, 4362.0, 4362.541933097011, 4364.192624364503, 4399.912001759979, 4399.978000109979, 4954.455009948939, 5083.517065878736, 5108.361454818148, 5112.772934495694, 5121.385433747974, 3713.535808023997, 3720.4791329213663, 3736.831842567091, 3745.62543745626, 3757.4551690004796, 5309.840704778824, 5399.811006614749, 5411.83764487066, 5414.0, 5425.701586412746, 3720.162963333228, 3851.614838516126, 3864.381698928158, 3875.399313106473, 3888.358420860583, 3897.162110146332, 3902.1415288636454, 3902.726809123391, 3913.1391093959282, 3922.9793059344147, 4367.31858234582, 4388.144311859221, 4390.53899340571, 4390.978045109754, 4405.361222622766, 4974.477679843637, 5066.847994560169, 5098.515641014098, 5118.692878427306, 5120.61595380348, 1329.3021163888843, 1342.5301144599312, 1345.3788185236767, 1355.9694632079493, 1356.220173400279, 847.7922908887363, 861.7414775567305, 862.4394143806576, 874.6807415293499, 877.9868301975475, 4370.519242883281, 4452.977735111303, 4458.264386376211, 4459.130469558405, 4462.44219472566, 5201.713905735145, 5231.319928409359, 5234.895302093937, 5235.947640523546, 5241.13521268994, 4488.483824360175, 4513.435820522434, 4518.344839998182, 4518.502964673883, 4519.276915693474, 2614.516314481827, 2778.0693467688147, 2780.5968134620366, 2791.5812628105946, 2814.5074611942828, 4930.0, 4941.654084214142, 4950.925736113961, 4951.257311403247, 4970.564423432492, 5225.895482090337, 5317.255584218213, 5353.598480114007, 5355.464453554613, 5379.924015196976, 4945.2582112683385, 4952.702837829742, 4965.627577931669, 4969.211084009826, 4981.501849814989, 5254.0, 5263.868403289795, 5279.551238144801, 5290.7354632269, 5297.337832770903, 4965.889496963849, 5213.348331458567, 5222.97388513055, 5226.790928362823, 5266.499682530153, 4975.527324904128, 5035.7985680572365, 5041.521055499722, 5046.394432668103, 5069.518395752398, 3745.382011967995, 3765.2657731742047, 3767.171222331083, 3776.4524143999515, 3800.277947190025, 5054.573804573752, 5335.67985920846, 5360.597955153457, 5360.812371566976, 5362.436944120811, 5080.695158290514, 5106.812413820631, 5108.182690769608, 5158.174692049254, 5166.767495462788, 5074.695518268915, 5080.644354895269, 5111.718855462986, 5116.616253781056, 5134.383873935151, 4896.608271338356, 5056.873578160428, 5063.392392912874, 5063.772130254221, 5079.187330027178, 4909.410870695539, 4970.478099799469, 5105.591552675852, 5136.512031357015, 5140.845774626767, 5026.597872170145, 5028.798848046037, 5032.3961124665275, 5033.936086204639, 5046.899062018812], "value": 3872.9460566035996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.9883417296177, 730.5069078372098, 738.7008261654032, 747.4805010517692, 779.2713812585233, 11381.089512838973, 12119.27284362939, 12139.57511487098, 12143.57497487587, 12206.084543659228, 11889.108316876225, 11911.58309459167, 11919.880801191985, 11929.22460040099, 11934.7613047739, 606.3663471672113, 756.6141267953356, 779.4738551477758, 780.7462574663228, 781.9609019549029, 789.0176729971193, 793.0641842625699, 793.4168386236112, 793.7936136604495, 794.9244821741926, 828.9171082891722, 835.419383528448, 836.8912041434636, 837.1419295222415, 837.6272558711346, 640.6828619833166, 812.959352032396, 827.5365795154703, 828.0642873552907, 828.9958550207241, 598.6198763784985, 599.6252342286072, 599.8290487211168, 600.066895976756, 601.6480358989996, 12142.817857732052, 12172.756544869142, 12189.207701499374, 12190.39048047603, 12209.084318676134, 12828.486860525567, 13239.470421183141, 13476.730465390736, 13501.189928604315, 13511.365283769668, 9416.1525462708, 9883.258755593288, 10072.597096116147, 10341.121004714609, 10467.528961196764, 4226.873193804191, 4227.281362168439, 4231.97884010581, 4359.10638319147, 4403.185410699031, 47118.0, 47902.52097479015, 47928.52071479276, 47974.52025479735, 48363.75818120887, 10553.47232638365, 10573.687249845627, 10602.204834637432, 10650.082985062763, 10674.946625266979, 18204.36284730028, 18257.726134107997, 18289.359872404402, 18308.725369119475, 18311.35910243135, 6625.933740662628, 6691.79924602253, 6796.422304104207, 6908.447324214051, 7060.752873649398, 3666.816659167031, 3676.117731744362, 3690.7970061646865, 3740.60723624021, 3764.3036038333, 2864.6848846626854, 2941.058861164407, 2969.079585328555, 2974.8215107093642, 2985.626796650419, 498.8902441462872, 502.5527280720162, 508.4864287070012, 512.1089304610026, 513.9640225184202, 475.46747642640463, 585.4759989809097, 598.5361344957693, 609.6860117039728, 610.0818268505959, 7389.261073892675, 7481.289277518627, 7509.324160825443, 7531.397488200931, 7738.342240909473, 578.8581797459649, 589.8820235952827, 591.4913174669781, 606.7845914700218, 609.326694003129, 3554.6267641897743, 3629.2015756534047, 3663.9816800915823, 3732.8320225589914, 3751.5873253942045, 53784.73107634437, 56470.152947705814, 56690.0, 56757.71621141868, 56849.43150568524, 49055.26417103747, 49600.751996239786, 49903.75048124736, 50682.74658626757, 50907.745461273196, 46254.306185407244, 46388.536114638424, 46503.76748116238, 46838.063238735034, 46965.76517117392, 7591.772246832604, 7594.848103038019, 7696.7306144284685, 7741.612919354123, 7742.070951485633, 30201.697983019887, 31310.0, 32250.677493224768, 32274.838625806722, 32491.18772030718, 41509.37735933903, 42034.78982605068, 42106.578934210265, 42406.36390454084, 43423.13153736844, 10281.691549253534, 10422.478876056015, 10547.52536135891, 10644.414557199429, 11250.887491124984, 11758.941205293919, 12071.0, 12113.69715757113, 12178.147529672839, 12237.938810305892, 10197.490125493843, 10310.278280520291, 10387.792244154924, 10581.62964296246, 10583.576656933636, 10209.018482791866, 10333.586656533655, 10385.324953877975, 10515.631952881613, 10692.465376730977, 10730.785384292427, 10800.783984320113, 10918.890811091787, 11174.329540227613, 11301.604443844426, 8587.22714955657, 8723.171298726611, 8782.648694052166, 9091.59087841062, 9218.631254750004, 8444.366672499464, 8956.731298061068, 8972.102789720975, 9185.678501252423, 9284.932232793046], "value": 5984.921519549406, "unit": "score"}], "name": "dromaeo_css", "value": 6309.790552325602, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 136.0, 190.0, 139.0, 133.0, 157.0, 132.0, 161.0, 136.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 76.0, 78.0, 77.0, 75.0, 100.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 86.0, 86.0, 124.0, 84.0, 84.0, 142.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 65.0, 63.0, 63.0, 65.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 72.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 82.0, 90.0, 84.0, 90.0, 84.0, 126.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 129.0, 135.0, 137.0, 141.0, 139.0, 138.0, 134.0, 131.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 169.0, 169.0, 170.0, 169.0, 168.0, 171.0, 166.0, 168.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 67.0, 65.0, 72.0, 65.0, 67.0, 66.0, 66.0, 64.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1546.6000000000001, "alertThreshold": 2.0}]} 10:10:31 INFO - Return code: 0 10:10:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:10:31 ERROR - # TBPL SUCCESS # 10:10:31 INFO - Running post-action listener: _resource_record_post_action 10:10:31 INFO - ##### 10:10:31 INFO - ##### Finished run-tests step (success) 10:10:31 INFO - ##### 10:10:31 INFO - Running post-run listener: _resource_record_post_run 10:10:31 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521465856; Read time: 4; Write time: 568500 10:10:31 INFO - TinderboxPrint: CPU usage
13.1% 10:10:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 10:10:31 INFO - TinderboxPrint: I/O write bytes / time
521,465,856 / 568,500 10:10:31 INFO - TinderboxPrint: CPU idle
8,322.5 (86.9%) 10:10:31 INFO - TinderboxPrint: CPU user
1,210.4 (12.6%) 10:10:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:10:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236941312; Read time: 0; Write time: 239260 10:10:31 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284524544; Read time: 4; Write time: 329240 10:10:32 INFO - Running post-run listener: _upload_blobber_files 10:10:32 INFO - Blob upload gear active. 10:10:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:10:32 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 10:10:32 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:10:32 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:10:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:10:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:10:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:36 INFO - (blobuploader) - INFO - Done attempting. 10:10:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:10:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:37 INFO - (blobuploader) - INFO - Done attempting. 10:10:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:10:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:38 INFO - (blobuploader) - INFO - Done attempting. 10:10:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:38 INFO - Return code: 0 10:10:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:10:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3a5fedc7504dbd18437c29df73572cea633a28334c667c022f1331518e1677207605fb7b093672fa08950df4622d9dba54d70c091f10ba2c57b5b9899ffae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82999b9da6e70f67e26cf4d9962b9e5f859d70e82e1526eabc9250bc1d8d53cfedf398963e7f4335ce53a715ed7aabb044aeae153dd1b5a00f7281c8ee0543dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64b2b02cd0cb12a4d95f567ce196a4af7c3b26b460bb78000ae7fd4c11da7f028a276ac39ce1e51f190a5f21fe556e84c78031585f9f5892311ff23f9cc48b3"} 10:10:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:10:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:10:38 INFO - Contents: 10:10:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3a5fedc7504dbd18437c29df73572cea633a28334c667c022f1331518e1677207605fb7b093672fa08950df4622d9dba54d70c091f10ba2c57b5b9899ffae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82999b9da6e70f67e26cf4d9962b9e5f859d70e82e1526eabc9250bc1d8d53cfedf398963e7f4335ce53a715ed7aabb044aeae153dd1b5a00f7281c8ee0543dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64b2b02cd0cb12a4d95f567ce196a4af7c3b26b460bb78000ae7fd4c11da7f028a276ac39ce1e51f190a5f21fe556e84c78031585f9f5892311ff23f9cc48b3"} 10:10:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:10:38 INFO - Copying logs to upload dir... 10:10:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:10:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.943050 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-27 10:10:38.924120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:38.928174) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 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-Non-PGO/sha512/9e3a5fedc7504dbd18437c29df73572cea633a28334c667c022f1331518e1677207605fb7b093672fa08950df4622d9dba54d70c091f10ba2c57b5b9899ffae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82999b9da6e70f67e26cf4d9962b9e5f859d70e82e1526eabc9250bc1d8d53cfedf398963e7f4335ce53a715ed7aabb044aeae153dd1b5a00f7281c8ee0543dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64b2b02cd0cb12a4d95f567ce196a4af7c3b26b460bb78000ae7fd4c11da7f028a276ac39ce1e51f190a5f21fe556e84c78031585f9f5892311ff23f9cc48b3"} build_url:https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/d621uzjdQjmG2yvXJf0RCA/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-Non-PGO/sha512/9e3a5fedc7504dbd18437c29df73572cea633a28334c667c022f1331518e1677207605fb7b093672fa08950df4622d9dba54d70c091f10ba2c57b5b9899ffae1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82999b9da6e70f67e26cf4d9962b9e5f859d70e82e1526eabc9250bc1d8d53cfedf398963e7f4335ce53a715ed7aabb044aeae153dd1b5a00f7281c8ee0543dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e64b2b02cd0cb12a4d95f567ce196a4af7c3b26b460bb78000ae7fd4c11da7f028a276ac39ce1e51f190a5f21fe556e84c78031585f9f5892311ff23f9cc48b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:38.960150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:38.960615) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1464360422.464075-472054883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:39.010592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 10:10:39.010983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 10:10:39.011288) ========= ========= Total master_lag: 0.74 =========