builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1464134171.14 results: success (0) buildid: 20160524160846 builduid: 95e08e1620374aa6b80cfbe340ddc317 revision: 67e6237c889546118da03cbf3512274f9db05562 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.141234) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.141621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.142058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.427725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.428023) ========= 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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 16:56:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-24 16:56:11 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164270 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.617888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.618233) ========= 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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.668279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:11.668618) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 67e6237c889546118da03cbf3512274f9db05562 --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 67e6237c889546118da03cbf3512274f9db05562 --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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 16:56:11,975 truncating revision to first 12 chars 2016-05-24 16:56:11,975 Setting DEBUG logging. 2016-05-24 16:56:11,975 attempt 1/10 2016-05-24 16:56:11,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/67e6237c8895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 16:56:12,237 unpacking tar archive at: fx-team-67e6237c8895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545251 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:12.230069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:12.230387) ========= script_repo_revision: 67e6237c889546118da03cbf3512274f9db05562 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:12.230815) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:12.231119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 16:56:12.241313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-24 16:56:12.241623) ========= /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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:12 INFO - MultiFileLogger online at 20160524 16:56:12 in /builds/slave/test 16:56:12 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 16:56:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:12 INFO - {'append_to_log': False, 16:56:12 INFO - 'base_work_dir': '/builds/slave/test', 16:56:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:56:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:12 INFO - 'branch': 'Fx-Team-Non-PGO', 16:56:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:12 INFO - 'config_files': ('talos/linux_config.py',), 16:56:12 INFO - 'default_actions': ('clobber', 16:56:12 INFO - 'read-buildbot-config', 16:56:12 INFO - 'download-and-extract', 16:56:12 INFO - 'populate-webroot', 16:56:12 INFO - 'create-virtualenv', 16:56:12 INFO - 'install', 16:56:12 INFO - 'run-tests'), 16:56:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:12 INFO - 'download_minidump_stackwalk': True, 16:56:12 INFO - 'download_symbols': 'ondemand', 16:56:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:12 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:12 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:12 INFO - 'installer_path': 'installer.exe', 16:56:12 INFO - 'log_level': 'info', 16:56:12 INFO - 'log_name': 'talos', 16:56:12 INFO - 'log_to_console': True, 16:56:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:12 INFO - 'opt_config_files': (), 16:56:12 INFO - 'pip_index': False, 16:56:12 INFO - 'sps_profile': False, 16:56:12 INFO - 'sps_profile_interval': 0, 16:56:12 INFO - 'suite': 'dromaeojs', 16:56:12 INFO - 'system_bits': '32', 16:56:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:12 INFO - 'title': 'talos-linux64-ix-058', 16:56:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:12 INFO - 'use_talos_json': True, 16:56:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:12 INFO - 'work_dir': 'build'} 16:56:12 INFO - ##### 16:56:12 INFO - ##### Running clobber step. 16:56:12 INFO - ##### 16:56:12 INFO - Running pre-action listener: _resource_record_pre_action 16:56:12 INFO - Running main action method: clobber 16:56:12 INFO - rmtree: /builds/slave/test/build 16:56:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:13 INFO - Running post-action listener: _resource_record_post_action 16:56:13 INFO - ##### 16:56:13 INFO - ##### Finished clobber step (success) 16:56:13 INFO - ##### 16:56:13 INFO - ##### 16:56:13 INFO - ##### Running read-buildbot-config step. 16:56:13 INFO - ##### 16:56:13 INFO - Running pre-action listener: _resource_record_pre_action 16:56:13 INFO - Running main action method: read_buildbot_config 16:56:13 INFO - Using buildbot properties: 16:56:13 INFO - { 16:56:13 INFO - "project": "", 16:56:13 INFO - "product": "firefox", 16:56:13 INFO - "script_repo_revision": "production", 16:56:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:56:13 INFO - "repository": "", 16:56:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:56:13 INFO - "buildid": "20160524160846", 16:56:13 INFO - "pgo_build": "False", 16:56:13 INFO - "basedir": "/builds/slave/test", 16:56:13 INFO - "buildnumber": 3003, 16:56:13 INFO - "slavename": "talos-linux64-ix-058", 16:56:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:56:13 INFO - "platform": "ubuntu64_hw", 16:56:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:56:13 INFO - "branch": "fx-team", 16:56:13 INFO - "repo_path": "integration/fx-team", 16:56:13 INFO - "revision": "67e6237c889546118da03cbf3512274f9db05562", 16:56:13 INFO - "stage_platform": "linux64", 16:56:13 INFO - "builduid": "95e08e1620374aa6b80cfbe340ddc317", 16:56:13 INFO - "slavebuilddir": "test" 16:56:13 INFO - } 16:56:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:56:13 INFO - Running post-action listener: _resource_record_post_action 16:56:13 INFO - ##### 16:56:13 INFO - ##### Finished read-buildbot-config step (success) 16:56:13 INFO - ##### 16:56:13 INFO - ##### 16:56:13 INFO - ##### Running download-and-extract step. 16:56:13 INFO - ##### 16:56:13 INFO - Running pre-action listener: _resource_record_pre_action 16:56:13 INFO - Running main action method: download_and_extract 16:56:13 INFO - mkdir: /builds/slave/test/build/tests 16:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:13 INFO - https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:14 INFO - Downloaded 1361 bytes. 16:56:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:56:14 INFO - Using the following test package requirements: 16:56:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'jsshell-linux-x86_64.zip'], 16:56:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56: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')]} 16:56:14 INFO - https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:16 INFO - Downloaded 22844408 bytes. 16:56:16 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'] 16:56:16 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 16:56:17 INFO - Return code: 0 16:56:17 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 16:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:17 INFO - https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:56:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:21 INFO - Downloaded 22844408 bytes. 16:56:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:56:22 INFO - Return code: 0 16:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:22 INFO - https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:24 INFO - Downloaded 10840359 bytes. 16:56:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:56:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:56:24 INFO - Return code: 0 16:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:24 INFO - https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UBdENGtoR-uKB2H2oNQaug/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 16:56:26 INFO - Downloaded 54823097 bytes. 16:56:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:26 INFO - mkdir: /builds/slave/test/properties 16:56:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:26 INFO - Contents: 16:56:26 INFO - build_url:https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - Running post-action listener: set_extra_try_arguments 16:56:27 INFO - ##### 16:56:27 INFO - ##### Finished download-and-extract step (success) 16:56:27 INFO - ##### 16:56:27 INFO - ##### 16:56:27 INFO - ##### Running populate-webroot step. 16:56:27 INFO - ##### 16:56:27 INFO - Running pre-action listener: _resource_record_pre_action 16:56:27 INFO - Running main action method: populate_webroot 16:56:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:56:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:56:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:56:27 INFO - '--tppagecycles', 16:56:27 INFO - '7'], 16:56:27 INFO - 'tests': ['tsvgm']}}, 16:56:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:56:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:56:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:56:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:56:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['damp', 'tps']}, 16:56:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'tests': ['damp', 'tps']}, 16:56:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['dromaeo_dom']}, 16:56:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['a11yr', 16:56:27 INFO - 'ts_paint', 16:56:27 INFO - 'tpaint', 16:56:27 INFO - 'sessionrestore', 16:56:27 INFO - 'sessionrestore_no_auto_restore', 16:56:27 INFO - 'tabpaint']}, 16:56:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['tsvgx', 16:56:27 INFO - 'tsvgr_opacity', 16:56:27 INFO - 'tart', 16:56:27 INFO - 'tscrollx', 16:56:27 INFO - 'cart']}, 16:56:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:56:27 INFO - 'tsvgr_opacity', 16:56:27 INFO - 'tart', 16:56:27 INFO - 'tscrollx', 16:56:27 INFO - 'cart']}, 16:56:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'talos_options': ['--disable-e10s'], 16:56:27 INFO - 'tests': ['tp5o']}, 16:56:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'tests': ['tp5o']}, 16:56:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'talos_options': ['--disable-e10s', 16:56:27 INFO - '--xperf_path', 16:56:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:27 INFO - 'tests': ['tp5n']}, 16:56:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:27 INFO - 'talos_options': ['--xperf_path', 16:56:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:27 INFO - 'tests': ['tp5n']}}, 16:56:27 INFO - 'talos.zip': {'path': '', 16:56:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - ##### 16:56:27 INFO - ##### Finished populate-webroot step (success) 16:56:27 INFO - ##### 16:56:27 INFO - ##### 16:56:27 INFO - ##### Running create-virtualenv step. 16:56:27 INFO - ##### 16:56:27 INFO - Running pre-action listener: _resource_record_pre_action 16:56:27 INFO - Running main action method: create_virtualenv 16:56:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:56:27 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 16:56:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:56:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:27 INFO - Using real prefix '/usr' 16:56:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:56:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:30 INFO - Installing pip.................done. 16:56:30 INFO - Return code: 0 16:56:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:56:30 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')]} 16:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 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')]} 16:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:30 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 16:56:30 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 16:56:30 INFO - Using env: {'DISPLAY': ':0', 16:56:30 INFO - 'HOME': '/home/cltbld', 16:56:30 INFO - 'LANG': 'en_US.UTF-8', 16:56:30 INFO - 'LANGUAGE': 'en_US:en', 16:56:30 INFO - 'LOGNAME': 'cltbld', 16:56:30 INFO - 'MAIL': '/var/mail/cltbld', 16:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:30 INFO - 'MOZ_NO_REMOTE': '1', 16:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:30 INFO - 'NO_EM_RESTART': '1', 16:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:30 INFO - 'PWD': '/builds/slave/test', 16:56:30 INFO - 'SHELL': '/bin/bash', 16:56:30 INFO - 'SHLVL': '1', 16:56:30 INFO - 'TERM': 'linux', 16:56:30 INFO - 'TMOUT': '86400', 16:56:30 INFO - 'USER': 'cltbld', 16:56:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:30 INFO - '_': '/tools/buildbot/bin/python'} 16:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:30 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 16:56:30 INFO - Cleaning up... 16:56:30 INFO - Return code: 0 16:56:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:56:30 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')]} 16:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 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')]} 16:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:30 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 16:56:30 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 16:56:30 INFO - Using env: {'DISPLAY': ':0', 16:56:30 INFO - 'HOME': '/home/cltbld', 16:56:30 INFO - 'LANG': 'en_US.UTF-8', 16:56:30 INFO - 'LANGUAGE': 'en_US:en', 16:56:30 INFO - 'LOGNAME': 'cltbld', 16:56:30 INFO - 'MAIL': '/var/mail/cltbld', 16:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:30 INFO - 'MOZ_NO_REMOTE': '1', 16:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:30 INFO - 'NO_EM_RESTART': '1', 16:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:30 INFO - 'PWD': '/builds/slave/test', 16:56:30 INFO - 'SHELL': '/bin/bash', 16:56:30 INFO - 'SHLVL': '1', 16:56:30 INFO - 'TERM': 'linux', 16:56:30 INFO - 'TMOUT': '86400', 16:56:30 INFO - 'USER': 'cltbld', 16:56:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:30 INFO - '_': '/tools/buildbot/bin/python'} 16:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:30 INFO - Downloading/unpacking psutil>=3.1.1 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56: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 16:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:32 INFO - Installing collected packages: psutil 16:56:32 INFO - Running setup.py install for psutil 16:56:32 INFO - building 'psutil._psutil_linux' extension 16:56:32 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 16:56:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:56:33 INFO - building 'psutil._psutil_posix' extension 16:56:33 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 16:56:33 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 16:56:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:33 INFO - Successfully installed psutil 16:56:33 INFO - Cleaning up... 16:56:33 INFO - Return code: 0 16:56:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:56:33 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')]} 16:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:33 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')]} 16:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:33 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:33 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 16:56:33 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 16:56:33 INFO - Using env: {'DISPLAY': ':0', 16:56:33 INFO - 'HOME': '/home/cltbld', 16:56:33 INFO - 'LANG': 'en_US.UTF-8', 16:56:33 INFO - 'LANGUAGE': 'en_US:en', 16:56:33 INFO - 'LOGNAME': 'cltbld', 16:56:33 INFO - 'MAIL': '/var/mail/cltbld', 16:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:33 INFO - 'MOZ_NO_REMOTE': '1', 16:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:33 INFO - 'NO_EM_RESTART': '1', 16:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:33 INFO - 'PWD': '/builds/slave/test', 16:56:33 INFO - 'SHELL': '/bin/bash', 16:56:33 INFO - 'SHLVL': '1', 16:56:33 INFO - 'TERM': 'linux', 16:56:33 INFO - 'TMOUT': '86400', 16:56:33 INFO - 'USER': 'cltbld', 16:56:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:33 INFO - '_': '/tools/buildbot/bin/python'} 16:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:56:33 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 16:56:33 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 16:56:33 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 16:56:33 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 16:56:33 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 16:56:33 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 16:56:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:35 INFO - Installing collected packages: mozsystemmonitor 16:56:35 INFO - Running setup.py install for mozsystemmonitor 16:56:35 INFO - Successfully installed mozsystemmonitor 16:56:35 INFO - Cleaning up... 16:56:35 INFO - Return code: 0 16:56:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:35 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:35 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 16:56:35 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 16:56:35 INFO - Using env: {'DISPLAY': ':0', 16:56:35 INFO - 'HOME': '/home/cltbld', 16:56:35 INFO - 'LANG': 'en_US.UTF-8', 16:56:35 INFO - 'LANGUAGE': 'en_US:en', 16:56:35 INFO - 'LOGNAME': 'cltbld', 16:56:35 INFO - 'MAIL': '/var/mail/cltbld', 16:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:35 INFO - 'MOZ_NO_REMOTE': '1', 16:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:35 INFO - 'NO_EM_RESTART': '1', 16:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:35 INFO - 'PWD': '/builds/slave/test', 16:56:35 INFO - 'SHELL': '/bin/bash', 16:56:35 INFO - 'SHLVL': '1', 16:56:35 INFO - 'TERM': 'linux', 16:56:35 INFO - 'TMOUT': '86400', 16:56:35 INFO - 'USER': 'cltbld', 16:56:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:35 INFO - '_': '/tools/buildbot/bin/python'} 16:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:35 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 16:56:35 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 16:56:35 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 16:56:35 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 16:56:35 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 16:56:35 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 16:56:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 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 16:56:38 INFO - Downloading docopt-0.6.1.tar.gz 16:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:38 INFO - Running setup.py install for blobuploader 16:56:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:38 INFO - Running setup.py install for requests 16:56:38 INFO - Running setup.py install for docopt 16:56:38 INFO - Successfully installed blobuploader requests docopt 16:56:38 INFO - Cleaning up... 16:56:39 INFO - Return code: 0 16:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:39 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:39 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 16:56:39 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 16:56:39 INFO - Using env: {'DISPLAY': ':0', 16:56:39 INFO - 'HOME': '/home/cltbld', 16:56:39 INFO - 'LANG': 'en_US.UTF-8', 16:56:39 INFO - 'LANGUAGE': 'en_US:en', 16:56:39 INFO - 'LOGNAME': 'cltbld', 16:56:39 INFO - 'MAIL': '/var/mail/cltbld', 16:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:39 INFO - 'MOZ_NO_REMOTE': '1', 16:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:39 INFO - 'NO_EM_RESTART': '1', 16:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:39 INFO - 'PWD': '/builds/slave/test', 16:56:39 INFO - 'SHELL': '/bin/bash', 16:56:39 INFO - 'SHLVL': '1', 16:56:39 INFO - 'TERM': 'linux', 16:56:39 INFO - 'TMOUT': '86400', 16:56:39 INFO - 'USER': 'cltbld', 16:56:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:39 INFO - '_': '/tools/buildbot/bin/python'} 16:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:39 INFO - Running setup.py (path:/tmp/pip-qQ9mLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:39 INFO - Running setup.py (path:/tmp/pip-xR2NyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:39 INFO - Running setup.py (path:/tmp/pip-Gx3A9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:39 INFO - Running setup.py (path:/tmp/pip-Ov474V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:39 INFO - Running setup.py (path:/tmp/pip-bXiMKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:39 INFO - Running setup.py (path:/tmp/pip-v5INdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:39 INFO - Running setup.py (path:/tmp/pip-nKkvFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:39 INFO - Running setup.py (path:/tmp/pip-a6sgAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:39 INFO - Running setup.py (path:/tmp/pip-06j1nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:39 INFO - Running setup.py (path:/tmp/pip-fruBzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:39 INFO - Running setup.py (path:/tmp/pip-yQOcPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:40 INFO - Running setup.py (path:/tmp/pip-MXZj0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:40 INFO - Running setup.py (path:/tmp/pip-7h_VWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:40 INFO - Running setup.py (path:/tmp/pip-KY4Abr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:40 INFO - Running setup.py (path:/tmp/pip-2Fxvhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:40 INFO - Running setup.py (path:/tmp/pip-pBka0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:40 INFO - Running setup.py (path:/tmp/pip-rtt9_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:40 INFO - Running setup.py install for manifestparser 16:56:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:40 INFO - Running setup.py install for mozcrash 16:56:40 INFO - Running setup.py install for mozdebug 16:56:40 INFO - Running setup.py install for mozdevice 16:56:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:56:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:40 INFO - Running setup.py install for mozfile 16:56:41 INFO - Running setup.py install for mozhttpd 16:56:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozinfo 16:56:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozInstall 16:56:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozleak 16:56:41 INFO - Running setup.py install for mozlog 16:56:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for moznetwork 16:56:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozprocess 16:56:41 INFO - Running setup.py install for mozprofile 16:56:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozrunner 16:56:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:41 INFO - Running setup.py install for mozscreenshot 16:56:42 INFO - Running setup.py install for moztest 16:56:42 INFO - Running setup.py install for mozversion 16:56:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:42 INFO - Cleaning up... 16:56:42 INFO - Return code: 0 16:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:42 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:42 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 16:56:42 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 16:56:42 INFO - Using env: {'DISPLAY': ':0', 16:56:42 INFO - 'HOME': '/home/cltbld', 16:56:42 INFO - 'LANG': 'en_US.UTF-8', 16:56:42 INFO - 'LANGUAGE': 'en_US:en', 16:56:42 INFO - 'LOGNAME': 'cltbld', 16:56:42 INFO - 'MAIL': '/var/mail/cltbld', 16:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:42 INFO - 'MOZ_NO_REMOTE': '1', 16:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:42 INFO - 'NO_EM_RESTART': '1', 16:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:42 INFO - 'PWD': '/builds/slave/test', 16:56:42 INFO - 'SHELL': '/bin/bash', 16:56:42 INFO - 'SHLVL': '1', 16:56:42 INFO - 'TERM': 'linux', 16:56:42 INFO - 'TMOUT': '86400', 16:56:42 INFO - 'USER': 'cltbld', 16:56:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:42 INFO - '_': '/tools/buildbot/bin/python'} 16:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:42 INFO - Running setup.py (path:/tmp/pip-z0XJ4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:42 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)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:42 INFO - Running setup.py (path:/tmp/pip-CVQqPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:42 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)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:42 INFO - Running setup.py (path:/tmp/pip-cjI4r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:42 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)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:42 INFO - Running setup.py (path:/tmp/pip-fc9FcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:42 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)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:42 INFO - Running setup.py (path:/tmp/pip-IVxuxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:42 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)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:42 INFO - Running setup.py (path:/tmp/pip-NnWXWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:42 INFO - Running setup.py (path:/tmp/pip-yVQI2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:43 INFO - Running setup.py (path:/tmp/pip-jVu8x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:43 INFO - Running setup.py (path:/tmp/pip-rNrcQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:43 INFO - Running setup.py (path:/tmp/pip-xg0iXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:43 INFO - Running setup.py (path:/tmp/pip-AtJ09A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:43 INFO - Running setup.py (path:/tmp/pip-HgMyeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:43 INFO - Running setup.py (path:/tmp/pip-IIkgat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:43 INFO - Running setup.py (path:/tmp/pip-ZsjtQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:43 INFO - Running setup.py (path:/tmp/pip-0qXr2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:43 INFO - Running setup.py (path:/tmp/pip-Z3dji9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:43 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)) 16:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:43 INFO - Running setup.py (path:/tmp/pip-EMRxwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:43 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)) 16:56:43 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)) 16:56:43 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)) 16:56:43 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)) 16:56:43 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)) 16:56:43 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)) 16:56:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:43 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 16:56:43 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 16:56:43 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 16:56:43 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 16:56:43 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 16:56:43 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 16:56:45 INFO - Downloading blessings-1.6.tar.gz 16:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:45 INFO - Installing collected packages: blessings 16:56:45 INFO - Running setup.py install for blessings 16:56:45 INFO - Successfully installed blessings 16:56:45 INFO - Cleaning up... 16:56:45 INFO - Return code: 0 16:56:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:46 INFO - Reading from file tmpfile_stdout 16:56:46 INFO - Current package versions: 16:56:46 INFO - argparse == 1.2.1 16:56:46 INFO - blessings == 1.6 16:56:46 INFO - blobuploader == 1.2.4 16:56:46 INFO - docopt == 0.6.1 16:56:46 INFO - manifestparser == 1.1 16:56:46 INFO - mozInstall == 1.12 16:56:46 INFO - mozcrash == 0.17 16:56:46 INFO - mozdebug == 0.1 16:56:46 INFO - mozdevice == 0.48 16:56:46 INFO - mozfile == 1.2 16:56:46 INFO - mozhttpd == 0.7 16:56:46 INFO - mozinfo == 0.9 16:56:46 INFO - mozleak == 0.1 16:56:46 INFO - mozlog == 3.2 16:56:46 INFO - moznetwork == 0.27 16:56:46 INFO - mozprocess == 0.22 16:56:46 INFO - mozprofile == 0.28 16:56:46 INFO - mozrunner == 6.11 16:56:46 INFO - mozscreenshot == 0.1 16:56:46 INFO - mozsystemmonitor == 0.3 16:56:46 INFO - moztest == 0.7 16:56:46 INFO - mozversion == 1.4 16:56:46 INFO - psutil == 3.1.1 16:56:46 INFO - requests == 1.2.3 16:56:46 INFO - wsgiref == 0.1.2 16:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:46 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:46 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 16:56:46 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 16:56:46 INFO - Using env: {'DISPLAY': ':0', 16:56:46 INFO - 'HOME': '/home/cltbld', 16:56:46 INFO - 'LANG': 'en_US.UTF-8', 16:56:46 INFO - 'LANGUAGE': 'en_US:en', 16:56:46 INFO - 'LOGNAME': 'cltbld', 16:56:46 INFO - 'MAIL': '/var/mail/cltbld', 16:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:46 INFO - 'MOZ_NO_REMOTE': '1', 16:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:46 INFO - 'NO_EM_RESTART': '1', 16:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:46 INFO - 'PWD': '/builds/slave/test', 16:56:46 INFO - 'SHELL': '/bin/bash', 16:56:46 INFO - 'SHLVL': '1', 16:56:46 INFO - 'TERM': 'linux', 16:56:46 INFO - 'TMOUT': '86400', 16:56:46 INFO - 'USER': 'cltbld', 16:56:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:46 INFO - '_': '/tools/buildbot/bin/python'} 16:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 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)) 16:56:46 INFO - Cleaning up... 16:56:46 INFO - Return code: 0 16:56:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:46 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 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:46 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 16:56:46 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 16:56:46 INFO - Using env: {'DISPLAY': ':0', 16:56:46 INFO - 'HOME': '/home/cltbld', 16:56:46 INFO - 'LANG': 'en_US.UTF-8', 16:56:46 INFO - 'LANGUAGE': 'en_US:en', 16:56:46 INFO - 'LOGNAME': 'cltbld', 16:56:46 INFO - 'MAIL': '/var/mail/cltbld', 16:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:46 INFO - 'MOZ_NO_REMOTE': '1', 16:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:46 INFO - 'NO_EM_RESTART': '1', 16:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:46 INFO - 'PWD': '/builds/slave/test', 16:56:46 INFO - 'SHELL': '/bin/bash', 16:56:46 INFO - 'SHLVL': '1', 16:56:46 INFO - 'TERM': 'linux', 16:56:46 INFO - 'TMOUT': '86400', 16:56:46 INFO - 'USER': 'cltbld', 16:56:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:46 INFO - '_': '/tools/buildbot/bin/python'} 16:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:46 INFO - Downloading/unpacking jsonschema 16:56:46 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 16:56:46 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 16:56:46 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 16:56:46 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 16:56:46 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 16:56:46 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 16:56:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:48 INFO - Downloading/unpacking functools32 (from jsonschema) 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:48 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:48 INFO - warning: no files found matching '*.txt' 16:56:48 INFO - no previously-included directories found matching 'build' 16:56:48 INFO - no previously-included directories found matching 'dist' 16:56:48 INFO - no previously-included directories found matching '.git*' 16:56:48 INFO - Installing collected packages: jsonschema, functools32 16:56:48 INFO - Running setup.py install for functools32 16:56:48 INFO - warning: no files found matching '*.txt' 16:56:48 INFO - no previously-included directories found matching 'build' 16:56:48 INFO - no previously-included directories found matching 'dist' 16:56:48 INFO - no previously-included directories found matching '.git*' 16:56:48 INFO - Successfully installed jsonschema functools32 16:56:48 INFO - Cleaning up... 16:56:48 INFO - Return code: 0 16:56:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce8bf01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, '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': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', '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 16:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:56:48 INFO - Using env: {'DISPLAY': ':0', 16:56:48 INFO - 'HOME': '/home/cltbld', 16:56:48 INFO - 'LANG': 'en_US.UTF-8', 16:56:48 INFO - 'LANGUAGE': 'en_US:en', 16:56:48 INFO - 'LOGNAME': 'cltbld', 16:56:48 INFO - 'MAIL': '/var/mail/cltbld', 16:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:48 INFO - 'MOZ_NO_REMOTE': '1', 16:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:48 INFO - 'NO_EM_RESTART': '1', 16:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:48 INFO - 'PWD': '/builds/slave/test', 16:56:48 INFO - 'SHELL': '/bin/bash', 16:56:48 INFO - 'SHLVL': '1', 16:56:48 INFO - 'TERM': 'linux', 16:56:48 INFO - 'TMOUT': '86400', 16:56:48 INFO - 'USER': 'cltbld', 16:56:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:48 INFO - '_': '/tools/buildbot/bin/python'} 16:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:49 INFO - Downloading/unpacking flake8 16:56:49 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 16:56:49 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 16:56:49 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 16:56:49 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 16:56:49 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 16:56:49 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 16:56:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:56:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:56:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 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 16:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:51 INFO - no previously-included directories found matching 'docs/_build' 16:56:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:56:51 INFO - Running setup.py install for pep8 16:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:51 INFO - no previously-included directories found matching 'docs/_build' 16:56:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:56:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:56:51 INFO - Cleaning up... 16:56:51 INFO - Return code: 0 16:56:51 INFO - Running post-action listener: _resource_record_post_action 16:56:51 INFO - Running post-action listener: _start_resource_monitoring 16:56:52 INFO - Starting resource monitoring. 16:56:52 INFO - ##### 16:56:52 INFO - ##### Finished create-virtualenv step (success) 16:56:52 INFO - ##### 16:56:52 INFO - ##### 16:56:52 INFO - ##### Running install step. 16:56:52 INFO - ##### 16:56:52 INFO - Running pre-action listener: _resource_record_pre_action 16:56:52 INFO - Running main action method: install 16:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:52 INFO - Reading from file tmpfile_stdout 16:56:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:52 INFO - Reading from file tmpfile_stdout 16:56:52 INFO - Output received: 16:56:52 INFO - Usage: mozinstall [options] installer 16:56:52 INFO - Options: 16:56:52 INFO - -h, --help show this help message and exit 16:56:52 INFO - -d DEST, --destination=DEST 16:56:52 INFO - Directory to install application into. [default: 16:56:52 INFO - "/builds/slave/test"] 16:56:52 INFO - --app=APP Application being installed. [default: firefox] 16:56:52 INFO - mkdir: /builds/slave/test/build/application 16:56:52 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'] 16:56:52 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 16:57:08 INFO - Reading from file tmpfile_stdout 16:57:08 INFO - Output received: 16:57:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:57:08 INFO - Running post-action listener: _resource_record_post_action 16:57:08 INFO - ##### 16:57:08 INFO - ##### Finished install step (success) 16:57:08 INFO - ##### 16:57:08 INFO - ##### 16:57:08 INFO - ##### Running run-tests step. 16:57:08 INFO - ##### 16:57:08 INFO - Running pre-action listener: _resource_record_pre_action 16:57:08 INFO - Running main action method: run_tests 16:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:57:08 INFO - Python 2.7.3 16:57:08 INFO - Return code: 0 16:57:08 INFO - grabbing minidump binary from tooltool 16:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:08 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 0x15ce9c0>, '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 0x15cf8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15cfd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:57:08 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 16:57:08 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 16:57:08 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 16:57:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:57:08 INFO - Return code: 0 16:57:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:57:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:57:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:57:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:57:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:57:09 INFO - Return code: 0 16:57:09 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/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:57:09 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/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 16:57:09 INFO - Using env: {'DISPLAY': ':0', 16:57:09 INFO - 'HOME': '/home/cltbld', 16:57:09 INFO - 'LANG': 'en_US.UTF-8', 16:57:09 INFO - 'LANGUAGE': 'en_US:en', 16:57:09 INFO - 'LOGNAME': 'cltbld', 16:57:09 INFO - 'MAIL': '/var/mail/cltbld', 16:57:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:57:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:09 INFO - 'MOZ_NO_REMOTE': '1', 16:57:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:09 INFO - 'NO_EM_RESTART': '1', 16:57:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:09 INFO - 'PWD': '/builds/slave/test', 16:57:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:57:09 INFO - 'SHELL': '/bin/bash', 16:57:09 INFO - 'SHLVL': '1', 16:57:09 INFO - 'TERM': 'linux', 16:57:09 INFO - 'TMOUT': '86400', 16:57:09 INFO - 'USER': 'cltbld', 16:57:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929', 16:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:09 INFO - '_': '/tools/buildbot/bin/python'} 16:57:09 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/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 16:57:09 INFO - mozversion application_buildid: 20160524160846 16:57:09 INFO - mozversion application_changeset: 67e6237c889546118da03cbf3512274f9db05562 16:57:09 INFO - mozversion application_display_name: Nightly 16:57:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:09 INFO - mozversion application_name: Firefox 16:57:09 INFO - mozversion application_remotingname: firefox 16:57:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:57:09 INFO - mozversion application_vendor: Mozilla 16:57:09 INFO - mozversion application_version: 49.0a1 16:57:09 INFO - mozversion platform_buildid: 20160524160846 16:57:09 INFO - mozversion platform_changeset: 67e6237c889546118da03cbf3512274f9db05562 16:57:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:57:09 INFO - mozversion platform_version: 49.0a1 16:57:09 INFO - using testdate: 1464134229 16:57:09 INFO - actual date: 1464134229 16:57:09 INFO - starting webserver on 'localhost:33673' 16:57:09 INFO - SUITE-START | Running 2 tests 16:57:09 INFO - TEST-START | dromaeo_css 16:57:09 INFO - operating with platform_type : linux_ 16:57:09 INFO - Initialising browser for dromaeo_css test... 16:57:09 INFO - TEST-INFO | started process 12815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_rP0DO/profile http://localhost:33673/getInfo.html) 16:57:13 INFO - PROCESS | 12815 | __metrics Screen width/height:1600/1200 16:57:13 INFO - PROCESS | 12815 | colorDepth:24 16:57:13 INFO - PROCESS | 12815 | Browser inner width/height: 1024/697 16:57:13 INFO - PROCESS | 12815 | __metrics 16:57:14 ERROR - PROCESS | 12815 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:57:15 INFO - TEST-INFO | 12815: exit 0 16:57:15 INFO - Browser initialized. 16:57:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:15 INFO - TEST-INFO | started process 12894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_rP0DO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:27 INFO - PROCESS | 12894 | RSS: Main: 154710016 16:57:27 INFO - PROCESS | 12894 | 16:58:19 INFO - PROCESS | 12894 | 1464134299285 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] 17:00:30 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33673/tests/dromaeo/cssquery-ext.html) 17:00:32 INFO - PROCESS | 12894 | RSS: Main: 274731008 17:00:32 INFO - PROCESS | 12894 | 17:03:34 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-ext.html (next: http://localhost:33673/tests/dromaeo/cssquery-jquery.html) 17:03:35 INFO - PROCESS | 12894 | RSS: Main: 240283648 17:03:35 INFO - PROCESS | 12894 | 17:06:37 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33673/tests/dromaeo/cssquery-mootools.html) 17:06:38 INFO - PROCESS | 12894 | RSS: Main: 231264256 17:06:38 INFO - PROCESS | 12894 | 17:09:40 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33673/tests/dromaeo/cssquery-prototype.html) 17:09:40 INFO - PROCESS | 12894 | RSS: Main: 229588992 17:09:40 INFO - PROCESS | 12894 | 17:12:43 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33673/tests/dromaeo/cssquery-yui.html) 17:12:44 INFO - PROCESS | 12894 | RSS: Main: 212639744 17:12:44 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | Cycle 1(1): loaded http://localhost:33673/tests/dromaeo/cssquery-yui.html (next: http://localhost:33673/tests/dromaeo/cssquery-dojo.html) 17:15:47 INFO - PROCESS | 12894 | RSS: Main: 271319040 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | __start_tp_report 17:15:47 INFO - PROCESS | 12894 | _x_x_mozilla_page_load 17:15:47 INFO - PROCESS | 12894 | _x_x_mozilla_page_load_details 17:15:47 INFO - PROCESS | 12894 | |i|pagename|runs| 17:15:47 INFO - PROCESS | 12894 | |0;dojo.html;2678.196541037689;2697.905573304932;2720.878332602718;2733.1253998720404;2755.2836262571736;4610.907781844361;4679;4710.199266124759;4793.999999999995;4839.8790030249265;4694.90610187796;4701.670883038189;4709.4348678158585;4751.02603966187;4754.881127971802;4294.312909934419;4327.394164816928;4370.694051416386;4405.207062728708;4526.75102869342;4460;4480.6639502037315;4480.8879778005485;4520.593146616804;4542.273236282195;4271.209826182167;4303.053328267776;4325.264705000158;4358.585934336233;4393.319035549479;4321.351797230409;4343.370211319341;4353.978230108861;4376.277914144162;4413.713108647928;4364.388985542027;4373.475182978032;4375.781210939472;4383.649308055348;4425.203463376591;4509.3461448090175;4625.1443482955765;4695.131400690883;4755.881102972453;4758.619310455155;5105.132127538327;5105.617078719111;5157.7936882524655;5161.122609156452;5173.482651734834;5147.536721695065;5147.7683504242395;5190.662606930538;5218.817341393033;5219;4676.95323046772;4766.713997160182;4816.084943860656;4862.635302352338;4867.075255701406;5270.077736396115;5277.23480095384;5280.419153893069;5320.388155362183;5341.225522299323;5040.36995375578;5060.620453466005;5114.462981386975;5116.437191908887;5121.257417674491;4999.0251900878975;5071;5134.743262836918;5138.434772175057;5176.559992400613;5073;5093;5100.387953445536;5104.412992505835;5163.199704045879;5049.091163590516;5090.211017292326;5101.0308041472;5102.617303702237;5103.897922041539;4318.52496225415;4332.090261045216;4353.49934757507;4354.216241076573;4374.759388233614;3797.430385442206;3799.810009499514;3811.02818781209;3851.6340947609933;3866.7873266970587;4425.181341451842;4458.219811532968;4466.7766611669285;4496.527864574238;4510.774461276923;4963.70217786934;5019.523145301264;5061.569766569883;5086.135356989321;5162.6902385856965;4394.033312671208;4394.604485596312;4398.846040388571;4402.933955990663;4428.180786554498;4599.655025873073;4601.056783359403;4605.631549476034;4607.124646317189;4647.790849411785;4762.16662084127;4854.781534831011;4882.36529251195;4890.462049174659;4891.046245982142;5158.509941555546;5170.922436163536;5184.9740751296;5201.583873290052;5234.712090835041;4723.858284251478;4859.478667097327;4889.168841296917;4897.877553061202;4906.362172917497;5029.094762942559;5034.773435195499;5053.469385714447;5073.213651883964;5097.15896877026;5151.356080489939;5156.097682905552;5168.328117344721;5177.964407118516;5220.112580861339;4880.487548807324;4923.778429970732;4960.454350021422;5005.974970125126;5010.023045506091;4928.802847886044;4946.0355230729665;4979.053979743837;4983;5017.824376146963;4903.975480122576;4908.582770464408;4916.582090522345;4963.230699241623;4965.006998600222;4887.682300650446;4982.028504441599;4992.9764398298985;5057;5064.392272927273;4736.621070314435;4781.832635857728;4854.75726213695;4864.294677271705;4929 17:15:47 INFO - PROCESS | 12894 | |1;ext.html;543.4782608695654;591.7396345607934;592.2271435776315;592.6562593695655;607.207594089713;39958.40062399067;40094;41160.38259426111;41213.381799273;41236.58763412365;41741.37387939183;42423.36364954528;42449.575504244945;42521.574784252225;42570.78714606431;7374.3363097321235;7736.65185066672;7907.4069444791585;10034.297599168061;10316.277860549764;9754.219662426989;10230.641927532537;10242.948785256063;10243.078122968931;10246.53890574926;10199.643012494564;10219.233557483218;10227.488625568729;10301.742456438611;10315.329503582243;10038.648647297347;10218.642347517802;10243.48782560869;10244.02681745233;10245.89754102457;9859.90140098597;9901.504924753734;9935.403875767477;9958.751031224205;9964.402135871871;39846.601533984576;40200.39699404511;40249.59750402488;40271.39592906109;40277;3170.4451720948973;3191.6010498687665;3194.88817891375;3199.536067270256;3508.5438892944007;29866.552001719992;30425.543616845764;30733.538996915064;30760;31206.21984450384;3536.451849963234;3540.1149712571855;3597.406427939387;3625.2205775758075;3626.2566173934542;171706;171739;172689;172862;172903;60829;61716.69141654263;61780.38219617746;61850.381496185364;61895.38104618896;64491.130532167284;64662.676686617204;64770.35229647737;64915.35084649093;65072.349276506626;14286.642833929234;14629.341679624229;14639.414423423157;14698;14712;11730.296182229093;11841.763164736829;11854.585089521825;11868.347240901661;11872.168948173718;19091.61816763657;20001.699974500396;20004.69992950107;20042.298519551747;20072.297469588495;7026.348808030109;7314.414846812242;7357.8160545986775;7406.925930740731;7527.322540971339;864.3517361978517;918.4030380252756;973.8247115519133;1009.7728011197422;1010.2574607663362;28009.859950700524;28713.56929646057;29141.56287655687;29395.265118372212;29617.407651846843;933.3793027636546;956.789506308611;985.6254623243265;1053.7681710023783;1069.1607088435542;15204.40353762861;15288.923555382375;15461.149636770086;15564.766528502081;15649.217539122998;416071;449500;455475;456762;667851;51673.224901626505;51919.48080519222;52226.73886630542;52287.73856130695;52329;1090.334895713614;1185.9169858110195;1219.6523990662795;1220.0239808153442;1221.407617305606;26385;29723.108306750833;29768.553471698375;30013.399732005673;30387.088387348416;43940.34089488724;44832;44834.77582612066;44849;44854;312573;322383;322666;322931;323338;22618.321450356514;25592.616110757983;26021.479570408108;26301.210963670354;26419.471610567296;43666.126677466906;44167.55832441634;44376.556234437245;45055.7747211275;45420.772896135306;36565.81717091398;36957.44563831491;37243;37394.43908341323;38053.23893522169;37230.8138459306;37561.4365784508;37803.43294850634;37974.8101259503;38414.423783642706;35856.28287434289;36964;36970.8151459241;37262;37324;29603.407931841673;30984;31165.177836632807;31203.063908082793;31222.21944451407;25469.10858119957;25621.61567576525;25737.227883163534;25836.8708156458;26284.737152628993 17:15:47 INFO - PROCESS | 12894 | |2;jquery.html;355.79186176086995;356.5347221875453;358.98384572694243;377.6657657972695;377.7185996432658;16445.506634800975;16543.503694889157;16794.74807877881;16861.494155175365;16989.320427182913;15971;16007.519774406757;16154.919225403857;16555.337786488555;16580.75128873068;5052.949470505294;5219.086659834514;5235.057689615867;5245.8950820983555;5248.632595718302;3671.2473942841652;5169.147090730025;5686.800961966332;6049.758009679607;6056.666883321438;6153.600015998968;6184.474319682832;6191.133241346215;6206.937930620704;6219.906701399483;5177.559907407875;5553.888922221553;5558.055130627803;5635.6055076144685;5641.915371269434;3420.4698271767916;5045.117104506733;5399.541039011689;5400.972995135038;5445.210444485567;20021.8998905006;20298.797012029987;20554.486137846525;20830.895845520674;20881.164753409845;1829;1904.6381187574455;1918.7505624268756;2019.81821636052;2024.3926821953355;9400.24798016157;9804.31369804114;9855.852162217572;11539.903709147618;12815.16701414405;1747.7815273090864;1825.543614096476;1859.2841755923932;1860.9162587683586;1873.6440076385443;66129.3387066128;66858.3314166857;68607.65696171537;69373;69649.65175174142;10041.246906482043;10222.386656800616;10310.690679279634;10356.948215258875;10435.94782026085;14463.638409039648;14550.054246473945;14573.562793116223;14588.781168282485;14600.926995364955;7131.361998321527;7281.490295679358;7292.34729234725;7305.561666300039;7357.337839594462;6804.897926531106;6831.4629208427705;6832.897506537406;6966.119147830058;6980.825479363057;4498.190325741398;4529.796159172845;4539.6368290536675;4557.612602928722;4618.330342100377;1643.7041332560016;1655.3461382753744;1769.6460707858223;1815.4372144635206;1818.3726614318039;777.5995362388375;843.7637461510786;845.446232717571;862.4264863865459;875.2516598308355;15795.68408631821;15965.441209557843;16873;16935.745963810554;17365.73951390705;861.9784505387415;871.5337294547387;906.4651855405342;909.9863502047475;911.0889110889111;9354.20489258407;9508.952455237679;9542.761430964143;9795.216382689368;9838.989348526133;367070;374523;392035;394002;396703;67221.66389168121;75182.62408688031;76891.61554192305;81617.59191204124;84106.57946710227;960.2941837749248;965.4400447740294;981.4160574458328;999.0259496990521;999.6900960702205;14598.27008649542;15967.041977480923;15971.121588312755;16330.918345408198;16693.499195024167;32471.675283246866;35446.291074177854;36197.36579525108;36857.63142368542;38065.04837379088;44837.77581112074;47268.527314726416;48873.75563122162;48892.26661600007;49236.50763492462;7521.811954701177;7702.460827742004;7711.884321735066;7804.9609751950875;7853.882191767242;10372.948135259276;11422.543098275975;11487.36819474937;11643;11744.823827642764;9599.42403455795;9747.805043898941;9791.951040244754;9855.556499957662;10033.899661003588;9749.853752193865;9778.9022109778;9900.603975841173;9902.504874756378;9962.701118966443;9968.601255949681;9978.101970822661;9999.800004000024;10003.549840257061;10040.297179197387;7753.340966017951;7829.217078292125;7873.5275883447175;7941.801454963672;7971.561564114029;7004;7108.644567771694;9142.131497507726;9686.56410461545;10023.248256380655 17:15:47 INFO - PROCESS | 12894 | |3;mootools.html;1166.912481563883;1370.4244217428682;1433.3764812306647;1498.947536836211;1771.3711632370516;6890.896636550456;7723.536587804736;7936.880946785803;7946.562939038351;8178.877316840238;7927.088384835745;8088.636011379487;8098.392620553453;8107.756767296975;8109.959450202756;2199.670049492573;2202.8678279303213;2227.487677834099;2231.553689262146;2235.2400183937457;2138.957220855582;2182.2798476502717;2193.5283913958497;2203.5372571759867;2207.2274703853604;2136.305700647288;2178.270279456384;2190.9921436139393;2192.9451763705874;2214.5570885822817;2152.9784702152933;2161.2111579273533;2162.2648299578063;2163.707899433572;2166.2309879992613;2081.2403472732494;2103.990084759324;2122.204173434962;2123.6814477828293;2124.5219825539284;7569.621518924032;7928.088269848983;7983.401244906597;7993.840123197561;7999.240072193133;4538.092381523708;4717.363155973934;4724.811007559693;4729.739864307462;4736.976315118402;2856.3144845237202;2872.942541149165;2897.33361326896;2910.577966194911;2973.093206571995;891.9241864441531;910.2035718746097;913.7441516375426;921.2767977137914;929.0709290709291;10862.511186996604;10942.17933654979;10953.561857525689;10965.232433729641;10993.670189894236;3983.541892682321;4047.2310261050307;4126.628603425706;4132.8140233689555;4142.1301526679135;8606.612702428405;8615.870761938577;8643.135686431433;8654.134586541295;8663.047064822864;4375.409319741794;4375.934360984587;4385.342198670161;4386.627136693353;4387.122575484916;3667.211549516867;4121;4147.97926010368;4219.599138081878;4285.61429471349;3462.1344663834043;3464.72282217422;3527.876524321636;3548.982255088708;3555.2711694102645;988.8615593816871;991.1426615977127;996.7109538233976;1002.8595996560488;1033.9534720937577;824.6412810427363;833.6832003838502;849.4181485682327;873.5108339329869;893.41927746965;5467.152591348347;5656.321241451053;5673.063944449203;5696.031674615242;5757.798477053367;914.1909410171912;928.6331898899897;932.5150921520772;935.9578818953163;962.9903700962901;3665.578458477256;3689.1330537323706;3742.101895545104;3780.7542509736777;3811.6378944000276;9590.472524011107;9907.554160062815;9908.058734420218;9936.80126397468;9950.751231219278;9293.72118836436;9678.225741940629;9960.203183745283;9973.800523989625;10025.19798416125;7437.330640242296;7508.1741008489025;7592.354649854824;7618.5809780461495;7633.2366763323225;5499.560035197254;5665.093585026376;5680.971595141998;5734.455226753452;5747.913781293368;9331.346805723535;9450.574724137568;9453.716388508356;9462.101100395452;9468.905310946802;9200;9456.479893605918;9558.952205239208;9572.042795720372;9609.087136722279;6722;6831.9658401707675;6923.89614155778;6933.237343892067;7092.219855815753;7804.570748608881;7826.921730782619;7841.215878412341;7848.921510785048;7889.6449659766595;7051.858962820612;7084.752033678797;7190.89213661785;7195.676194571152;7338.302861228175;6584.308647591934;6719.529632925648;6799.184097908283;7034.366906978396;7065.6820443081215;5974.462298392991;6133.417325354084;6133.662648554194;6134.325224225421;6142.78500252489;4578.267477203632;4600.7469589172915;4611.33135695329;4630.467496237841;4648.9772250104925;4625.236835922035;4747.240441529339;4759.095771803346;4785.138675038526;4851.223804191312 17:15:47 INFO - PROCESS | 12894 | |4;prototype.html;288.4951335163464;299.4520028348122;300.9759219262459;308.96755840636735;312.03736472980853;4738.384010078689;4790.455063253189;4809.8797530061765;4837.32277481153;4844.975775121124;4749.551386827016;4761.166795810736;4761.69049011814;4768.904621907568;4776.952230477694;3564.394053010988;3625.6011838697723;3696.7800625793425;3750.2499500099952;3785.7728536287773;3728.179800443898;3763.5671897731836;3768.9811550942345;3773.547174339083;3797.89860940327;3749.662530372266;3758.661720445173;3762;3764.7929363884973;3777.263433630443;3590.605033446319;3596.766210196342;3728.366177749762;3730.8880733577766;3732.794696291703;3307.4873394623874;3322.5846769153854;3324.5678061852045;3324.8670053197843;3326.234965957819;4519.254323036695;4520.412346394981;4525.570070843265;4530.411046563926;4534.342520334533;3954.4463775071513;4198.244316023115;4251.659867210616;4256.106217694288;4266.509351424595;4921.581665558432;4946.356973593446;4950.331705219785;4960.801567937278;4973.875653108665;3488.1977145256733;3495.4931534927546;3498.8775392861126;3500.3874321993803;3502.404591219499;4954.331165292675;5184.7148406837605;5190.4550022247495;5205.7397130143345;5214.32213812202;3543.94684079739;3546.5921419036627;3573.4997100405963;3579.1588976591;3579.94630080549;3621.1128273572617;3624.9519021752626;3628.38317486028;3629.183433727443;3650.6714395703984;4116.650084742771;4137.110521237948;4141.52372477169;4151.398047283127;4157.64660003897;4690.78039709678;4936.802527898843;4937.407511098691;4943.777530011158;4985.700857948535;1263.5577547858177;1269.8571285842631;1275.8963496575395;1278.6355888571713;1280.9871901281053;799.5282783157965;809.3039985612369;813.4915677701437;853.2363534636465;866.4065115395974;4417.469903611587;4423.911521769546;4428.357888106207;4429.402030725811;4455.866324010285;4985.102681517362;4997.800087996439;5040.445550989388;5044.184093726256;5044.83968687204;4231.788410579458;4414.139242847614;4427.180971520279;4432.822687092545;4442.333649952533;2721.6189733437336;2735.849528275924;2739.5068887600423;2743.7256274372803;2749.175247425764;4858.344123543347;4886.951130488721;4892.0705066037335;4928.408590969107;4940.876478088005;4952.900941981212;5237.8214901646825;5247.580193584504;5253.684778913201;5262.60530460217;4850;4872.049950259665;4893.412790465167;4904.681195722338;4905.8037678492465;5133.8716532087;5153.587712983027;5160.561352285098;5166.147585648326;5166.819161329336;4834.613230941446;5049.166887463674;5057.873553161053;5071.822486212965;5072.695638261716;4889.266610008527;4891.779869905791;4904.5340692634145;4919.557239848431;4920.286558449076;3568.7680300780366;3592.1019745063736;3612.205314830733;3616.4756110364374;3641.399169137063;4963.602911766978;5130.972726091624;5155;5187.429382767968;5193.870153246199;4963.851084467472;4966.329545511309;4993.201087825931;5002.324686167321;5010.849674509771;4957.454679985271;4957.702537847741;4990.850274491771;5030.748462576783;5045.520675535819;4648.488666246642;4920.450058231646;4922.8769280768265;4925.802967881388;4942.654014218971;4797.760111994457;4891.217405215149;5038.236617183957;5070.3155074064525;5075.670081444694;4876.878078047936;4886.951130488792;4899.338589290543;4923.236898280772;4977.129002424634 17:15:47 INFO - PROCESS | 12894 | |5;yui.html;669.63170256359;759.8252401947556;783.7883771381727;786.7757689058619;792.7780221537971;12231.204971676834;12284.324362160078;12351.382430878442;12370.443330050146;12449.813252801192;10943.507542160602;11961.162718609701;12261;12327.137100402975;12329.643739188683;783.2167832167846;796.9920300796975;798.2935102434359;799.8800179973022;799.9640016199285;795.5823192823785;796.2594786848229;804.7907544038534;805.1425232127795;807.3299161695778;831.4595512916623;832.2634468495395;834.8497270491309;834.9916500834975;835.5947365527744;831.4637059096849;832.068083746205;832.2301870769514;833.8457385383723;833.9874901876477;612.6875293600251;614.1678026274378;614.499183165723;614.637363955264;614.9692515374213;11394.316341019565;11467.139964502696;11490.942545287304;11493.942530287295;11500.597479088192;10528.894711052868;10640.467976601216;10696.78606427875;10705.518251678694;10965.232433729641;9292.16370526649;9371.718848434557;9536.2371010319;9596.76008099803;9849.310548261625;3243.3999710053718;3286.8027918324738;3304.306095719902;3356.8153751543655;3399.3711163434846;36223.4566481503;43615.34576981348;44384.3342349865;45927.54072459266;46216.76891615554;10396.790547283608;10435.94782026085;10477.16182705397;10593.523291451904;10781.353118812896;16428.507144785675;16495.752563711554;16511.917440412963;16523.504294871174;16561.751573726404;5394.244805727201;6853.588784672936;6863.725450982005;7019.824504387431;7029.578225306498;3773.8490460381827;3868.187680587052;3898.1618951924906;3962.0689138052535;3999.080211551301;2796.748292653671;2891.6096326996008;2932.017774045676;2932.4135172965493;2935.471615109258;499.21623051808314;521.2858384013925;525.1938274748319;525.584788017462;536.5466181076984;475.55060467857544;527.7862465701397;536.7396812545912;632.2634131237057;657.2408867757747;7698.307152356315;7859.17478664732;7860.371170306362;8006.380380330391;8042.718504852302;620.6865532905944;621.3941407128104;624.6501958902938;626.786892456567;635.3519410201661;3657.9634203658156;3764.7552909060823;3794.4118661607495;3808.3716186829415;3825;43601.04343701795;44709.32936005962;45418;51259.487405126216;52098;47103;47873.281900771515;48807.75596121997;48923.755381222865;49289.50710492849;35745.64254357475;41729.374059389134;43694.344584831255;46369.53630463719;47003.29495057577;7949;8091.959540202261;8216.630251638571;8251.216134467217;8333.250583386976;30504.542431863985;31117.8444107778;31166.37667246597;31241;32115.197120072185;38014.61985380111;40159.1968160641;40332;40552.391714123725;40897.38653920134;11638.127140464669;11658.41707914584;11690.941545292219;11707.239029463057;11761.176717630025;11115.833262500908;11249.156313276373;11319.207655464368;11671.299722016705;11961.162718609614;9937.055979681918;10201.132903702972;10582.417967011581;12080.879191207976;12086.758264834478;11245.212835101463;11683.591074312359;11984.460699268728;12116;12125.393730313626;10267.7433064174;10310.793784124126;10589.099926506333;11138.777224455627;11431.314121152758;8981.14679105484;9038;9240.399374040666;9354.438733676001;9799.069088436587;8816.338774591803;8942.329325300758;9177.678781242625;9192.586333615138;9232.492212928353 17:15:47 INFO - PROCESS | 12894 | __end_tp_report 17:15:47 INFO - PROCESS | 12894 | __start_cc_report 17:15:47 INFO - PROCESS | 12894 | _x_x_mozilla_cycle_collect,1088 17:15:47 INFO - PROCESS | 12894 | __end_cc_report 17:15:47 INFO - PROCESS | 12894 | __startTimestamp1464135347435__endTimestamp 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | ------- Summary: start ------- 17:15:47 INFO - PROCESS | 12894 | Number of tests: 6 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#0] dojo.html Cycles:165 Average:4731.70 Median:4867.08 stddev:493.80 (10.1%) stddev-sans-first:468.30 17:15:47 INFO - PROCESS | 12894 | Values: 2678.2 2697.9 2720.9 2733.1 2755.3 4610.9 4679.0 4710.2 4794.0 4839.9 4694.9 4701.7 4709.4 4751.0 4754.9 4294.3 4327.4 4370.7 4405.2 4526.8 4460.0 4480.7 4480.9 4520.6 4542.3 4271.2 4303.1 4325.3 4358.6 4393.3 4321.4 4343.4 4354.0 4376.3 4413.7 4364.4 4373.5 4375.8 4383.6 4425.2 4509.3 4625.1 4695.1 4755.9 4758.6 5105.1 5105.6 5157.8 5161.1 5173.5 5147.5 5147.8 5190.7 5218.8 5219.0 4677.0 4766.7 4816.1 4862.6 4867.1 5270.1 5277.2 5280.4 5320.4 5341.2 5040.4 5060.6 5114.5 5116.4 5121.3 4999.0 5071.0 5134.7 5138.4 5176.6 5073.0 5093.0 5100.4 5104.4 5163.2 5049.1 5090.2 5101.0 5102.6 5103.9 4318.5 4332.1 4353.5 4354.2 4374.8 3797.4 3799.8 3811.0 3851.6 3866.8 4425.2 4458.2 4466.8 4496.5 4510.8 4963.7 5019.5 5061.6 5086.1 5162.7 4394.0 4394.6 4398.8 4402.9 4428.2 4599.7 4601.1 4605.6 4607.1 4647.8 4762.2 4854.8 4882.4 4890.5 4891.0 5158.5 5170.9 5185.0 5201.6 5234.7 4723.9 4859.5 4889.2 4897.9 4906.4 5029.1 5034.8 5053.5 5073.2 5097.2 5151.4 5156.1 5168.3 5178.0 5220.1 4880.5 4923.8 4960.5 5006.0 5010.0 4928.8 4946.0 4979.1 4983.0 5017.8 4904.0 4908.6 4916.6 4963.2 4965.0 4887.7 4982.0 4993.0 5057.0 5064.4 4736.6 4781.8 4854.8 4864.3 4929.0 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#1] ext.html Cycles:180 Average:49576.78 Median:3538.28 stddev:94836.18 (2680.3%) stddev-sans-first:95030.76 17:15:47 INFO - PROCESS | 12894 | Values: 543.5 591.7 592.2 592.7 607.2 39958.4 40094.0 41160.4 41213.4 41236.6 41741.4 42423.4 42449.6 42521.6 42570.8 7374.3 7736.7 7907.4 10034.3 10316.3 9754.2 10230.6 10242.9 10243.1 10246.5 10199.6 10219.2 10227.5 10301.7 10315.3 10038.6 10218.6 10243.5 10244.0 10245.9 9859.9 9901.5 9935.4 9958.8 9964.4 39846.6 40200.4 40249.6 40271.4 40277.0 3170.4 3191.6 3194.9 3199.5 3508.5 29866.6 30425.5 30733.5 30760.0 31206.2 3536.5 3540.1 3597.4 3625.2 3626.3 171706.0 171739.0 172689.0 172862.0 172903.0 60829.0 61716.7 61780.4 61850.4 61895.4 64491.1 64662.7 64770.4 64915.4 65072.3 14286.6 14629.3 14639.4 14698.0 14712.0 11730.3 11841.8 11854.6 11868.3 11872.2 19091.6 20001.7 20004.7 20042.3 20072.3 7026.3 7314.4 7357.8 7406.9 7527.3 864.4 918.4 973.8 1009.8 1010.3 28009.9 28713.6 29141.6 29395.3 29617.4 933.4 956.8 985.6 1053.8 1069.2 15204.4 15288.9 15461.1 15564.8 15649.2 416071.0 449500.0 455475.0 456762.0 667851.0 51673.2 51919.5 52226.7 52287.7 52329.0 1090.3 1185.9 1219.7 1220.0 1221.4 26385.0 29723.1 29768.6 30013.4 30387.1 43940.3 44832.0 44834.8 44849.0 44854.0 312573.0 322383.0 322666.0 322931.0 323338.0 22618.3 25592.6 26021.5 26301.2 26419.5 43666.1 44167.6 44376.6 45055.8 45420.8 36565.8 36957.4 37243.0 37394.4 38053.2 37230.8 37561.4 37803.4 37974.8 38414.4 35856.3 36964.0 36970.8 37262.0 37324.0 29603.4 30984.0 31165.2 31203.1 31222.2 25469.1 25621.6 25737.2 25836.9 26284.7 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#2] jquery.html Cycles:180 Average:24011.00 Median:5173.35 stddev:63556.53 (1228.5%) stddev-sans-first:63710.01 17:15:47 INFO - PROCESS | 12894 | Values: 355.8 356.5 359.0 377.7 377.7 16445.5 16543.5 16794.7 16861.5 16989.3 15971.0 16007.5 16154.9 16555.3 16580.8 5052.9 5219.1 5235.1 5245.9 5248.6 3671.2 5169.1 5686.8 6049.8 6056.7 6153.6 6184.5 6191.1 6206.9 6219.9 5177.6 5553.9 5558.1 5635.6 5641.9 3420.5 5045.1 5399.5 5401.0 5445.2 20021.9 20298.8 20554.5 20830.9 20881.2 1829.0 1904.6 1918.8 2019.8 2024.4 9400.2 9804.3 9855.9 11539.9 12815.2 1747.8 1825.5 1859.3 1860.9 1873.6 66129.3 66858.3 68607.7 69373.0 69649.7 10041.2 10222.4 10310.7 10356.9 10435.9 14463.6 14550.1 14573.6 14588.8 14600.9 7131.4 7281.5 7292.3 7305.6 7357.3 6804.9 6831.5 6832.9 6966.1 6980.8 4498.2 4529.8 4539.6 4557.6 4618.3 1643.7 1655.3 1769.6 1815.4 1818.4 777.6 843.8 845.4 862.4 875.3 15795.7 15965.4 16873.0 16935.7 17365.7 862.0 871.5 906.5 910.0 911.1 9354.2 9509.0 9542.8 9795.2 9839.0 367070.0 374523.0 392035.0 394002.0 396703.0 67221.7 75182.6 76891.6 81617.6 84106.6 960.3 965.4 981.4 999.0 999.7 14598.3 15967.0 15971.1 16330.9 16693.5 32471.7 35446.3 36197.4 36857.6 38065.0 44837.8 47268.5 48873.8 48892.3 49236.5 7521.8 7702.5 7711.9 7805.0 7853.9 10372.9 11422.5 11487.4 11643.0 11744.8 9599.4 9747.8 9792.0 9855.6 10033.9 9749.9 9778.9 9900.6 9902.5 9962.7 9968.6 9978.1 9999.8 10003.5 10040.3 7753.3 7829.2 7873.5 7941.8 7971.6 7004.0 7108.6 9142.1 9686.6 10023.2 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#3] mootools.html Cycles:180 Average:5231.84 Median:5741.18 stddev:2974.05 (51.8%) stddev-sans-first:2966.70 17:15:47 INFO - PROCESS | 12894 | Values: 1166.9 1370.4 1433.4 1498.9 1771.4 6890.9 7723.5 7936.9 7946.6 8178.9 7927.1 8088.6 8098.4 8107.8 8110.0 2199.7 2202.9 2227.5 2231.6 2235.2 2139.0 2182.3 2193.5 2203.5 2207.2 2136.3 2178.3 2191.0 2192.9 2214.6 2153.0 2161.2 2162.3 2163.7 2166.2 2081.2 2104.0 2122.2 2123.7 2124.5 7569.6 7928.1 7983.4 7993.8 7999.2 4538.1 4717.4 4724.8 4729.7 4737.0 2856.3 2872.9 2897.3 2910.6 2973.1 891.9 910.2 913.7 921.3 929.1 10862.5 10942.2 10953.6 10965.2 10993.7 3983.5 4047.2 4126.6 4132.8 4142.1 8606.6 8615.9 8643.1 8654.1 8663.0 4375.4 4375.9 4385.3 4386.6 4387.1 3667.2 4121.0 4148.0 4219.6 4285.6 3462.1 3464.7 3527.9 3549.0 3555.3 988.9 991.1 996.7 1002.9 1034.0 824.6 833.7 849.4 873.5 893.4 5467.2 5656.3 5673.1 5696.0 5757.8 914.2 928.6 932.5 936.0 963.0 3665.6 3689.1 3742.1 3780.8 3811.6 9590.5 9907.6 9908.1 9936.8 9950.8 9293.7 9678.2 9960.2 9973.8 10025.2 7437.3 7508.2 7592.4 7618.6 7633.2 5499.6 5665.1 5681.0 5734.5 5747.9 9331.3 9450.6 9453.7 9462.1 9468.9 9200.0 9456.5 9559.0 9572.0 9609.1 6722.0 6832.0 6923.9 6933.2 7092.2 7804.6 7826.9 7841.2 7848.9 7889.6 7051.9 7084.8 7190.9 7195.7 7338.3 6584.3 6719.5 6799.2 7034.4 7065.7 5974.5 6133.4 6133.7 6134.3 6142.8 4578.3 4600.7 4611.3 4630.5 4649.0 4625.2 4747.2 4759.1 4785.1 4851.2 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#4] prototype.html Cycles:180 Average:4134.43 Median:4765.30 stddev:1201.70 (25.2%) stddev-sans-first:1169.88 17:15:47 INFO - PROCESS | 12894 | Values: 288.5 299.5 301.0 309.0 312.0 4738.4 4790.5 4809.9 4837.3 4845.0 4749.6 4761.2 4761.7 4768.9 4777.0 3564.4 3625.6 3696.8 3750.2 3785.8 3728.2 3763.6 3769.0 3773.5 3797.9 3749.7 3758.7 3762.0 3764.8 3777.3 3590.6 3596.8 3728.4 3730.9 3732.8 3307.5 3322.6 3324.6 3324.9 3326.2 4519.3 4520.4 4525.6 4530.4 4534.3 3954.4 4198.2 4251.7 4256.1 4266.5 4921.6 4946.4 4950.3 4960.8 4973.9 3488.2 3495.5 3498.9 3500.4 3502.4 4954.3 5184.7 5190.5 5205.7 5214.3 3543.9 3546.6 3573.5 3579.2 3579.9 3621.1 3625.0 3628.4 3629.2 3650.7 4116.7 4137.1 4141.5 4151.4 4157.6 4690.8 4936.8 4937.4 4943.8 4985.7 1263.6 1269.9 1275.9 1278.6 1281.0 799.5 809.3 813.5 853.2 866.4 4417.5 4423.9 4428.4 4429.4 4455.9 4985.1 4997.8 5040.4 5044.2 5044.8 4231.8 4414.1 4427.2 4432.8 4442.3 2721.6 2735.8 2739.5 2743.7 2749.2 4858.3 4887.0 4892.1 4928.4 4940.9 4952.9 5237.8 5247.6 5253.7 5262.6 4850.0 4872.0 4893.4 4904.7 4905.8 5133.9 5153.6 5160.6 5166.1 5166.8 4834.6 5049.2 5057.9 5071.8 5072.7 4889.3 4891.8 4904.5 4919.6 4920.3 3568.8 3592.1 3612.2 3616.5 3641.4 4963.6 5131.0 5155.0 5187.4 5193.9 4963.9 4966.3 4993.2 5002.3 5010.8 4957.5 4957.7 4990.9 5030.7 5045.5 4648.5 4920.5 4922.9 4925.8 4942.7 4797.8 4891.2 5038.2 5070.3 5075.7 4876.9 4887.0 4899.3 4923.2 4977.1 17:15:47 INFO - PROCESS | 12894 | 17:15:47 INFO - PROCESS | 12894 | [#5] yui.html Cycles:180 Average:12618.43 Median:44546.83 stddev:14229.05 (31.9%) stddev-sans-first:14240.67 17:15:47 INFO - PROCESS | 12894 | Values: 669.6 759.8 783.8 786.8 792.8 12231.2 12284.3 12351.4 12370.4 12449.8 10943.5 11961.2 12261.0 12327.1 12329.6 783.2 797.0 798.3 799.9 800.0 795.6 796.3 804.8 805.1 807.3 831.5 832.3 834.8 835.0 835.6 831.5 832.1 832.2 833.8 834.0 612.7 614.2 614.5 614.6 615.0 11394.3 11467.1 11490.9 11493.9 11500.6 10528.9 10640.5 10696.8 10705.5 10965.2 9292.2 9371.7 9536.2 9596.8 9849.3 3243.4 3286.8 3304.3 3356.8 3399.4 36223.5 43615.3 44384.3 45927.5 46216.8 10396.8 10435.9 10477.2 10593.5 10781.4 16428.5 16495.8 16511.9 16523.5 16561.8 5394.2 6853.6 6863.7 7019.8 7029.6 3773.8 3868.2 3898.2 3962.1 3999.1 2796.7 2891.6 2932.0 2932.4 2935.5 499.2 521.3 525.2 525.6 536.5 475.6 527.8 536.7 632.3 657.2 7698.3 7859.2 7860.4 8006.4 8042.7 620.7 621.4 624.7 626.8 635.4 3658.0 3764.8 3794.4 3808.4 3825.0 43601.0 44709.3 45418.0 51259.5 52098.0 47103.0 47873.3 48807.8 48923.8 49289.5 35745.6 41729.4 43694.3 46369.5 47003.3 7949.0 8092.0 8216.6 8251.2 8333.3 30504.5 31117.8 31166.4 31241.0 32115.2 38014.6 40159.2 40332.0 40552.4 40897.4 11638.1 11658.4 11690.9 11707.2 11761.2 11115.8 11249.2 11319.2 11671.3 11961.2 9937.1 10201.1 10582.4 12080.9 12086.8 11245.2 11683.6 11984.5 12116.0 12125.4 10267.7 10310.8 10589.1 11138.8 11431.3 8981.1 9038.0 9240.4 9354.4 9799.1 8816.3 8942.3 9177.7 9192.6 9232.5 17:15:47 INFO - PROCESS | 12894 | -------- Summary: end -------- 17:15:47 INFO - PROCESS | 12894 | 17:15:48 INFO - TEST-INFO | 12894: exit 0 17:15:48 INFO - TEST-OK | dromaeo_css | took 1118834ms 17:15:48 INFO - TEST-START | kraken 17:15:48 INFO - operating with platform_type : linux_ 17:15:48 INFO - Initialising browser for kraken test... 17:15:48 INFO - TEST-INFO | started process 13075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppzjTK1/profile http://localhost:33673/getInfo.html) 17:15:52 INFO - PROCESS | 13075 | __metrics Screen width/height:1600/1200 17:15:52 INFO - PROCESS | 13075 | colorDepth:24 17:15:52 INFO - PROCESS | 13075 | Browser inner width/height: 1024/697 17:15:52 INFO - PROCESS | 13075 | __metrics 17:15:53 ERROR - PROCESS | 13075 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:15:54 INFO - TEST-INFO | 13075: exit 0 17:15:54 INFO - Browser initialized. 17:15:54 INFO - Running cycle 1/1 for kraken test... 17:15:54 INFO - TEST-INFO | started process 13156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppzjTK1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:06 INFO - PROCESS | 13156 | RSS: Main: 154746880 17:16:06 INFO - PROCESS | 13156 | 17:16:09 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33673/tests/kraken/driver.html?testName=audio-beat-detection) 17:16:10 INFO - PROCESS | 13156 | RSS: Main: 209682432 17:16:10 INFO - PROCESS | 13156 | 17:16:12 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33673/tests/kraken/driver.html?testName=audio-dft) 17:16:13 INFO - PROCESS | 13156 | RSS: Main: 196337664 17:16:13 INFO - PROCESS | 13156 | 17:16:16 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33673/tests/kraken/driver.html?testName=audio-fft) 17:16:17 INFO - PROCESS | 13156 | RSS: Main: 267382784 17:16:17 INFO - PROCESS | 13156 | 17:16:19 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33673/tests/kraken/driver.html?testName=audio-oscillator) 17:16:20 INFO - PROCESS | 13156 | RSS: Main: 176177152 17:16:20 INFO - PROCESS | 13156 | 17:16:22 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33673/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:22 INFO - PROCESS | 13156 | RSS: Main: 179888128 17:16:22 INFO - PROCESS | 13156 | 17:16:26 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33673/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:26 INFO - PROCESS | 13156 | RSS: Main: 216199168 17:16:26 INFO - PROCESS | 13156 | 17:16:30 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33673/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:30 INFO - PROCESS | 13156 | RSS: Main: 217030656 17:16:30 INFO - PROCESS | 13156 | 17:16:33 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33673/tests/kraken/driver.html?testName=json-parse-financial) 17:16:34 INFO - PROCESS | 13156 | RSS: Main: 217591808 17:16:34 INFO - PROCESS | 13156 | 17:16:36 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33673/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:36 INFO - PROCESS | 13156 | RSS: Main: 204423168 17:16:36 INFO - PROCESS | 13156 | 17:16:38 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:39 INFO - PROCESS | 13156 | RSS: Main: 208216064 17:16:39 INFO - PROCESS | 13156 | 17:16:41 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:42 INFO - PROCESS | 13156 | RSS: Main: 218505216 17:16:42 INFO - PROCESS | 13156 | 17:16:44 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:45 INFO - PROCESS | 13156 | RSS: Main: 224546816 17:16:45 INFO - PROCESS | 13156 | 17:16:48 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:49 INFO - PROCESS | 13156 | RSS: Main: 220127232 17:16:49 INFO - PROCESS | 13156 | 17:16:50 INFO - PROCESS | 13156 | Cycle 1(1): loaded http://localhost:33673/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33673/tests/kraken/driver.html?testName=ai-astar) 17:16:51 INFO - PROCESS | 13156 | RSS: Main: 265433088 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | __start_tp_report 17:16:51 INFO - PROCESS | 13156 | _x_x_mozilla_page_load 17:16:51 INFO - PROCESS | 13156 | _x_x_mozilla_page_load_details 17:16:51 INFO - PROCESS | 13156 | |i|pagename|runs| 17:16:51 INFO - PROCESS | 13156 | |0;ai-astar;114;110;118;113;113;112;113;112;114;112 17:16:51 INFO - PROCESS | 13156 | |1;audio-beat-detection;168;135;130;186;132;131;168;131;198;132 17:16:51 INFO - PROCESS | 13156 | |2;audio-dft;163;161;162;161;162;162;162;161;162;161 17:16:51 INFO - PROCESS | 13156 | |3;audio-fft;75;77;75;110;75;77;76;76;108;75 17:16:51 INFO - PROCESS | 13156 | |4;audio-oscillator;87;85;120;84;85;85;115;85;85;123 17:16:51 INFO - PROCESS | 13156 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;118 17:16:51 INFO - PROCESS | 13156 | |6;imaging-darkroom;146;145;145;146;146;145;146;145;147;147 17:16:51 INFO - PROCESS | 13156 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 17:16:51 INFO - PROCESS | 13156 | |8;json-parse-financial;63;64;65;65;65;65;65;80;62;62 17:16:51 INFO - PROCESS | 13156 | |9;json-stringify-tinderbox;67;65;66;65;66;66;66;66;66;66 17:16:51 INFO - PROCESS | 13156 | |10;stanford-crypto-aes;82;82;89;89;91;86;84;84;85;83 17:16:51 INFO - PROCESS | 13156 | |11;stanford-crypto-ccm;129;129;130;127;124;128;127;127;169;141 17:16:51 INFO - PROCESS | 13156 | |12;stanford-crypto-pbkdf2;171;171;167;168;166;167;168;176;170;170 17:16:51 INFO - PROCESS | 13156 | |13;stanford-crypto-sha256-iterative;66;69;66;66;65;68;65;66;64;66 17:16:51 INFO - PROCESS | 13156 | __end_tp_report 17:16:51 INFO - PROCESS | 13156 | __start_cc_report 17:16:51 INFO - PROCESS | 13156 | _x_x_mozilla_cycle_collect,1903 17:16:51 INFO - PROCESS | 13156 | __end_cc_report 17:16:51 INFO - PROCESS | 13156 | __startTimestamp1464135411004__endTimestamp 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | ------- Summary: start ------- 17:16:51 INFO - PROCESS | 13156 | Number of tests: 14 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:2.08 (1.8%) stddev-sans-first:2.18 17:16:51 INFO - PROCESS | 13156 | Values: 114.0 110.0 118.0 113.0 113.0 112.0 113.0 112.0 114.0 112.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:151.50 stddev:26.31 (17.4%) stddev-sans-first:27.19 17:16:51 INFO - PROCESS | 13156 | Values: 168.0 135.0 130.0 186.0 132.0 131.0 168.0 131.0 198.0 132.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.53 17:16:51 INFO - PROCESS | 13156 | Values: 163.0 161.0 162.0 161.0 162.0 162.0 162.0 161.0 162.0 161.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:14.05 (18.6%) stddev-sans-first:14.64 17:16:51 INFO - PROCESS | 13156 | Values: 75.0 77.0 75.0 110.0 75.0 77.0 76.0 76.0 108.0 75.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:16.64 (19.6%) stddev-sans-first:17.37 17:16:51 INFO - PROCESS | 13156 | Values: 87.0 85.0 120.0 84.0 85.0 85.0 115.0 85.0 85.0 123.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:16:51 INFO - PROCESS | 13156 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:16:51 INFO - PROCESS | 13156 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 147.0 147.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:16:51 INFO - PROCESS | 13156 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:5.21 (8.0%) stddev-sans-first:5.44 17:16:51 INFO - PROCESS | 13156 | Values: 63.0 64.0 65.0 65.0 65.0 65.0 65.0 80.0 62.0 62.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 17:16:51 INFO - PROCESS | 13156 | Values: 67.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:3.17 (3.7%) stddev-sans-first:3.10 17:16:51 INFO - PROCESS | 13156 | Values: 82.0 82.0 89.0 89.0 91.0 86.0 84.0 84.0 85.0 83.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:129.00 stddev:13.40 (10.4%) stddev-sans-first:14.13 17:16:51 INFO - PROCESS | 13156 | Values: 129.0 129.0 130.0 127.0 124.0 128.0 127.0 127.0 169.0 141.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:2.91 (1.7%) stddev-sans-first:3.03 17:16:51 INFO - PROCESS | 13156 | Values: 171.0 171.0 167.0 168.0 166.0 167.0 168.0 176.0 170.0 170.0 17:16:51 INFO - PROCESS | 13156 | 17:16:51 INFO - PROCESS | 13156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 17:16:51 INFO - PROCESS | 13156 | Values: 66.0 69.0 66.0 66.0 65.0 68.0 65.0 66.0 64.0 66.0 17:16:51 INFO - PROCESS | 13156 | -------- Summary: end -------- 17:16:51 INFO - PROCESS | 13156 | 17:16:52 INFO - TEST-INFO | 13156: exit 0 17:16:52 INFO - TEST-OK | kraken | took 63929ms 17:16:52 INFO - SUITE-END | took 1182s 17:16:52 INFO - Completed test suite (00:19:42) 17:16:52 INFO - javascript benchmark 17:16:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.196541037689, 2697.905573304932, 2720.878332602718, 2733.1253998720404, 2755.2836262571736, 4610.907781844361, 4679.0, 4710.199266124759, 4793.999999999995, 4839.8790030249265, 4694.90610187796, 4701.670883038189, 4709.4348678158585, 4751.02603966187, 4754.881127971802, 4294.312909934419, 4327.394164816928, 4370.694051416386, 4405.207062728708, 4526.75102869342, 4460.0, 4480.6639502037315, 4480.8879778005485, 4520.593146616804, 4542.273236282195, 4271.209826182167, 4303.053328267776, 4325.264705000158, 4358.585934336233, 4393.319035549479, 4321.351797230409, 4343.370211319341, 4353.978230108861, 4376.277914144162, 4413.713108647928, 4364.388985542027, 4373.475182978032, 4375.781210939472, 4383.649308055348, 4425.203463376591, 4509.3461448090175, 4625.1443482955765, 4695.131400690883, 4755.881102972453, 4758.619310455155, 5105.132127538327, 5105.617078719111, 5157.7936882524655, 5161.122609156452, 5173.482651734834, 5147.536721695065, 5147.7683504242395, 5190.662606930538, 5218.817341393033, 5219.0, 4676.95323046772, 4766.713997160182, 4816.084943860656, 4862.635302352338, 4867.075255701406, 5270.077736396115, 5277.23480095384, 5280.419153893069, 5320.388155362183, 5341.225522299323, 5040.36995375578, 5060.620453466005, 5114.462981386975, 5116.437191908887, 5121.257417674491, 4999.0251900878975, 5071.0, 5134.743262836918, 5138.434772175057, 5176.559992400613, 5073.0, 5093.0, 5100.387953445536, 5104.412992505835, 5163.199704045879, 5049.091163590516, 5090.211017292326, 5101.0308041472, 5102.617303702237, 5103.897922041539, 4318.52496225415, 4332.090261045216, 4353.49934757507, 4354.216241076573, 4374.759388233614, 3797.430385442206, 3799.810009499514, 3811.02818781209, 3851.6340947609933, 3866.7873266970587, 4425.181341451842, 4458.219811532968, 4466.7766611669285, 4496.527864574238, 4510.774461276923, 4963.70217786934, 5019.523145301264, 5061.569766569883, 5086.135356989321, 5162.6902385856965, 4394.033312671208, 4394.604485596312, 4398.846040388571, 4402.933955990663, 4428.180786554498, 4599.655025873073, 4601.056783359403, 4605.631549476034, 4607.124646317189, 4647.790849411785, 4762.16662084127, 4854.781534831011, 4882.36529251195, 4890.462049174659, 4891.046245982142, 5158.509941555546, 5170.922436163536, 5184.9740751296, 5201.583873290052, 5234.712090835041, 4723.858284251478, 4859.478667097327, 4889.168841296917, 4897.877553061202, 4906.362172917497, 5029.094762942559, 5034.773435195499, 5053.469385714447, 5073.213651883964, 5097.15896877026, 5151.356080489939, 5156.097682905552, 5168.328117344721, 5177.964407118516, 5220.112580861339, 4880.487548807324, 4923.778429970732, 4960.454350021422, 5005.974970125126, 5010.023045506091, 4928.802847886044, 4946.0355230729665, 4979.053979743837, 4983.0, 5017.824376146963, 4903.975480122576, 4908.582770464408, 4916.582090522345, 4963.230699241623, 4965.006998600222, 4887.682300650446, 4982.028504441599, 4992.9764398298985, 5057.0, 5064.392272927273, 4736.621070314435, 4781.832635857728, 4854.75726213695, 4864.294677271705, 4929.0], "value": 4700.739382471566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.4782608695654, 591.7396345607934, 592.2271435776315, 592.6562593695655, 607.207594089713, 39958.40062399067, 40094.0, 41160.38259426111, 41213.381799273, 41236.58763412365, 41741.37387939183, 42423.36364954528, 42449.575504244945, 42521.574784252225, 42570.78714606431, 7374.3363097321235, 7736.65185066672, 7907.4069444791585, 10034.297599168061, 10316.277860549764, 9754.219662426989, 10230.641927532537, 10242.948785256063, 10243.078122968931, 10246.53890574926, 10199.643012494564, 10219.233557483218, 10227.488625568729, 10301.742456438611, 10315.329503582243, 10038.648647297347, 10218.642347517802, 10243.48782560869, 10244.02681745233, 10245.89754102457, 9859.90140098597, 9901.504924753734, 9935.403875767477, 9958.751031224205, 9964.402135871871, 39846.601533984576, 40200.39699404511, 40249.59750402488, 40271.39592906109, 40277.0, 3170.4451720948973, 3191.6010498687665, 3194.88817891375, 3199.536067270256, 3508.5438892944007, 29866.552001719992, 30425.543616845764, 30733.538996915064, 30760.0, 31206.21984450384, 3536.451849963234, 3540.1149712571855, 3597.406427939387, 3625.2205775758075, 3626.2566173934542, 171706.0, 171739.0, 172689.0, 172862.0, 172903.0, 60829.0, 61716.69141654263, 61780.38219617746, 61850.381496185364, 61895.38104618896, 64491.130532167284, 64662.676686617204, 64770.35229647737, 64915.35084649093, 65072.349276506626, 14286.642833929234, 14629.341679624229, 14639.414423423157, 14698.0, 14712.0, 11730.296182229093, 11841.763164736829, 11854.585089521825, 11868.347240901661, 11872.168948173718, 19091.61816763657, 20001.699974500396, 20004.69992950107, 20042.298519551747, 20072.297469588495, 7026.348808030109, 7314.414846812242, 7357.8160545986775, 7406.925930740731, 7527.322540971339, 864.3517361978517, 918.4030380252756, 973.8247115519133, 1009.7728011197422, 1010.2574607663362, 28009.859950700524, 28713.56929646057, 29141.56287655687, 29395.265118372212, 29617.407651846843, 933.3793027636546, 956.789506308611, 985.6254623243265, 1053.7681710023783, 1069.1607088435542, 15204.40353762861, 15288.923555382375, 15461.149636770086, 15564.766528502081, 15649.217539122998, 416071.0, 449500.0, 455475.0, 456762.0, 667851.0, 51673.224901626505, 51919.48080519222, 52226.73886630542, 52287.73856130695, 52329.0, 1090.334895713614, 1185.9169858110195, 1219.6523990662795, 1220.0239808153442, 1221.407617305606, 26385.0, 29723.108306750833, 29768.553471698375, 30013.399732005673, 30387.088387348416, 43940.34089488724, 44832.0, 44834.77582612066, 44849.0, 44854.0, 312573.0, 322383.0, 322666.0, 322931.0, 323338.0, 22618.321450356514, 25592.616110757983, 26021.479570408108, 26301.210963670354, 26419.471610567296, 43666.126677466906, 44167.55832441634, 44376.556234437245, 45055.7747211275, 45420.772896135306, 36565.81717091398, 36957.44563831491, 37243.0, 37394.43908341323, 38053.23893522169, 37230.8138459306, 37561.4365784508, 37803.43294850634, 37974.8101259503, 38414.423783642706, 35856.28287434289, 36964.0, 36970.8151459241, 37262.0, 37324.0, 29603.407931841673, 30984.0, 31165.177836632807, 31203.063908082793, 31222.21944451407, 25469.10858119957, 25621.61567576525, 25737.227883163534, 25836.8708156458, 26284.737152628993], "value": 18672.417555501943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.79186176086995, 356.5347221875453, 358.98384572694243, 377.6657657972695, 377.7185996432658, 16445.506634800975, 16543.503694889157, 16794.74807877881, 16861.494155175365, 16989.320427182913, 15971.0, 16007.519774406757, 16154.919225403857, 16555.337786488555, 16580.75128873068, 5052.949470505294, 5219.086659834514, 5235.057689615867, 5245.8950820983555, 5248.632595718302, 3671.2473942841652, 5169.147090730025, 5686.800961966332, 6049.758009679607, 6056.666883321438, 6153.600015998968, 6184.474319682832, 6191.133241346215, 6206.937930620704, 6219.906701399483, 5177.559907407875, 5553.888922221553, 5558.055130627803, 5635.6055076144685, 5641.915371269434, 3420.4698271767916, 5045.117104506733, 5399.541039011689, 5400.972995135038, 5445.210444485567, 20021.8998905006, 20298.797012029987, 20554.486137846525, 20830.895845520674, 20881.164753409845, 1829.0, 1904.6381187574455, 1918.7505624268756, 2019.81821636052, 2024.3926821953355, 9400.24798016157, 9804.31369804114, 9855.852162217572, 11539.903709147618, 12815.16701414405, 1747.7815273090864, 1825.543614096476, 1859.2841755923932, 1860.9162587683586, 1873.6440076385443, 66129.3387066128, 66858.3314166857, 68607.65696171537, 69373.0, 69649.65175174142, 10041.246906482043, 10222.386656800616, 10310.690679279634, 10356.948215258875, 10435.94782026085, 14463.638409039648, 14550.054246473945, 14573.562793116223, 14588.781168282485, 14600.926995364955, 7131.361998321527, 7281.490295679358, 7292.34729234725, 7305.561666300039, 7357.337839594462, 6804.897926531106, 6831.4629208427705, 6832.897506537406, 6966.119147830058, 6980.825479363057, 4498.190325741398, 4529.796159172845, 4539.6368290536675, 4557.612602928722, 4618.330342100377, 1643.7041332560016, 1655.3461382753744, 1769.6460707858223, 1815.4372144635206, 1818.3726614318039, 777.5995362388375, 843.7637461510786, 845.446232717571, 862.4264863865459, 875.2516598308355, 15795.68408631821, 15965.441209557843, 16873.0, 16935.745963810554, 17365.73951390705, 861.9784505387415, 871.5337294547387, 906.4651855405342, 909.9863502047475, 911.0889110889111, 9354.20489258407, 9508.952455237679, 9542.761430964143, 9795.216382689368, 9838.989348526133, 367070.0, 374523.0, 392035.0, 394002.0, 396703.0, 67221.66389168121, 75182.62408688031, 76891.61554192305, 81617.59191204124, 84106.57946710227, 960.2941837749248, 965.4400447740294, 981.4160574458328, 999.0259496990521, 999.6900960702205, 14598.27008649542, 15967.041977480923, 15971.121588312755, 16330.918345408198, 16693.499195024167, 32471.675283246866, 35446.291074177854, 36197.36579525108, 36857.63142368542, 38065.04837379088, 44837.77581112074, 47268.527314726416, 48873.75563122162, 48892.26661600007, 49236.50763492462, 7521.811954701177, 7702.460827742004, 7711.884321735066, 7804.9609751950875, 7853.882191767242, 10372.948135259276, 11422.543098275975, 11487.36819474937, 11643.0, 11744.823827642764, 9599.42403455795, 9747.805043898941, 9791.951040244754, 9855.556499957662, 10033.899661003588, 9749.853752193865, 9778.9022109778, 9900.603975841173, 9902.504874756378, 9962.701118966443, 9968.601255949681, 9978.101970822661, 9999.800004000024, 10003.549840257061, 10040.297179197387, 7753.340966017951, 7829.217078292125, 7873.5275883447175, 7941.801454963672, 7971.561564114029, 7004.0, 7108.644567771694, 9142.131497507726, 9686.56410461545, 10023.248256380655], "value": 8202.092740267617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1166.912481563883, 1370.4244217428682, 1433.3764812306647, 1498.947536836211, 1771.3711632370516, 6890.896636550456, 7723.536587804736, 7936.880946785803, 7946.562939038351, 8178.877316840238, 7927.088384835745, 8088.636011379487, 8098.392620553453, 8107.756767296975, 8109.959450202756, 2199.670049492573, 2202.8678279303213, 2227.487677834099, 2231.553689262146, 2235.2400183937457, 2138.957220855582, 2182.2798476502717, 2193.5283913958497, 2203.5372571759867, 2207.2274703853604, 2136.305700647288, 2178.270279456384, 2190.9921436139393, 2192.9451763705874, 2214.5570885822817, 2152.9784702152933, 2161.2111579273533, 2162.2648299578063, 2163.707899433572, 2166.2309879992613, 2081.2403472732494, 2103.990084759324, 2122.204173434962, 2123.6814477828293, 2124.5219825539284, 7569.621518924032, 7928.088269848983, 7983.401244906597, 7993.840123197561, 7999.240072193133, 4538.092381523708, 4717.363155973934, 4724.811007559693, 4729.739864307462, 4736.976315118402, 2856.3144845237202, 2872.942541149165, 2897.33361326896, 2910.577966194911, 2973.093206571995, 891.9241864441531, 910.2035718746097, 913.7441516375426, 921.2767977137914, 929.0709290709291, 10862.511186996604, 10942.17933654979, 10953.561857525689, 10965.232433729641, 10993.670189894236, 3983.541892682321, 4047.2310261050307, 4126.628603425706, 4132.8140233689555, 4142.1301526679135, 8606.612702428405, 8615.870761938577, 8643.135686431433, 8654.134586541295, 8663.047064822864, 4375.409319741794, 4375.934360984587, 4385.342198670161, 4386.627136693353, 4387.122575484916, 3667.211549516867, 4121.0, 4147.97926010368, 4219.599138081878, 4285.61429471349, 3462.1344663834043, 3464.72282217422, 3527.876524321636, 3548.982255088708, 3555.2711694102645, 988.8615593816871, 991.1426615977127, 996.7109538233976, 1002.8595996560488, 1033.9534720937577, 824.6412810427363, 833.6832003838502, 849.4181485682327, 873.5108339329869, 893.41927746965, 5467.152591348347, 5656.321241451053, 5673.063944449203, 5696.031674615242, 5757.798477053367, 914.1909410171912, 928.6331898899897, 932.5150921520772, 935.9578818953163, 962.9903700962901, 3665.578458477256, 3689.1330537323706, 3742.101895545104, 3780.7542509736777, 3811.6378944000276, 9590.472524011107, 9907.554160062815, 9908.058734420218, 9936.80126397468, 9950.751231219278, 9293.72118836436, 9678.225741940629, 9960.203183745283, 9973.800523989625, 10025.19798416125, 7437.330640242296, 7508.1741008489025, 7592.354649854824, 7618.5809780461495, 7633.2366763323225, 5499.560035197254, 5665.093585026376, 5680.971595141998, 5734.455226753452, 5747.913781293368, 9331.346805723535, 9450.574724137568, 9453.716388508356, 9462.101100395452, 9468.905310946802, 9200.0, 9456.479893605918, 9558.952205239208, 9572.042795720372, 9609.087136722279, 6722.0, 6831.9658401707675, 6923.89614155778, 6933.237343892067, 7092.219855815753, 7804.570748608881, 7826.921730782619, 7841.215878412341, 7848.921510785048, 7889.6449659766595, 7051.858962820612, 7084.752033678797, 7190.89213661785, 7195.676194571152, 7338.302861228175, 6584.308647591934, 6719.529632925648, 6799.184097908283, 7034.366906978396, 7065.6820443081215, 5974.462298392991, 6133.417325354084, 6133.662648554194, 6134.325224225421, 6142.78500252489, 4578.267477203632, 4600.7469589172915, 4611.33135695329, 4630.467496237841, 4648.9772250104925, 4625.236835922035, 4747.240441529339, 4759.095771803346, 4785.138675038526, 4851.223804191312], "value": 4180.8289652388785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.4951335163464, 299.4520028348122, 300.9759219262459, 308.96755840636735, 312.03736472980853, 4738.384010078689, 4790.455063253189, 4809.8797530061765, 4837.32277481153, 4844.975775121124, 4749.551386827016, 4761.166795810736, 4761.69049011814, 4768.904621907568, 4776.952230477694, 3564.394053010988, 3625.6011838697723, 3696.7800625793425, 3750.2499500099952, 3785.7728536287773, 3728.179800443898, 3763.5671897731836, 3768.9811550942345, 3773.547174339083, 3797.89860940327, 3749.662530372266, 3758.661720445173, 3762.0, 3764.7929363884973, 3777.263433630443, 3590.605033446319, 3596.766210196342, 3728.366177749762, 3730.8880733577766, 3732.794696291703, 3307.4873394623874, 3322.5846769153854, 3324.5678061852045, 3324.8670053197843, 3326.234965957819, 4519.254323036695, 4520.412346394981, 4525.570070843265, 4530.411046563926, 4534.342520334533, 3954.4463775071513, 4198.244316023115, 4251.659867210616, 4256.106217694288, 4266.509351424595, 4921.581665558432, 4946.356973593446, 4950.331705219785, 4960.801567937278, 4973.875653108665, 3488.1977145256733, 3495.4931534927546, 3498.8775392861126, 3500.3874321993803, 3502.404591219499, 4954.331165292675, 5184.7148406837605, 5190.4550022247495, 5205.7397130143345, 5214.32213812202, 3543.94684079739, 3546.5921419036627, 3573.4997100405963, 3579.1588976591, 3579.94630080549, 3621.1128273572617, 3624.9519021752626, 3628.38317486028, 3629.183433727443, 3650.6714395703984, 4116.650084742771, 4137.110521237948, 4141.52372477169, 4151.398047283127, 4157.64660003897, 4690.78039709678, 4936.802527898843, 4937.407511098691, 4943.777530011158, 4985.700857948535, 1263.5577547858177, 1269.8571285842631, 1275.8963496575395, 1278.6355888571713, 1280.9871901281053, 799.5282783157965, 809.3039985612369, 813.4915677701437, 853.2363534636465, 866.4065115395974, 4417.469903611587, 4423.911521769546, 4428.357888106207, 4429.402030725811, 4455.866324010285, 4985.102681517362, 4997.800087996439, 5040.445550989388, 5044.184093726256, 5044.83968687204, 4231.788410579458, 4414.139242847614, 4427.180971520279, 4432.822687092545, 4442.333649952533, 2721.6189733437336, 2735.849528275924, 2739.5068887600423, 2743.7256274372803, 2749.175247425764, 4858.344123543347, 4886.951130488721, 4892.0705066037335, 4928.408590969107, 4940.876478088005, 4952.900941981212, 5237.8214901646825, 5247.580193584504, 5253.684778913201, 5262.60530460217, 4850.0, 4872.049950259665, 4893.412790465167, 4904.681195722338, 4905.8037678492465, 5133.8716532087, 5153.587712983027, 5160.561352285098, 5166.147585648326, 5166.819161329336, 4834.613230941446, 5049.166887463674, 5057.873553161053, 5071.822486212965, 5072.695638261716, 4889.266610008527, 4891.779869905791, 4904.5340692634145, 4919.557239848431, 4920.286558449076, 3568.7680300780366, 3592.1019745063736, 3612.205314830733, 3616.4756110364374, 3641.399169137063, 4963.602911766978, 5130.972726091624, 5155.0, 5187.429382767968, 5193.870153246199, 4963.851084467472, 4966.329545511309, 4993.201087825931, 5002.324686167321, 5010.849674509771, 4957.454679985271, 4957.702537847741, 4990.850274491771, 5030.748462576783, 5045.520675535819, 4648.488666246642, 4920.450058231646, 4922.8769280768265, 4925.802967881388, 4942.654014218971, 4797.760111994457, 4891.217405215149, 5038.236617183957, 5070.3155074064525, 5075.670081444694, 4876.878078047936, 4886.951130488792, 4899.338589290543, 4923.236898280772, 4977.129002424634], "value": 3753.5507459516725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.63170256359, 759.8252401947556, 783.7883771381727, 786.7757689058619, 792.7780221537971, 12231.204971676834, 12284.324362160078, 12351.382430878442, 12370.443330050146, 12449.813252801192, 10943.507542160602, 11961.162718609701, 12261.0, 12327.137100402975, 12329.643739188683, 783.2167832167846, 796.9920300796975, 798.2935102434359, 799.8800179973022, 799.9640016199285, 795.5823192823785, 796.2594786848229, 804.7907544038534, 805.1425232127795, 807.3299161695778, 831.4595512916623, 832.2634468495395, 834.8497270491309, 834.9916500834975, 835.5947365527744, 831.4637059096849, 832.068083746205, 832.2301870769514, 833.8457385383723, 833.9874901876477, 612.6875293600251, 614.1678026274378, 614.499183165723, 614.637363955264, 614.9692515374213, 11394.316341019565, 11467.139964502696, 11490.942545287304, 11493.942530287295, 11500.597479088192, 10528.894711052868, 10640.467976601216, 10696.78606427875, 10705.518251678694, 10965.232433729641, 9292.16370526649, 9371.718848434557, 9536.2371010319, 9596.76008099803, 9849.310548261625, 3243.3999710053718, 3286.8027918324738, 3304.306095719902, 3356.8153751543655, 3399.3711163434846, 36223.4566481503, 43615.34576981348, 44384.3342349865, 45927.54072459266, 46216.76891615554, 10396.790547283608, 10435.94782026085, 10477.16182705397, 10593.523291451904, 10781.353118812896, 16428.507144785675, 16495.752563711554, 16511.917440412963, 16523.504294871174, 16561.751573726404, 5394.244805727201, 6853.588784672936, 6863.725450982005, 7019.824504387431, 7029.578225306498, 3773.8490460381827, 3868.187680587052, 3898.1618951924906, 3962.0689138052535, 3999.080211551301, 2796.748292653671, 2891.6096326996008, 2932.017774045676, 2932.4135172965493, 2935.471615109258, 499.21623051808314, 521.2858384013925, 525.1938274748319, 525.584788017462, 536.5466181076984, 475.55060467857544, 527.7862465701397, 536.7396812545912, 632.2634131237057, 657.2408867757747, 7698.307152356315, 7859.17478664732, 7860.371170306362, 8006.380380330391, 8042.718504852302, 620.6865532905944, 621.3941407128104, 624.6501958902938, 626.786892456567, 635.3519410201661, 3657.9634203658156, 3764.7552909060823, 3794.4118661607495, 3808.3716186829415, 3825.0, 43601.04343701795, 44709.32936005962, 45418.0, 51259.487405126216, 52098.0, 47103.0, 47873.281900771515, 48807.75596121997, 48923.755381222865, 49289.50710492849, 35745.64254357475, 41729.374059389134, 43694.344584831255, 46369.53630463719, 47003.29495057577, 7949.0, 8091.959540202261, 8216.630251638571, 8251.216134467217, 8333.250583386976, 30504.542431863985, 31117.8444107778, 31166.37667246597, 31241.0, 32115.197120072185, 38014.61985380111, 40159.1968160641, 40332.0, 40552.391714123725, 40897.38653920134, 11638.127140464669, 11658.41707914584, 11690.941545292219, 11707.239029463057, 11761.176717630025, 11115.833262500908, 11249.156313276373, 11319.207655464368, 11671.299722016705, 11961.162718609614, 9937.055979681918, 10201.132903702972, 10582.417967011581, 12080.879191207976, 12086.758264834478, 11245.212835101463, 11683.591074312359, 11984.460699268728, 12116.0, 12125.393730313626, 10267.7433064174, 10310.793784124126, 10589.099926506333, 11138.777224455627, 11431.314121152758, 8981.14679105484, 9038.0, 9240.399374040666, 9354.438733676001, 9799.069088436587, 8816.338774591803, 8942.329325300758, 9177.678781242625, 9192.586333615138, 9232.492212928353], "value": 5906.588042012725, "unit": "score"}], "name": "dromaeo_css", "value": 6368.896928298772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 118.0, 113.0, 113.0, 112.0, 113.0, 112.0, 114.0, 112.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 135.0, 130.0, 186.0, 132.0, 131.0, 168.0, 131.0, 198.0, 132.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 110.0, 75.0, 77.0, 76.0, 76.0, 108.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 120.0, 84.0, 85.0, 85.0, 115.0, 85.0, 85.0, 123.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 80.0, 62.0, 62.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 89.0, 89.0, 91.0, 86.0, 84.0, 84.0, 85.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 130.0, 127.0, 124.0, 128.0, 127.0, 127.0, 169.0, 141.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 167.0, 168.0, 166.0, 167.0, 168.0, 176.0, 170.0, 170.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 66.0, 65.0, 68.0, 65.0, 66.0, 64.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 17:16:52 INFO - Return code: 0 17:16:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:16:52 ERROR - # TBPL SUCCESS # 17:16:52 INFO - Running post-action listener: _resource_record_post_action 17:16:52 INFO - ##### 17:16:52 INFO - ##### Finished run-tests step (success) 17:16:52 INFO - ##### 17:16:52 INFO - Running post-run listener: _resource_record_post_run 17:16:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521199616; Read time: 8; Write time: 405036 17:16:52 INFO - TinderboxPrint: CPU usage
13.1% 17:16:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:16:52 INFO - TinderboxPrint: I/O write bytes / time
521,199,616 / 405,036 17:16:52 INFO - TinderboxPrint: CPU idle
8,324.6 (86.9%) 17:16:52 INFO - TinderboxPrint: CPU user
1,210.1 (12.6%) 17:16:52 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236949504; Read time: 0; Write time: 230944 17:16:52 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284250112; Read time: 8; Write time: 174092 17:16:52 INFO - Running post-run listener: _upload_blobber_files 17:16:52 INFO - Blob upload gear active. 17:16:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:52 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 17:16:52 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'] 17:16:52 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 17:16:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:54 INFO - (blobuploader) - INFO - Done attempting. 17:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:54 INFO - (blobuploader) - INFO - Done attempting. 17:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:58 INFO - (blobuploader) - INFO - Done attempting. 17:16:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:58 INFO - Return code: 0 17:16:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93233d28f4fe210cafe460062abf151e62158ac8725862c679dd5c9cac3424d56e17ed0e915776058ebaf1eff73b971e1d15035fe12aba0aa645fcb29bba9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41f206e0045936766eeb17f9dbbf81d1a488fb480e76cbee5a5e24336da4321c87d38ac130eb5e18ce896d2e80e09e40b6c352b645daa5b034eb18b9377fe503", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edce966d28d3d8b8391b58fbd50fd922402c98e666040f98478d7076e37d5095333e7edfdfa7b7e9b480617c3eeff0496b0e24796ab242d236d32e2991d3ca74"} 17:16:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:58 INFO - Contents: 17:16:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c93233d28f4fe210cafe460062abf151e62158ac8725862c679dd5c9cac3424d56e17ed0e915776058ebaf1eff73b971e1d15035fe12aba0aa645fcb29bba9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41f206e0045936766eeb17f9dbbf81d1a488fb480e76cbee5a5e24336da4321c87d38ac130eb5e18ce896d2e80e09e40b6c352b645daa5b034eb18b9377fe503", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edce966d28d3d8b8391b58fbd50fd922402c98e666040f98478d7076e37d5095333e7edfdfa7b7e9b480617c3eeff0496b0e24796ab242d236d32e2991d3ca74"} 17:16:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:58 INFO - Copying logs to upload dir... 17:16:58 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.009851 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-24 17:16:58.270914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:16:58.274186) ========= 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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 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/c93233d28f4fe210cafe460062abf151e62158ac8725862c679dd5c9cac3424d56e17ed0e915776058ebaf1eff73b971e1d15035fe12aba0aa645fcb29bba9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41f206e0045936766eeb17f9dbbf81d1a488fb480e76cbee5a5e24336da4321c87d38ac130eb5e18ce896d2e80e09e40b6c352b645daa5b034eb18b9377fe503", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edce966d28d3d8b8391b58fbd50fd922402c98e666040f98478d7076e37d5095333e7edfdfa7b7e9b480617c3eeff0496b0e24796ab242d236d32e2991d3ca74"} build_url:https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/UBdENGtoR-uKB2H2oNQaug/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/c93233d28f4fe210cafe460062abf151e62158ac8725862c679dd5c9cac3424d56e17ed0e915776058ebaf1eff73b971e1d15035fe12aba0aa645fcb29bba9e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41f206e0045936766eeb17f9dbbf81d1a488fb480e76cbee5a5e24336da4321c87d38ac130eb5e18ce896d2e80e09e40b6c352b645daa5b034eb18b9377fe503", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edce966d28d3d8b8391b58fbd50fd922402c98e666040f98478d7076e37d5095333e7edfdfa7b7e9b480617c3eeff0496b0e24796ab242d236d32e2991d3ca74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 17:16:58.304612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:16:58.304983) ========= 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=0e2a256762fed810e2f0f810000001b3-1464134038.608654-383709929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 17:16:58.390707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:16:58.391488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 17:16:58.392222) ========= ========= Total master_lag: 0.20 =========