builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1464253052.9 results: success (0) buildid: 20160526012938 builduid: 3c7e2e01a36d4d12938f41112d3d3058 revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:32.900666) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:32.901116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:32.901431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:32.947404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:32.947720) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 01:57:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-26 01:57:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079366 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.057844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.058258) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018430 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.112997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.113348) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebf96465a8de20345f7b8d176d827ec538ecbd09 --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 ebf96465a8de20345f7b8d176d827ec538ecbd09 --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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 01:57:33,539 truncating revision to first 12 chars 2016-05-26 01:57:33,539 Setting DEBUG logging. 2016-05-26 01:57:33,539 attempt 1/10 2016-05-26 01:57:33,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebf96465a8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 01:57:33,863 unpacking tar archive at: fx-team-ebf96465a8de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.793064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.793424) ========= script_repo_revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.793930) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.794248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 01:57:33.805589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-26 01:57:33.806229) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:57:34 INFO - MultiFileLogger online at 20160526 01:57:34 in /builds/slave/test 01:57:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:57:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:57:34 INFO - {'append_to_log': False, 01:57:34 INFO - 'base_work_dir': '/builds/slave/test', 01:57:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:57:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:57:34 INFO - 'branch': 'Fx-Team-Non-PGO', 01:57:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:57:34 INFO - 'config_files': ('talos/linux_config.py',), 01:57:34 INFO - 'default_actions': ('clobber', 01:57:34 INFO - 'read-buildbot-config', 01:57:34 INFO - 'download-and-extract', 01:57:34 INFO - 'populate-webroot', 01:57:34 INFO - 'create-virtualenv', 01:57:34 INFO - 'install', 01:57:34 INFO - 'run-tests'), 01:57:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:57:34 INFO - 'download_minidump_stackwalk': True, 01:57:34 INFO - 'download_symbols': 'ondemand', 01:57:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:57:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:57:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:57:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:57:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:57:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:57:34 INFO - 'installer_path': 'installer.exe', 01:57:34 INFO - 'log_level': 'info', 01:57:34 INFO - 'log_name': 'talos', 01:57:34 INFO - 'log_to_console': True, 01:57:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:57:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:57:34 INFO - 'opt_config_files': (), 01:57:34 INFO - 'pip_index': False, 01:57:34 INFO - 'sps_profile': False, 01:57:34 INFO - 'sps_profile_interval': 0, 01:57:34 INFO - 'suite': 'dromaeojs', 01:57:34 INFO - 'system_bits': '32', 01:57:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:57:34 INFO - 'title': 'talos-linux64-ix-005', 01:57:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:57:34 INFO - 'use_talos_json': True, 01:57:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:57:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:57:34 INFO - 'work_dir': 'build'} 01:57:34 INFO - ##### 01:57:34 INFO - ##### Running clobber step. 01:57:34 INFO - ##### 01:57:34 INFO - Running pre-action listener: _resource_record_pre_action 01:57:34 INFO - Running main action method: clobber 01:57:34 INFO - rmtree: /builds/slave/test/build 01:57:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:57:35 INFO - Running post-action listener: _resource_record_post_action 01:57:35 INFO - ##### 01:57:35 INFO - ##### Finished clobber step (success) 01:57:35 INFO - ##### 01:57:35 INFO - ##### 01:57:35 INFO - ##### Running read-buildbot-config step. 01:57:35 INFO - ##### 01:57:35 INFO - Running pre-action listener: _resource_record_pre_action 01:57:35 INFO - Running main action method: read_buildbot_config 01:57:35 INFO - Using buildbot properties: 01:57:35 INFO - { 01:57:35 INFO - "project": "", 01:57:35 INFO - "product": "firefox", 01:57:35 INFO - "script_repo_revision": "production", 01:57:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:57:35 INFO - "repository": "", 01:57:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:57:35 INFO - "buildid": "20160526012938", 01:57:35 INFO - "pgo_build": "False", 01:57:35 INFO - "basedir": "/builds/slave/test", 01:57:35 INFO - "buildnumber": 1724, 01:57:35 INFO - "slavename": "talos-linux64-ix-005", 01:57:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:57:35 INFO - "platform": "ubuntu64_hw", 01:57:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:57:35 INFO - "branch": "fx-team", 01:57:35 INFO - "repo_path": "integration/fx-team", 01:57:35 INFO - "revision": "ebf96465a8de20345f7b8d176d827ec538ecbd09", 01:57:35 INFO - "stage_platform": "linux64", 01:57:35 INFO - "builduid": "3c7e2e01a36d4d12938f41112d3d3058", 01:57:35 INFO - "slavebuilddir": "test" 01:57:35 INFO - } 01:57:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:57:35 INFO - Running post-action listener: _resource_record_post_action 01:57:35 INFO - ##### 01:57:35 INFO - ##### Finished read-buildbot-config step (success) 01:57:35 INFO - ##### 01:57:35 INFO - ##### 01:57:35 INFO - ##### Running download-and-extract step. 01:57:35 INFO - ##### 01:57:35 INFO - Running pre-action listener: _resource_record_pre_action 01:57:35 INFO - Running main action method: download_and_extract 01:57:35 INFO - mkdir: /builds/slave/test/build/tests 01:57: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')]} 01:57:35 INFO - https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:45 INFO - Downloaded 1361 bytes. 01:57:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:57:45 INFO - Using the following test package requirements: 01:57:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:57:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:57:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'jsshell-linux-x86_64.zip'], 01:57:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:57:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:57:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:57:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:57:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:57:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:57:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:57:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:45 INFO - https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:53 INFO - Downloaded 22835896 bytes. 01:57:53 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'] 01:57:53 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 01:57:55 INFO - Return code: 0 01:57:55 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 01:57:55 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')]} 01:57:55 INFO - https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:57:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:57:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:56 INFO - Downloaded 22835896 bytes. 01:57:56 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'] 01:57:56 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 01:57:57 INFO - Return code: 0 01:57:57 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')]} 01:57:57 INFO - https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:58 INFO - Downloaded 10834034 bytes. 01:57:58 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'] 01:57:58 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 01:57:58 INFO - Return code: 0 01:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:57:58 INFO - https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:57:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:57:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GAlFE-9qRVSTptp2iAVe6g/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 01:58:00 INFO - Downloaded 54822228 bytes. 01:58:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:58:00 INFO - mkdir: /builds/slave/test/properties 01:58:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:58:00 INFO - Writing to file /builds/slave/test/properties/build_url 01:58:00 INFO - Contents: 01:58:00 INFO - build_url:https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:58:00 INFO - Running post-action listener: _resource_record_post_action 01:58:00 INFO - Running post-action listener: set_extra_try_arguments 01:58:00 INFO - ##### 01:58:00 INFO - ##### Finished download-and-extract step (success) 01:58:00 INFO - ##### 01:58:00 INFO - ##### 01:58:00 INFO - ##### Running populate-webroot step. 01:58:00 INFO - ##### 01:58:00 INFO - Running pre-action listener: _resource_record_pre_action 01:58:00 INFO - Running main action method: populate_webroot 01:58:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:58:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:58:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:58:00 INFO - '--tppagecycles', 01:58:00 INFO - '7'], 01:58:00 INFO - 'tests': ['tsvgm']}}, 01:58:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:58:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:58:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:58:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:58:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:58:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['damp', 'tps']}, 01:58:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'tests': ['damp', 'tps']}, 01:58:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['dromaeo_dom']}, 01:58:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:58:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'other-e10s': {'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['a11yr', 01:58:00 INFO - 'ts_paint', 01:58:00 INFO - 'tpaint', 01:58:00 INFO - 'sessionrestore', 01:58:00 INFO - 'sessionrestore_no_auto_restore', 01:58:00 INFO - 'tabpaint']}, 01:58:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['tsvgx', 01:58:00 INFO - 'tsvgr_opacity', 01:58:00 INFO - 'tart', 01:58:00 INFO - 'tscrollx', 01:58:00 INFO - 'cart']}, 01:58:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:58:00 INFO - 'tsvgr_opacity', 01:58:00 INFO - 'tart', 01:58:00 INFO - 'tscrollx', 01:58:00 INFO - 'cart']}, 01:58:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'talos_options': ['--disable-e10s'], 01:58:00 INFO - 'tests': ['tp5o']}, 01:58:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'tests': ['tp5o']}, 01:58:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'talos_options': ['--disable-e10s', 01:58:00 INFO - '--xperf_path', 01:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:00 INFO - 'tests': ['tp5n']}, 01:58:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:58:00 INFO - 'talos_options': ['--xperf_path', 01:58:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:58:00 INFO - 'tests': ['tp5n']}}, 01:58:00 INFO - 'talos.zip': {'path': '', 01:58:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:58:00 INFO - Running post-action listener: _resource_record_post_action 01:58:00 INFO - ##### 01:58:00 INFO - ##### Finished populate-webroot step (success) 01:58:00 INFO - ##### 01:58:00 INFO - ##### 01:58:00 INFO - ##### Running create-virtualenv step. 01:58:00 INFO - ##### 01:58:00 INFO - Running pre-action listener: _resource_record_pre_action 01:58:00 INFO - Running main action method: create_virtualenv 01:58:00 INFO - Creating virtualenv /builds/slave/test/build/venv 01:58:00 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 01:58:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:58:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:58:00 INFO - Using real prefix '/usr' 01:58:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:58:01 INFO - Installing distribute.............................................................................................................................................................................................done. 01:58:03 INFO - Installing pip.................done. 01:58:03 INFO - Return code: 0 01:58:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:58:03 INFO - Using env: {'DISPLAY': ':0', 01:58:03 INFO - 'HOME': '/home/cltbld', 01:58:03 INFO - 'LANG': 'en_US.UTF-8', 01:58:03 INFO - 'LANGUAGE': 'en_US:en', 01:58:03 INFO - 'LOGNAME': 'cltbld', 01:58:03 INFO - 'MAIL': '/var/mail/cltbld', 01:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:03 INFO - 'MOZ_NO_REMOTE': '1', 01:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:03 INFO - 'NO_EM_RESTART': '1', 01:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:03 INFO - 'PWD': '/builds/slave/test', 01:58:03 INFO - 'SHELL': '/bin/bash', 01:58:03 INFO - 'SHLVL': '1', 01:58:03 INFO - 'TERM': 'linux', 01:58:03 INFO - 'TMOUT': '86400', 01:58:03 INFO - 'USER': 'cltbld', 01:58:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:03 INFO - '_': '/tools/buildbot/bin/python'} 01:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:03 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 01:58:03 INFO - Cleaning up... 01:58:03 INFO - Return code: 0 01:58:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:58:03 INFO - Using env: {'DISPLAY': ':0', 01:58:03 INFO - 'HOME': '/home/cltbld', 01:58:03 INFO - 'LANG': 'en_US.UTF-8', 01:58:03 INFO - 'LANGUAGE': 'en_US:en', 01:58:03 INFO - 'LOGNAME': 'cltbld', 01:58:03 INFO - 'MAIL': '/var/mail/cltbld', 01:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:03 INFO - 'MOZ_NO_REMOTE': '1', 01:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:03 INFO - 'NO_EM_RESTART': '1', 01:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:03 INFO - 'PWD': '/builds/slave/test', 01:58:03 INFO - 'SHELL': '/bin/bash', 01:58:03 INFO - 'SHLVL': '1', 01:58:03 INFO - 'TERM': 'linux', 01:58:03 INFO - 'TMOUT': '86400', 01:58:03 INFO - 'USER': 'cltbld', 01:58:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:03 INFO - '_': '/tools/buildbot/bin/python'} 01:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:03 INFO - Downloading/unpacking psutil>=3.1.1 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:58:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:05 INFO - Installing collected packages: psutil 01:58:05 INFO - Running setup.py install for psutil 01:58:05 INFO - building 'psutil._psutil_linux' extension 01:58:05 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 01:58:05 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 01:58:06 INFO - building 'psutil._psutil_posix' extension 01:58:06 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 01:58:06 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 01:58:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:58:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:58:06 INFO - Successfully installed psutil 01:58:06 INFO - Cleaning up... 01:58:06 INFO - Return code: 0 01:58:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:06 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:06 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 01:58:06 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 01:58:06 INFO - Using env: {'DISPLAY': ':0', 01:58:06 INFO - 'HOME': '/home/cltbld', 01:58:06 INFO - 'LANG': 'en_US.UTF-8', 01:58:06 INFO - 'LANGUAGE': 'en_US:en', 01:58:06 INFO - 'LOGNAME': 'cltbld', 01:58:06 INFO - 'MAIL': '/var/mail/cltbld', 01:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:06 INFO - 'MOZ_NO_REMOTE': '1', 01:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:06 INFO - 'NO_EM_RESTART': '1', 01:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:06 INFO - 'PWD': '/builds/slave/test', 01:58:06 INFO - 'SHELL': '/bin/bash', 01:58:06 INFO - 'SHLVL': '1', 01:58:06 INFO - 'TERM': 'linux', 01:58:06 INFO - 'TMOUT': '86400', 01:58:06 INFO - 'USER': 'cltbld', 01:58:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:06 INFO - '_': '/tools/buildbot/bin/python'} 01:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:58:08 INFO - Installing collected packages: mozsystemmonitor 01:58:08 INFO - Running setup.py install for mozsystemmonitor 01:58:08 INFO - Successfully installed mozsystemmonitor 01:58:08 INFO - Cleaning up... 01:58:08 INFO - Return code: 0 01:58:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:58: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')]} 01:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58: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')]} 01:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:08 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:08 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 01:58:08 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 01:58:08 INFO - Using env: {'DISPLAY': ':0', 01:58:08 INFO - 'HOME': '/home/cltbld', 01:58:08 INFO - 'LANG': 'en_US.UTF-8', 01:58:08 INFO - 'LANGUAGE': 'en_US:en', 01:58:08 INFO - 'LOGNAME': 'cltbld', 01:58:08 INFO - 'MAIL': '/var/mail/cltbld', 01:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:08 INFO - 'MOZ_NO_REMOTE': '1', 01:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:08 INFO - 'NO_EM_RESTART': '1', 01:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:08 INFO - 'PWD': '/builds/slave/test', 01:58:08 INFO - 'SHELL': '/bin/bash', 01:58:08 INFO - 'SHLVL': '1', 01:58:08 INFO - 'TERM': 'linux', 01:58:08 INFO - 'TMOUT': '86400', 01:58:08 INFO - 'USER': 'cltbld', 01:58:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:08 INFO - '_': '/tools/buildbot/bin/python'} 01:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:08 INFO - Downloading/unpacking blobuploader==1.2.4 01:58:08 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 01:58:08 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 01:58:08 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 01:58:08 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 01:58:08 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 01:58:08 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 01:58:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:58:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:58:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:11 INFO - Downloading docopt-0.6.1.tar.gz 01:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:58:11 INFO - Installing collected packages: blobuploader, requests, docopt 01:58:11 INFO - Running setup.py install for blobuploader 01:58:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:58:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:58:11 INFO - Running setup.py install for requests 01:58:11 INFO - Running setup.py install for docopt 01:58:11 INFO - Successfully installed blobuploader requests docopt 01:58:11 INFO - Cleaning up... 01:58:12 INFO - Return code: 0 01:58:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:12 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:12 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 01:58:12 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 01:58:12 INFO - Using env: {'DISPLAY': ':0', 01:58:12 INFO - 'HOME': '/home/cltbld', 01:58:12 INFO - 'LANG': 'en_US.UTF-8', 01:58:12 INFO - 'LANGUAGE': 'en_US:en', 01:58:12 INFO - 'LOGNAME': 'cltbld', 01:58:12 INFO - 'MAIL': '/var/mail/cltbld', 01:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:12 INFO - 'MOZ_NO_REMOTE': '1', 01:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:12 INFO - 'NO_EM_RESTART': '1', 01:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:12 INFO - 'PWD': '/builds/slave/test', 01:58:12 INFO - 'SHELL': '/bin/bash', 01:58:12 INFO - 'SHLVL': '1', 01:58:12 INFO - 'TERM': 'linux', 01:58:12 INFO - 'TMOUT': '86400', 01:58:12 INFO - 'USER': 'cltbld', 01:58:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:12 INFO - '_': '/tools/buildbot/bin/python'} 01:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:12 INFO - Running setup.py (path:/tmp/pip-Hqbto8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:12 INFO - Running setup.py (path:/tmp/pip-3pOvlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:12 INFO - Running setup.py (path:/tmp/pip-XPlAHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:12 INFO - Running setup.py (path:/tmp/pip-c2lkib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:12 INFO - Running setup.py (path:/tmp/pip-kKffvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:12 INFO - Running setup.py (path:/tmp/pip-OR02hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:12 INFO - Running setup.py (path:/tmp/pip-TDHULW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:12 INFO - Running setup.py (path:/tmp/pip-wVHOKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:12 INFO - Running setup.py (path:/tmp/pip-vBDFmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:12 INFO - Running setup.py (path:/tmp/pip-bbnlkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:12 INFO - Running setup.py (path:/tmp/pip-Sw7M4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:13 INFO - Running setup.py (path:/tmp/pip-yaXW4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:13 INFO - Running setup.py (path:/tmp/pip-Oob1QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:13 INFO - Running setup.py (path:/tmp/pip-SgbpS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:13 INFO - Running setup.py (path:/tmp/pip-HLBSPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:13 INFO - Running setup.py (path:/tmp/pip-lnwWaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:13 INFO - Running setup.py (path:/tmp/pip-4nebv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:58:13 INFO - Running setup.py install for manifestparser 01:58:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:58:13 INFO - Running setup.py install for mozcrash 01:58:13 INFO - Running setup.py install for mozdebug 01:58:13 INFO - Running setup.py install for mozdevice 01:58:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:58:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:58:13 INFO - Running setup.py install for mozfile 01:58:14 INFO - Running setup.py install for mozhttpd 01:58:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozinfo 01:58:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozInstall 01:58:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozleak 01:58:14 INFO - Running setup.py install for mozlog 01:58:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for moznetwork 01:58:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozprocess 01:58:14 INFO - Running setup.py install for mozprofile 01:58:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozrunner 01:58:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:58:14 INFO - Running setup.py install for mozscreenshot 01:58:15 INFO - Running setup.py install for moztest 01:58:15 INFO - Running setup.py install for mozversion 01:58:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:58:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:58:15 INFO - Cleaning up... 01:58:15 INFO - Return code: 0 01:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:15 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')]} 01:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:15 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')]} 01:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:15 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:15 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 01:58:15 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 01:58:15 INFO - Using env: {'DISPLAY': ':0', 01:58:15 INFO - 'HOME': '/home/cltbld', 01:58:15 INFO - 'LANG': 'en_US.UTF-8', 01:58:15 INFO - 'LANGUAGE': 'en_US:en', 01:58:15 INFO - 'LOGNAME': 'cltbld', 01:58:15 INFO - 'MAIL': '/var/mail/cltbld', 01:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:15 INFO - 'MOZ_NO_REMOTE': '1', 01:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:15 INFO - 'NO_EM_RESTART': '1', 01:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:15 INFO - 'PWD': '/builds/slave/test', 01:58:15 INFO - 'SHELL': '/bin/bash', 01:58:15 INFO - 'SHLVL': '1', 01:58:15 INFO - 'TERM': 'linux', 01:58:15 INFO - 'TMOUT': '86400', 01:58:15 INFO - 'USER': 'cltbld', 01:58:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:15 INFO - '_': '/tools/buildbot/bin/python'} 01:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:58:15 INFO - Running setup.py (path:/tmp/pip-fo6rlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:58:15 INFO - Running setup.py (path:/tmp/pip-ePqT8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:58:15 INFO - Running setup.py (path:/tmp/pip-EO4uut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:58:15 INFO - Running setup.py (path:/tmp/pip-Xs8WRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:58:15 INFO - Running setup.py (path:/tmp/pip-7_xf6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:58:15 INFO - Running setup.py (path:/tmp/pip-6yXujN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:58:15 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)) 01:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:58:15 INFO - Running setup.py (path:/tmp/pip-hQidBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:58:16 INFO - Running setup.py (path:/tmp/pip-175Vn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:58:16 INFO - Running setup.py (path:/tmp/pip-XxX1Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:58:16 INFO - Running setup.py (path:/tmp/pip-Ku02rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:58:16 INFO - Running setup.py (path:/tmp/pip-h_7_oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:58:16 INFO - Running setup.py (path:/tmp/pip-IimKDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:58:16 INFO - Running setup.py (path:/tmp/pip-H0GFmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:58:16 INFO - Running setup.py (path:/tmp/pip-ei0g54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:16 INFO - Running setup.py (path:/tmp/pip-2Td01g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:58:16 INFO - Running setup.py (path:/tmp/pip-jbuOhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:58:16 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)) 01:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:58:16 INFO - Running setup.py (path:/tmp/pip-hGtMtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:58:16 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)) 01:58:16 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)) 01:58:16 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)) 01:58:16 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)) 01:58:16 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)) 01:58:16 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)) 01:58:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:18 INFO - Downloading blessings-1.6.tar.gz 01:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:58:18 INFO - Installing collected packages: blessings 01:58:18 INFO - Running setup.py install for blessings 01:58:18 INFO - Successfully installed blessings 01:58:18 INFO - Cleaning up... 01:58:18 INFO - Return code: 0 01:58:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:19 INFO - Reading from file tmpfile_stdout 01:58:19 INFO - Current package versions: 01:58:19 INFO - argparse == 1.2.1 01:58:19 INFO - blessings == 1.6 01:58:19 INFO - blobuploader == 1.2.4 01:58:19 INFO - docopt == 0.6.1 01:58:19 INFO - manifestparser == 1.1 01:58:19 INFO - mozInstall == 1.12 01:58:19 INFO - mozcrash == 0.17 01:58:19 INFO - mozdebug == 0.1 01:58:19 INFO - mozdevice == 0.48 01:58:19 INFO - mozfile == 1.2 01:58:19 INFO - mozhttpd == 0.7 01:58:19 INFO - mozinfo == 0.9 01:58:19 INFO - mozleak == 0.1 01:58:19 INFO - mozlog == 3.2 01:58:19 INFO - moznetwork == 0.27 01:58:19 INFO - mozprocess == 0.22 01:58:19 INFO - mozprofile == 0.28 01:58:19 INFO - mozrunner == 6.11 01:58:19 INFO - mozscreenshot == 0.1 01:58:19 INFO - mozsystemmonitor == 0.3 01:58:19 INFO - moztest == 0.7 01:58:19 INFO - mozversion == 1.4 01:58:19 INFO - psutil == 3.1.1 01:58:19 INFO - requests == 1.2.3 01:58:19 INFO - wsgiref == 0.1.2 01:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:58:19 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')]} 01:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:19 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')]} 01:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:19 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:19 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 01:58:19 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 01:58:19 INFO - Using env: {'DISPLAY': ':0', 01:58:19 INFO - 'HOME': '/home/cltbld', 01:58:19 INFO - 'LANG': 'en_US.UTF-8', 01:58:19 INFO - 'LANGUAGE': 'en_US:en', 01:58:19 INFO - 'LOGNAME': 'cltbld', 01:58:19 INFO - 'MAIL': '/var/mail/cltbld', 01:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:19 INFO - 'MOZ_NO_REMOTE': '1', 01:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:19 INFO - 'NO_EM_RESTART': '1', 01:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:19 INFO - 'PWD': '/builds/slave/test', 01:58:19 INFO - 'SHELL': '/bin/bash', 01:58:19 INFO - 'SHLVL': '1', 01:58:19 INFO - 'TERM': 'linux', 01:58:19 INFO - 'TMOUT': '86400', 01:58:19 INFO - 'USER': 'cltbld', 01:58:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:19 INFO - '_': '/tools/buildbot/bin/python'} 01:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 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)) 01:58:19 INFO - Cleaning up... 01:58:19 INFO - Return code: 0 01:58:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:58:19 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')]} 01:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:19 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')]} 01:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:19 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:19 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 01:58:19 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 01:58:19 INFO - Using env: {'DISPLAY': ':0', 01:58:19 INFO - 'HOME': '/home/cltbld', 01:58:19 INFO - 'LANG': 'en_US.UTF-8', 01:58:19 INFO - 'LANGUAGE': 'en_US:en', 01:58:19 INFO - 'LOGNAME': 'cltbld', 01:58:19 INFO - 'MAIL': '/var/mail/cltbld', 01:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:19 INFO - 'MOZ_NO_REMOTE': '1', 01:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:19 INFO - 'NO_EM_RESTART': '1', 01:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:19 INFO - 'PWD': '/builds/slave/test', 01:58:19 INFO - 'SHELL': '/bin/bash', 01:58:19 INFO - 'SHLVL': '1', 01:58:19 INFO - 'TERM': 'linux', 01:58:19 INFO - 'TMOUT': '86400', 01:58:19 INFO - 'USER': 'cltbld', 01:58:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:19 INFO - '_': '/tools/buildbot/bin/python'} 01:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:19 INFO - Downloading/unpacking jsonschema 01:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:58:21 INFO - Downloading/unpacking functools32 (from jsonschema) 01:58:21 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 01:58:21 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 01:58:21 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 01:58:21 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 01:58:21 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 01:58:21 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 01:58:21 INFO - Downloading functools32-3.2.3-2.tar.gz 01:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:58:21 INFO - warning: no files found matching '*.txt' 01:58:21 INFO - no previously-included directories found matching 'build' 01:58:21 INFO - no previously-included directories found matching 'dist' 01:58:21 INFO - no previously-included directories found matching '.git*' 01:58:21 INFO - Installing collected packages: jsonschema, functools32 01:58:21 INFO - Running setup.py install for functools32 01:58:21 INFO - warning: no files found matching '*.txt' 01:58:21 INFO - no previously-included directories found matching 'build' 01:58:21 INFO - no previously-included directories found matching 'dist' 01:58:21 INFO - no previously-included directories found matching '.git*' 01:58:21 INFO - Successfully installed jsonschema functools32 01:58:21 INFO - Cleaning up... 01:58:21 INFO - Return code: 0 01:58:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:58:21 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 0x7f0b4ab05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c96770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', '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 01:58:21 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 01:58:21 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 01:58:21 INFO - Using env: {'DISPLAY': ':0', 01:58:21 INFO - 'HOME': '/home/cltbld', 01:58:21 INFO - 'LANG': 'en_US.UTF-8', 01:58:21 INFO - 'LANGUAGE': 'en_US:en', 01:58:21 INFO - 'LOGNAME': 'cltbld', 01:58:21 INFO - 'MAIL': '/var/mail/cltbld', 01:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:21 INFO - 'MOZ_NO_REMOTE': '1', 01:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:21 INFO - 'NO_EM_RESTART': '1', 01:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:21 INFO - 'PWD': '/builds/slave/test', 01:58:21 INFO - 'SHELL': '/bin/bash', 01:58:21 INFO - 'SHLVL': '1', 01:58:21 INFO - 'TERM': 'linux', 01:58:21 INFO - 'TMOUT': '86400', 01:58:21 INFO - 'USER': 'cltbld', 01:58:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:21 INFO - '_': '/tools/buildbot/bin/python'} 01:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:58:22 INFO - Downloading/unpacking flake8 01:58:22 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 01:58:22 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 01:58:22 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 01:58:22 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 01:58:22 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 01:58:22 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 01:58:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:58:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:58:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:58:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 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 01:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:58:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:24 INFO - no previously-included directories found matching 'docs/_build' 01:58:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:58:24 INFO - Running setup.py install for pep8 01:58:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:58:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:58:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:58:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:58:24 INFO - no previously-included directories found matching 'docs/_build' 01:58:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:58:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:58:24 INFO - Cleaning up... 01:58:24 INFO - Return code: 0 01:58:24 INFO - Running post-action listener: _resource_record_post_action 01:58:24 INFO - Running post-action listener: _start_resource_monitoring 01:58:24 INFO - Starting resource monitoring. 01:58:25 INFO - ##### 01:58:25 INFO - ##### Finished create-virtualenv step (success) 01:58:25 INFO - ##### 01:58:25 INFO - ##### 01:58:25 INFO - ##### Running install step. 01:58:25 INFO - ##### 01:58:25 INFO - Running pre-action listener: _resource_record_pre_action 01:58:25 INFO - Running main action method: install 01:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:58:25 INFO - Reading from file tmpfile_stdout 01:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 01:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:58:25 INFO - Reading from file tmpfile_stdout 01:58:25 INFO - Output received: 01:58:25 INFO - Usage: mozinstall [options] installer 01:58:25 INFO - Options: 01:58:25 INFO - -h, --help show this help message and exit 01:58:25 INFO - -d DEST, --destination=DEST 01:58:25 INFO - Directory to install application into. [default: 01:58:25 INFO - "/builds/slave/test"] 01:58:25 INFO - --app=APP Application being installed. [default: firefox] 01:58:25 INFO - mkdir: /builds/slave/test/build/application 01:58:25 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'] 01:58:25 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 01:58:41 INFO - Reading from file tmpfile_stdout 01:58:41 INFO - Output received: 01:58:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:58:41 INFO - Running post-action listener: _resource_record_post_action 01:58:41 INFO - ##### 01:58:41 INFO - ##### Finished install step (success) 01:58:41 INFO - ##### 01:58:41 INFO - ##### 01:58:41 INFO - ##### Running run-tests step. 01:58:41 INFO - ##### 01:58:41 INFO - Running pre-action listener: _resource_record_pre_action 01:58:41 INFO - Running main action method: run_tests 01:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:58:41 INFO - Python 2.7.3 01:58:41 INFO - Return code: 0 01:58:41 INFO - grabbing minidump binary from tooltool 01:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:41 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 0x2d259c0>, '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 0x2d268c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d26d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:58:41 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 01:58:41 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 01:58:41 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 01:58:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:58:41 INFO - Return code: 0 01:58:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:58:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:58:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:58:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:58:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:58:42 INFO - Return code: 0 01:58:42 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/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 01:58:42 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/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 01:58:42 INFO - Using env: {'DISPLAY': ':0', 01:58:42 INFO - 'HOME': '/home/cltbld', 01:58:42 INFO - 'LANG': 'en_US.UTF-8', 01:58:42 INFO - 'LANGUAGE': 'en_US:en', 01:58:42 INFO - 'LOGNAME': 'cltbld', 01:58:42 INFO - 'MAIL': '/var/mail/cltbld', 01:58:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:58:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:58:42 INFO - 'MOZ_NO_REMOTE': '1', 01:58:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:58:42 INFO - 'NO_EM_RESTART': '1', 01:58:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:58:42 INFO - 'PWD': '/builds/slave/test', 01:58:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:58:42 INFO - 'SHELL': '/bin/bash', 01:58:42 INFO - 'SHLVL': '1', 01:58:42 INFO - 'TERM': 'linux', 01:58:42 INFO - 'TMOUT': '86400', 01:58:42 INFO - 'USER': 'cltbld', 01:58:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502', 01:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:58:42 INFO - '_': '/tools/buildbot/bin/python'} 01:58:42 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/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 01:58:42 INFO - mozversion application_buildid: 20160526012938 01:58:42 INFO - mozversion application_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 01:58:42 INFO - mozversion application_display_name: Nightly 01:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:58:42 INFO - mozversion application_name: Firefox 01:58:42 INFO - mozversion application_remotingname: firefox 01:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:58:42 INFO - mozversion application_vendor: Mozilla 01:58:42 INFO - mozversion application_version: 49.0a1 01:58:42 INFO - mozversion platform_buildid: 20160526012938 01:58:42 INFO - mozversion platform_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 01:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:58:42 INFO - mozversion platform_version: 49.0a1 01:58:42 INFO - using testdate: 1464253122 01:58:42 INFO - actual date: 1464253122 01:58:42 INFO - starting webserver on 'localhost:60692' 01:58:42 INFO - SUITE-START | Running 2 tests 01:58:42 INFO - TEST-START | dromaeo_css 01:58:42 INFO - operating with platform_type : linux_ 01:58:42 INFO - Initialising browser for dromaeo_css test... 01:58:42 INFO - TEST-INFO | started process 15729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QKmXy/profile http://localhost:60692/getInfo.html) 01:58:46 INFO - PROCESS | 15729 | __metrics Screen width/height:1600/1200 01:58:46 INFO - PROCESS | 15729 | colorDepth:24 01:58:46 INFO - PROCESS | 15729 | Browser inner width/height: 1024/697 01:58:46 INFO - PROCESS | 15729 | __metrics 01:58:47 ERROR - PROCESS | 15729 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:58:48 INFO - TEST-INFO | 15729: exit 0 01:58:48 INFO - Browser initialized. 01:58:48 INFO - Running cycle 1/1 for dromaeo_css test... 01:58:48 INFO - TEST-INFO | started process 15809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QKmXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:59:00 INFO - PROCESS | 15809 | RSS: Main: 156946432 01:59:00 INFO - PROCESS | 15809 | 01:59:52 INFO - PROCESS | 15809 | 1464253192296 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] 02:02:04 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60692/tests/dromaeo/cssquery-ext.html) 02:02:05 INFO - PROCESS | 15809 | RSS: Main: 264491008 02:02:05 INFO - PROCESS | 15809 | 02:05:07 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-ext.html (next: http://localhost:60692/tests/dromaeo/cssquery-jquery.html) 02:05:08 INFO - PROCESS | 15809 | RSS: Main: 245219328 02:05:08 INFO - PROCESS | 15809 | 02:08:10 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60692/tests/dromaeo/cssquery-mootools.html) 02:08:10 INFO - PROCESS | 15809 | RSS: Main: 241287168 02:08:10 INFO - PROCESS | 15809 | 02:11:13 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60692/tests/dromaeo/cssquery-prototype.html) 02:11:13 INFO - PROCESS | 15809 | RSS: Main: 232857600 02:11:13 INFO - PROCESS | 15809 | 02:14:16 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60692/tests/dromaeo/cssquery-yui.html) 02:14:17 INFO - PROCESS | 15809 | RSS: Main: 205565952 02:14:17 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | Cycle 1(1): loaded http://localhost:60692/tests/dromaeo/cssquery-yui.html (next: http://localhost:60692/tests/dromaeo/cssquery-dojo.html) 02:17:20 INFO - PROCESS | 15809 | RSS: Main: 273272832 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | __start_tp_report 02:17:20 INFO - PROCESS | 15809 | _x_x_mozilla_page_load 02:17:20 INFO - PROCESS | 15809 | _x_x_mozilla_page_load_details 02:17:20 INFO - PROCESS | 15809 | |i|pagename|runs| 02:17:20 INFO - PROCESS | 15809 | |0;dojo.html;2695.9730402695973;2711.376383431812;2732.672079350478;2750.931226719333;2768.916932492025;4500.639948804096;4578.3819184410095;4661.13768952744;4730.408698912636;4794.424669039716;4647.558481944218;4688;4690.648201384901;4702.0360826030665;4719.528047195278;4257.531671516139;4327.783610819446;4353.455818022747;4390.538993405694;4492.483364413101;4415.911681766363;4435.578620031108;4438.8224471021285;4471.686981911267;4494.887627809315;4235.639970602502;4293.677974151919;4294.806733696991;4349.086691794727;4365.126974605076;4246.08709127536;4291.935620965688;4295;4378.6934914555995;4395.516493185779;4326.264535029021;4327.350897365421;4342.522322544518;4380.7152535085115;4387.758673272969;4505.864824055284;4530.546945305443;4600.516945720685;4603.10239503297;4695.225287827504;4999.900001999976;5016.598672106259;5024.422191447957;5059.898802023976;5070.29015937769;5034.622403319766;5049.823256186016;5077.111505486562;5078.187490001619;5100.15847385181;4623.306504024423;4688.2733176357715;4727.456342520585;4746.667733258639;4761.714297142183;5238.554722848525;5250.422453530108;5260.526552610283;5265.736713164403;5270.209468579667;4983.725895075733;5021.974890125526;5040.1179793535985;5043.84868453947;5044.697318160922;4870.780814863339;5001.174806157016;5048.899022019539;5128.282040514331;5139.434662187156;5035.84892453227;5038.622103342264;5070.391553013662;5073.492650734971;5085.160948443539;4985.775640096204;5010.348654674942;5012.097822391932;5022.221555658879;5062.772175252123;4198.097409057067;4229.577042295746;4312.784360782011;4330.220560299176;4378.584034516716;3715.442683597482;3773.867914622975;3778.263238668488;3804.2391521695217;3810;4303.784810759449;4307.160103779733;4319.3952846601505;4345.217860785026;4357.716748411343;4935.111679897581;4989;5059.696418214919;5074.162763144113;5116.513931176607;4275.828966841354;4306.397104405386;4329.2640251156745;4332.805023773938;4333.046729719456;4560.247559152769;4565.497795242521;4565.954340456619;4584.174848527297;4609.009063051393;4593.081383723202;4696.2955556666775;4723.480417154179;4730.266808644666;4734.928976065431;5032.094223039888;5067;5086.923696144487;5089.567386772166;5124.256982737407;4750.263709125091;4762.59517940965;4764.094821983812;4768.0463907218;4808.08646357191;4843.24929635907;4911.845716256748;4938.604911606991;5004.4495105537635;5057.367829021372;4959.20652695567;4979.601631869514;4986.252062190701;4990.775415106256;5027.798888044437;4860.906296083353;4861.756912154307;4864;4872.342233798392;4909.558139767438;4759.190937540696;4803.927941080957;4829.903401932012;4849.660523763303;4893.168161412497;4792.616590672807;4797.928031079467;4801.759912004316;4827.831025914076;4849.587785038311;4899.583535399531;4899.853004409873;4908.067467181224;4934.851954441372;4955.5044495550155;4689.155951928686;4728.71627702339;4747.525247475225;4805.543473370024;4810.783514741915 02:17:20 INFO - PROCESS | 15809 | |1;ext.html;574.4140976204271;592.4726992976252;593.462916060965;611.2909025530384;630.9747610095596;40260.798696006554;41300;41300.38049429261;41358.58641413585;45321.32018019733;41103.38344924821;41703;41778.791106044504;41795.16409671805;41817.58182418175;7503.887441688379;7580.9241907581045;7627.313541781238;7632.2749338813;7632.9236707633045;7694.422918281123;7809.140994490602;7811.33603643691;7811.804704882395;7816.687332506693;7822.491538050037;7845.058592968823;7861.410394220427;7871.252231038042;7872.252136047066;7756.0304961879765;7792.025996750434;7796.181400952932;7804.921950780533;7806.102298235719;7612.200718924544;7671.42464315173;7678.078630564368;7680.500767450098;7683.923160768377;37906;38344.616553834385;38398;38421.231575368336;38454.23091538181;3046.192758918888;3127.4057928993648;3138.9686103138906;3180.3639272145665;3280.7703460757757;28868.089354798452;29063.56404653932;29122.854385728147;29423.558646620317;30839;3532.131207586933;3535.2045789697368;3553.307105114504;3564.7861128332383;3665.193657395369;261649;261803;261900;262500.9999999981;262713;52846.414607561834;52918.735406322725;53290.73354633202;53342;53412.46587534153;32722.509162362585;33819.830900845336;33847.32305353879;36005.27989440197;57412.71293643505;15205.771913421308;15344.232788360761;15354.84645153534;15367.846321536865;15373.231338433034;11646.70883227926;11724.179307448398;11737.589184378507;11737.941310293394;11739.29564226132;18645.533861653297;18679.813201867808;18685.439436816916;18706.345277915207;18778.624427511375;6835.760748373783;6999.23008469068;7157.713691452388;7163.239299367873;7220.566765994057;802.9839403211903;900.243795212025;900.6847603338779;1001.5242759689089;1004.4977511244377;26969;27679.655453241852;27879.096926430317;28019.43961120766;28330.150095497167;943.7923656795494;964.3972517176765;1005.5726316315537;1012.7113772574928;1057.2713613242252;14379.679518578194;14506.927465362605;14539.636509087357;14783.408663653549;14830;377511;386887;388993;391017;392624;48376;48897.51102489001;48949;49116;49154.26268605974;1121.814900541418;1206.0592737664635;1214.2168301445517;1246.6883279180206;1251.8873301402734;26041.218763437126;26611.33471663224;26781.33046673771;26859.597106043817;26866.59700104539;41699.7915010423;41805.79097104617;42324.36513452239;42362.99999999877;42402;326079;328321;328833;329612;329909;21162.788372116083;23788.643170352112;25112.497750045262;25182.607652273004;25234.873825630755;39775.60224397719;39826.203475930895;40009;40623;40860.59139408568;33707;35507.46738798972;35707.64292357147;36019;36264.27471450609;34865;35294.47058294179;35318.29363412769;35501;35564.822175888956;33834.66165338414;34479.827600861834;34674.47988280228;34740;34871.65128348785;31353.68646313599;31810.52284215785;31932.361352773278;32104.357912841144;32163.51754723728;24276.786160691543;26918.59622105709;27042.594361084204;27073.323166920985;27081.593776093767 02:17:20 INFO - PROCESS | 15809 | |2;jquery.html;362.6917120447619;364.64082878364803;371.82895867900766;375.9962400375997;376.33952413514277;15482.690346193083;16806.663866722673;16991.660166796657;17304.221310041063;17474.82525174748;15590.922045389785;15825;15964.361425542993;16152.192390380493;16170.2723377448;4941.654084214116;5146.588272938156;5181.378234611851;5184.403793563732;5186.092433824085;3702.0929872181355;3870.903227419323;5144.945286216335;5668.206451096849;5993.130996005577;6050.576459647827;6051.606645568024;6070.878582428349;6074.757009719606;6083.756649734028;5872.970635146797;5914;5988.071848863433;6024.819255422344;6028.819135425944;3321.3025264694443;4876;5200.713960732158;5222.529972302473;5234.947650523484;19542.70685939712;20370.49073773153;20372.69440958387;20385.898070509553;20425.591488170303;1969.468243574227;1971.9507012324807;2164.5238047629496;2332.148765700524;2447.2535876557645;12494.687632809162;13038.087333886631;13293.335333233299;13430.52993145245;13467.393967271399;1731.809500954894;1741.939032133882;1744.2412550540555;1786.7230579260236;1821.3443160462223;67825.66087169581;69731.65134174348;72086;81651;84529;15264.465743698916;16070.75893861593;16640.916795415946;16837.494875153767;16922.40771572989;29426.11721648354;29739.553906691417;29935.850320748694;30059.398812023635;30179.698203017688;8694.869576956351;8746.518941458153;8756.474611523328;8964;9688.370255933483;7607.277308655669;7616;7721.806954826175;7814.257645523666;7827.686892524235;8545.829083418297;8614.827703445895;8670.739877803677;8783.91216087831;8849.115088491099;2598.454324591819;3285.2180162913446;3393.389189945784;3446.3451944130534;3450.6549345065796;759.7606753872512;901.6483571407157;922.6678395777515;948.3598570964572;1004.8944860789658;16252.918735406483;16408.425705100264;16515.504534863972;16604;16858.072805995787;882.4308321132834;884.969026084084;914.6204325204966;915.7573243090586;942.8491441369348;9015.864762028576;9104.726858194264;9369.109934556207;9439.52802359893;9588.856167157499;366658;389612;395416;397314;402713;76869;81894;82043.17956820475;82080.58959705163;83527.68877803473;977.5014742481386;985.1084768284713;988.9653862114935;993.9155171810332;1000.2198285337448;14795.186264755543;15433.151176685391;15502.147381894105;15503.302351393988;15856.52430427089;34066.65933340734;34263.657363427046;34277.65722342845;35286.823565882005;35828.462573061945;48523;49965.500344996086;50255;50528.40880847016;51250.74374628103;6692.83267918306;7144.785656430316;7304.5252058616015;7306.415486761152;7340.302671246223;7711.922880771121;10838.403887786248;10979.615713449992;10992.340459572451;11215.158863085464;8676.566171691264;8865.64537418496;8930.910690893268;9193.816123677623;9332.580033898626;9177.678781242625;9343.71968840936;9461.574229159567;9482.336236463381;9554.761130971781;5756.539476841759;5961.463468287875;8945.329100317373;8968.865467018131;9072.682456114004;7202.603856787927;7235.493515454078;7363;7405.111386633638;7702.768916932501;6890.414314783099;8889.599968001585;8978.506182160045;9107.316951228551;9264.629414823332 02:17:20 INFO - PROCESS | 15809 | |3;mootools.html;1212.1999480342974;1404.2417094768825;1452.6804103097318;1577.6134846962495;1759.9032053237074;6359.71381287842;7293.416526677866;7503.812404689872;7512.286332798382;7735.187805280449;7540.585267810268;7542.886856697154;7607.125180604218;7613.505122167056;7648.541087534752;2160.7839216078423;2188.0481990334256;2191.145453273217;2193.7257842769654;2195.7913998170147;2180.8582442141287;2207.0619986505753;2208.624533829253;2211.447138215446;2218.8557743746605;2172.543765809182;2220.11195521791;2221.1559607349186;2224.3771743911648;2225.944351391212;2089.60297543467;2091.173986275428;2094.3298144593737;2094.696269040996;2096.758872729625;2122.07689654999;2173.250228671122;2180.1715348167754;2180.324099529151;2181.7818218178213;7443.739469118555;7526.698932042712;7581.696732130708;7593.316601505836;7604.771856844303;4274.829006839723;4428.468583769936;4431.601155895953;4433.578810013076;4439.511653718088;2896.391757730879;2916.8332666933184;2945.6023436835967;2960.067578712699;3010.7741919356135;895.4671970177734;920.7928216151313;926.36081104038;970.3304719743425;986.063239922077;10101.343412678152;10143.543540540693;10145.644902428454;10150.593976241016;10169.59321627134;3971.424143499234;4033.072393349546;4118.876433706993;4119.670426365884;4120.587941205916;8091.959540202261;8127.715529956423;8142.918570814334;8145.877811832827;8153.470024448392;4271.572842715766;4277.315629499265;4279.679024073207;4281.828726850891;4285.5928686774705;3440.9311813763584;3816.1985982943893;3859.459675645412;3911.159100793286;3967.166894952092;3374.156460884779;3407.6592340765724;3485.4946032825096;3492.5983511896457;3512.227309991798;1024.8565200871883;1031.4120951057826;1037.8547003419528;1042.968710938673;1050.364529459681;805.6213579617688;822.3256929318021;838.9664413423517;850.3197442046338;861.0270394454227;4897.14299997499;4968.22992436173;5124.948750512522;5159.974200128975;5264.15773476242;393.84406766141467;404.6782807667911;404.7510780869744;410.5894105894106;411.71180173878406;3525.136341596325;3566.4115420955773;3583.6740406049407;3669.0093674708214;3685.3182161300247;9454.952725236468;9692.563834627459;9857.55640996157;9893.802123957481;9894.455804930654;9441.15029647335;9660.420374777395;9693.70918872435;9700.223982081416;9705.854412183822;6675.299093595199;7342.6695798688115;7432.777016689508;7443.255674432622;7454.478186527;5033.92449113271;5110.872228194176;5179.585633149414;5232.476752324737;5310;8565.27195188416;8587.871181932402;8635.481871087755;8881.73354799357;8883.600237989434;8733.519656418957;8846.380753347205;8848.159424854628;8851.424657397249;9010.369274150746;5806.5645076618575;5944.970275148597;5958.7616495341435;6397.680115994275;6522.445592124723;6662.866742665023;6749;7001.054857594159;7175.282471752783;7183.604901730246;6470.255920569195;6552.312007239171;6557.147570815763;6633.270340262471;6751.223609284995;6202.658853763086;6436.292007879036;6519.315471875385;6568.211814582281;6580.407763301326;5970.850728731816;6187.3503282154725;6198.442140207403;6206.503479721701;6213.627182369072;4258.808353624032;4388.736675799462;4431.778411079497;4433.578810013044;4443.555644435531;4437.8224871004795;4448.4439445069365;4494.865154045384;4497.100579883971;4516.887077822949 02:17:20 INFO - PROCESS | 15809 | |4;prototype.html;281.18035925277815;284.2221902002972;291.35901017760926;293.165942892471;293.2975523620927;4749.216379297421;4753.168195565775;4792.568668819806;4816.470188279291;4817.686850354725;4170.374443833419;4465.888352791182;4507.819687212507;4724.645651576128;4748.694109119993;3708.814559272039;3713.6657700806923;3714.702823774105;3734.618191269234;3734.7591445132907;3740.251949610089;3744.1949980754134;3745.4943582616406;3762.604926482721;3766.7739935603813;3524.1189702574356;3598.838052287653;3699.389600715892;3708.091517578197;3709.2210635766387;3701.1672373715833;3701.1857391373856;3704.6110158433244;3705.906757506542;3721.274351501458;3278.655741147169;3281.1305004173914;3284.359549887773;3284.704376606093;3296.884609038696;4565.885852853672;4569.657275704336;4575.611073058794;4579.427571553556;4585.72485650862;4019.839206431739;4135.8966025849295;4258.701890867641;4260.25445547028;4270.316749320125;4699.906001879944;4841.273808928654;4845.127876982177;4854.805807767721;4860.1008813369635;3514.9279469761714;3562.251927095287;3577.3203091412547;3581.1405262737017;3623.202895363016;5031.924521132222;5136.203888397305;5191.221316802472;5192.818251361185;5238.554722848562;3632.3098611263777;3641.471986561987;3642.9817850910576;3660.890173294752;3683.4106542953;3683.244934788362;3711;3711.7216208783907;3721.3115573618966;3727.1986522897705;4173.123644034726;4181.435506206684;4185.434966279574;4205.137946720976;4228.260054490452;4855.344528488679;4930.8767280818265;4968.801247950114;4978;5011;1267.1889990406148;1277.4634653445576;1281.8974482041415;1286.2861112082883;1286.3696788573532;806.6450761664848;830.4021104804531;834.7746108550657;837.1958429584256;843.9703561654771;3967.821448034845;3970.861019864291;3979.4826672532963;3982.9203415932097;3996.7809818005207;4527.932081018787;4560.521145279764;4560.726356418625;4572.565606267399;4592.7933243004145;3895.668868146239;3976.264391087658;3993.6805055595482;4030.556638769733;4032.6773858091283;2319.918802841926;2484.565201089802;2489.626556016612;2490.9786987335106;2493.6061381074373;4334.851264414932;4341.936225624742;4342.913141737211;4362.825486980485;4380.649548036149;4635.559621835988;4665.743384113838;4686.484486706459;4689.859304220879;4700.55344742249;4315.8489452869;4349.369341445473;4581.785826755912;4814.9518504815205;4815.15734746411;5113.619322782903;5156.1750119980625;5157.329547158845;5166;5168.767405466688;5017.498250174954;5018.623603229699;5044.419891712353;5062.367204099488;5063.924041139459;4611.723296602215;4807.302941073455;4812.374391329105;4876.487968763229;4883.780229889735;3575.1955809942556;3584.121890136829;3600.8837260449345;3604.85580576774;3629.785830643358;5234.712090834888;5247.501487358848;5250.766069973477;5258.316418865523;5262.9210561842365;4958.380202474691;4982.6512144149565;5039.21892106724;5080.212567052113;5111.514406131411;4958.677685950402;4975.726335051607;5009.920882833583;5021.824236151717;5026.271190677405;4919.975400122977;4935.457099718957;4988.825391111293;4993.825216117419;5004.824831130893;4934.235193545006;5040.57155141817;5056.367954005749;5085.949140508696;5087.186050231945;4884.731339776205;4906.288588154769;4907.484714104968;4935.629827763004;4937.8271760488215 02:17:20 INFO - PROCESS | 15809 | |5;yui.html;654.3783405764524;747.993067867174;766.6894907562439;768.7155752371623;775.8603451378754;11305.830412543819;11869.881301186986;12067.4569644366;12099.999999999989;12124.69688257793;12142.332171730552;12546.937265313683;12569.183003104792;12596.307203103826;12606.873931260685;633.9904901426482;639.3478651775209;762.2758379539432;767.6161919040479;776.4448419380142;764.0106062648855;770.5415277909663;771.4522688890894;772.3512249710242;796.8286818334057;811.3103861717523;812.2608426332039;812.6911773526052;812.92277233663;814.7963009247688;660.7257987935026;793.4564823096198;794.5907857453416;805.1948051948052;816.8815521749343;590.1059894260156;590.657418697159;590.6603702870866;590.6633219065135;592.478618815444;12552.623421297376;12567.811482827765;12569.245845249314;12592.370381480889;12618.495260189582;11921.582744603984;12333.938330308381;12381.257124572554;12464.252144871336;12601.810972835323;10779.461026948622;10827.350358978487;10872.67381978542;10906.781864362747;10993.560257589686;3159.984200078985;3281.6062072551445;3313.867445302209;3347.8493467794005;4142.937855932163;44215.33676994847;45960.999999999665;46113.76943115296;46127.538724613;46390;9851.211903047739;9942.602295908082;9980.151687106678;10018.899811001796;10079.042490963348;14961.326740296712;14976.850231497545;14985.325660345092;14991.32539035746;14993.400263989319;6225.066240063936;6279.780207692709;6364.586301890362;6515.804525864231;6544.051112588648;3600.4419315006216;3651.8174091295327;3696.2977034363385;3710.2023065040607;3766.4350347447553;2683.9865800671264;2753.765929895941;2754.669439667253;2763.6130941668184;2769.3907340385085;518.1967949677984;527.3882296536;527.6122050293031;528.2235114381853;532.9973350133303;470.71521729353935;473.95734383905614;494.5450185829046;497.6491573440788;514.6320380927655;6663.034949447449;6679.599224046573;6734.595924244561;6769.070814817754;6912.723491060402;468.7937307584652;474.43779121740846;485.3084354794404;486.30215640555207;495.4566525273746;3060.9540856887165;3077.138401247654;3085.460044492205;3102.3329984053535;3164.0666003529013;47096.529034709216;52519.73740131275;53317;54115;54127.69276147748;44815.77592112084;48305.51694483081;49585.50414495809;50406.243906341435;50688;46222;46390.5360946393;46623;47055.764721176856;47145.29282060772;7465.962670186615;7497.362724168507;7577.0907491101425;7736.342410895137;7792.961035195014;30957.8452107738;31445.371092578476;32159.51760723638;32219;32318.35363292674;37993.43009854799;38438;40489.39265911072;40902.18195636011;41035.1792964145;10521.789564208826;10648.627298044532;10715;10785.245032847939;11208.495617697386;11859.34773587461;12040.75918481643;12089.57686480969;12492.125551211328;12738.044646651353;10806.405647689453;11115;11267.718307042389;11535.480903359537;12026.458809353775;11095.445227738743;11095.72260693489;11110.166737494881;11621.24461909973;11665.416729163338;10811.135109191404;10820.458977051274;10845.132389408986;11084.168687348643;11431.142664300378;9449.763755906157;9515.429074255568;9516.23870090405;9545.522723863918;9978.351407158512;9402.43585384879;9697.709068727949;9699.796675039084;9706;9706.369086009387 02:17:20 INFO - PROCESS | 15809 | __end_tp_report 02:17:20 INFO - PROCESS | 15809 | __start_cc_report 02:17:20 INFO - PROCESS | 15809 | _x_x_mozilla_cycle_collect,1045 02:17:20 INFO - PROCESS | 15809 | __end_cc_report 02:17:20 INFO - PROCESS | 15809 | __startTimestamp1464254240300__endTimestamp 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | ------- Summary: start ------- 02:17:20 INFO - PROCESS | 15809 | Number of tests: 6 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#0] dojo.html Cycles:165 Average:4656.64 Median:4759.19 stddev:473.11 (9.9%) stddev-sans-first:448.86 02:17:20 INFO - PROCESS | 15809 | Values: 2696.0 2711.4 2732.7 2750.9 2768.9 4500.6 4578.4 4661.1 4730.4 4794.4 4647.6 4688.0 4690.6 4702.0 4719.5 4257.5 4327.8 4353.5 4390.5 4492.5 4415.9 4435.6 4438.8 4471.7 4494.9 4235.6 4293.7 4294.8 4349.1 4365.1 4246.1 4291.9 4295.0 4378.7 4395.5 4326.3 4327.4 4342.5 4380.7 4387.8 4505.9 4530.5 4600.5 4603.1 4695.2 4999.9 5016.6 5024.4 5059.9 5070.3 5034.6 5049.8 5077.1 5078.2 5100.2 4623.3 4688.3 4727.5 4746.7 4761.7 5238.6 5250.4 5260.5 5265.7 5270.2 4983.7 5022.0 5040.1 5043.8 5044.7 4870.8 5001.2 5048.9 5128.3 5139.4 5035.8 5038.6 5070.4 5073.5 5085.2 4985.8 5010.3 5012.1 5022.2 5062.8 4198.1 4229.6 4312.8 4330.2 4378.6 3715.4 3773.9 3778.3 3804.2 3810.0 4303.8 4307.2 4319.4 4345.2 4357.7 4935.1 4989.0 5059.7 5074.2 5116.5 4275.8 4306.4 4329.3 4332.8 4333.0 4560.2 4565.5 4566.0 4584.2 4609.0 4593.1 4696.3 4723.5 4730.3 4734.9 5032.1 5067.0 5086.9 5089.6 5124.3 4750.3 4762.6 4764.1 4768.0 4808.1 4843.2 4911.8 4938.6 5004.4 5057.4 4959.2 4979.6 4986.3 4990.8 5027.8 4860.9 4861.8 4864.0 4872.3 4909.6 4759.2 4803.9 4829.9 4849.7 4893.2 4792.6 4797.9 4801.8 4827.8 4849.6 4899.6 4899.9 4908.1 4934.9 4955.5 4689.2 4728.7 4747.5 4805.5 4810.8 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#1] ext.html Cycles:180 Average:47534.65 Median:19530.39 stddev:86882.30 (444.9%) stddev-sans-first:87054.48 02:17:20 INFO - PROCESS | 15809 | Values: 574.4 592.5 593.5 611.3 631.0 40260.8 41300.0 41300.4 41358.6 45321.3 41103.4 41703.0 41778.8 41795.2 41817.6 7503.9 7580.9 7627.3 7632.3 7632.9 7694.4 7809.1 7811.3 7811.8 7816.7 7822.5 7845.1 7861.4 7871.3 7872.3 7756.0 7792.0 7796.2 7804.9 7806.1 7612.2 7671.4 7678.1 7680.5 7683.9 37906.0 38344.6 38398.0 38421.2 38454.2 3046.2 3127.4 3139.0 3180.4 3280.8 28868.1 29063.6 29122.9 29423.6 30839.0 3532.1 3535.2 3553.3 3564.8 3665.2 261649.0 261803.0 261900.0 262501.0 262713.0 52846.4 52918.7 53290.7 53342.0 53412.5 32722.5 33819.8 33847.3 36005.3 57412.7 15205.8 15344.2 15354.8 15367.8 15373.2 11646.7 11724.2 11737.6 11737.9 11739.3 18645.5 18679.8 18685.4 18706.3 18778.6 6835.8 6999.2 7157.7 7163.2 7220.6 803.0 900.2 900.7 1001.5 1004.5 26969.0 27679.7 27879.1 28019.4 28330.2 943.8 964.4 1005.6 1012.7 1057.3 14379.7 14506.9 14539.6 14783.4 14830.0 377511.0 386887.0 388993.0 391017.0 392624.0 48376.0 48897.5 48949.0 49116.0 49154.3 1121.8 1206.1 1214.2 1246.7 1251.9 26041.2 26611.3 26781.3 26859.6 26866.6 41699.8 41805.8 42324.4 42363.0 42402.0 326079.0 328321.0 328833.0 329612.0 329909.0 21162.8 23788.6 25112.5 25182.6 25234.9 39775.6 39826.2 40009.0 40623.0 40860.6 33707.0 35507.5 35707.6 36019.0 36264.3 34865.0 35294.5 35318.3 35501.0 35564.8 33834.7 34479.8 34674.5 34740.0 34871.7 31353.7 31810.5 31932.4 32104.4 32163.5 24276.8 26918.6 27042.6 27073.3 27081.6 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#2] jquery.html Cycles:180 Average:25206.07 Median:5193.40 stddev:64613.12 (1244.1%) stddev-sans-first:64767.45 02:17:20 INFO - PROCESS | 15809 | Values: 362.7 364.6 371.8 376.0 376.3 15482.7 16806.7 16991.7 17304.2 17474.8 15590.9 15825.0 15964.4 16152.2 16170.3 4941.7 5146.6 5181.4 5184.4 5186.1 3702.1 3870.9 5144.9 5668.2 5993.1 6050.6 6051.6 6070.9 6074.8 6083.8 5873.0 5914.0 5988.1 6024.8 6028.8 3321.3 4876.0 5200.7 5222.5 5234.9 19542.7 20370.5 20372.7 20385.9 20425.6 1969.5 1972.0 2164.5 2332.1 2447.3 12494.7 13038.1 13293.3 13430.5 13467.4 1731.8 1741.9 1744.2 1786.7 1821.3 67825.7 69731.7 72086.0 81651.0 84529.0 15264.5 16070.8 16640.9 16837.5 16922.4 29426.1 29739.6 29935.9 30059.4 30179.7 8694.9 8746.5 8756.5 8964.0 9688.4 7607.3 7616.0 7721.8 7814.3 7827.7 8545.8 8614.8 8670.7 8783.9 8849.1 2598.5 3285.2 3393.4 3446.3 3450.7 759.8 901.6 922.7 948.4 1004.9 16252.9 16408.4 16515.5 16604.0 16858.1 882.4 885.0 914.6 915.8 942.8 9015.9 9104.7 9369.1 9439.5 9588.9 366658.0 389612.0 395416.0 397314.0 402713.0 76869.0 81894.0 82043.2 82080.6 83527.7 977.5 985.1 989.0 993.9 1000.2 14795.2 15433.2 15502.1 15503.3 15856.5 34066.7 34263.7 34277.7 35286.8 35828.5 48523.0 49965.5 50255.0 50528.4 51250.7 6692.8 7144.8 7304.5 7306.4 7340.3 7711.9 10838.4 10979.6 10992.3 11215.2 8676.6 8865.6 8930.9 9193.8 9332.6 9177.7 9343.7 9461.6 9482.3 9554.8 5756.5 5961.5 8945.3 8968.9 9072.7 7202.6 7235.5 7363.0 7405.1 7702.8 6890.4 8889.6 8978.5 9107.3 9264.6 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#3] mootools.html Cycles:180 Average:4957.59 Median:4932.69 stddev:2795.45 (56.7%) stddev-sans-first:2789.12 02:17:20 INFO - PROCESS | 15809 | Values: 1212.2 1404.2 1452.7 1577.6 1759.9 6359.7 7293.4 7503.8 7512.3 7735.2 7540.6 7542.9 7607.1 7613.5 7648.5 2160.8 2188.0 2191.1 2193.7 2195.8 2180.9 2207.1 2208.6 2211.4 2218.9 2172.5 2220.1 2221.2 2224.4 2225.9 2089.6 2091.2 2094.3 2094.7 2096.8 2122.1 2173.3 2180.2 2180.3 2181.8 7443.7 7526.7 7581.7 7593.3 7604.8 4274.8 4428.5 4431.6 4433.6 4439.5 2896.4 2916.8 2945.6 2960.1 3010.8 895.5 920.8 926.4 970.3 986.1 10101.3 10143.5 10145.6 10150.6 10169.6 3971.4 4033.1 4118.9 4119.7 4120.6 8092.0 8127.7 8142.9 8145.9 8153.5 4271.6 4277.3 4279.7 4281.8 4285.6 3440.9 3816.2 3859.5 3911.2 3967.2 3374.2 3407.7 3485.5 3492.6 3512.2 1024.9 1031.4 1037.9 1043.0 1050.4 805.6 822.3 839.0 850.3 861.0 4897.1 4968.2 5124.9 5160.0 5264.2 393.8 404.7 404.8 410.6 411.7 3525.1 3566.4 3583.7 3669.0 3685.3 9455.0 9692.6 9857.6 9893.8 9894.5 9441.2 9660.4 9693.7 9700.2 9705.9 6675.3 7342.7 7432.8 7443.3 7454.5 5033.9 5110.9 5179.6 5232.5 5310.0 8565.3 8587.9 8635.5 8881.7 8883.6 8733.5 8846.4 8848.2 8851.4 9010.4 5806.6 5945.0 5958.8 6397.7 6522.4 6662.9 6749.0 7001.1 7175.3 7183.6 6470.3 6552.3 6557.1 6633.3 6751.2 6202.7 6436.3 6519.3 6568.2 6580.4 5970.9 6187.4 6198.4 6206.5 6213.6 4258.8 4388.7 4431.8 4433.6 4443.6 4437.8 4448.4 4494.9 4497.1 4516.9 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#4] prototype.html Cycles:180 Average:4056.35 Median:4544.23 stddev:1182.10 (26.0%) stddev-sans-first:1150.96 02:17:20 INFO - PROCESS | 15809 | Values: 281.2 284.2 291.4 293.2 293.3 4749.2 4753.2 4792.6 4816.5 4817.7 4170.4 4465.9 4507.8 4724.6 4748.7 3708.8 3713.7 3714.7 3734.6 3734.8 3740.3 3744.2 3745.5 3762.6 3766.8 3524.1 3598.8 3699.4 3708.1 3709.2 3701.2 3701.2 3704.6 3705.9 3721.3 3278.7 3281.1 3284.4 3284.7 3296.9 4565.9 4569.7 4575.6 4579.4 4585.7 4019.8 4135.9 4258.7 4260.3 4270.3 4699.9 4841.3 4845.1 4854.8 4860.1 3514.9 3562.3 3577.3 3581.1 3623.2 5031.9 5136.2 5191.2 5192.8 5238.6 3632.3 3641.5 3643.0 3660.9 3683.4 3683.2 3711.0 3711.7 3721.3 3727.2 4173.1 4181.4 4185.4 4205.1 4228.3 4855.3 4930.9 4968.8 4978.0 5011.0 1267.2 1277.5 1281.9 1286.3 1286.4 806.6 830.4 834.8 837.2 844.0 3967.8 3970.9 3979.5 3982.9 3996.8 4527.9 4560.5 4560.7 4572.6 4592.8 3895.7 3976.3 3993.7 4030.6 4032.7 2319.9 2484.6 2489.6 2491.0 2493.6 4334.9 4341.9 4342.9 4362.8 4380.6 4635.6 4665.7 4686.5 4689.9 4700.6 4315.8 4349.4 4581.8 4815.0 4815.2 5113.6 5156.2 5157.3 5166.0 5168.8 5017.5 5018.6 5044.4 5062.4 5063.9 4611.7 4807.3 4812.4 4876.5 4883.8 3575.2 3584.1 3600.9 3604.9 3629.8 5234.7 5247.5 5250.8 5258.3 5262.9 4958.4 4982.7 5039.2 5080.2 5111.5 4958.7 4975.7 5009.9 5021.8 5026.3 4920.0 4935.5 4988.8 4993.8 5004.8 4934.2 5040.6 5056.4 5085.9 5087.2 4884.7 4906.3 4907.5 4935.6 4937.8 02:17:20 INFO - PROCESS | 15809 | 02:17:20 INFO - PROCESS | 15809 | [#5] yui.html Cycles:180 Average:12937.33 Median:46120.65 stddev:14980.57 (32.5%) stddev-sans-first:14994.20 02:17:20 INFO - PROCESS | 15809 | Values: 654.4 748.0 766.7 768.7 775.9 11305.8 11869.9 12067.5 12100.0 12124.7 12142.3 12546.9 12569.2 12596.3 12606.9 634.0 639.3 762.3 767.6 776.4 764.0 770.5 771.5 772.4 796.8 811.3 812.3 812.7 812.9 814.8 660.7 793.5 794.6 805.2 816.9 590.1 590.7 590.7 590.7 592.5 12552.6 12567.8 12569.2 12592.4 12618.5 11921.6 12333.9 12381.3 12464.3 12601.8 10779.5 10827.4 10872.7 10906.8 10993.6 3160.0 3281.6 3313.9 3347.8 4142.9 44215.3 45961.0 46113.8 46127.5 46390.0 9851.2 9942.6 9980.2 10018.9 10079.0 14961.3 14976.9 14985.3 14991.3 14993.4 6225.1 6279.8 6364.6 6515.8 6544.1 3600.4 3651.8 3696.3 3710.2 3766.4 2684.0 2753.8 2754.7 2763.6 2769.4 518.2 527.4 527.6 528.2 533.0 470.7 474.0 494.5 497.6 514.6 6663.0 6679.6 6734.6 6769.1 6912.7 468.8 474.4 485.3 486.3 495.5 3061.0 3077.1 3085.5 3102.3 3164.1 47096.5 52519.7 53317.0 54115.0 54127.7 44815.8 48305.5 49585.5 50406.2 50688.0 46222.0 46390.5 46623.0 47055.8 47145.3 7466.0 7497.4 7577.1 7736.3 7793.0 30957.8 31445.4 32159.5 32219.0 32318.4 37993.4 38438.0 40489.4 40902.2 41035.2 10521.8 10648.6 10715.0 10785.2 11208.5 11859.3 12040.8 12089.6 12492.1 12738.0 10806.4 11115.0 11267.7 11535.5 12026.5 11095.4 11095.7 11110.2 11621.2 11665.4 10811.1 10820.5 10845.1 11084.2 11431.1 9449.8 9515.4 9516.2 9545.5 9978.4 9402.4 9697.7 9699.8 9706.0 9706.4 02:17:20 INFO - PROCESS | 15809 | -------- Summary: end -------- 02:17:20 INFO - PROCESS | 15809 | 02:17:21 INFO - TEST-INFO | 15809: exit 0 02:17:21 INFO - TEST-OK | dromaeo_css | took 1118819ms 02:17:21 INFO - TEST-START | kraken 02:17:21 INFO - operating with platform_type : linux_ 02:17:21 INFO - Initialising browser for kraken test... 02:17:21 INFO - TEST-INFO | started process 15987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGptcm/profile http://localhost:60692/getInfo.html) 02:17:25 INFO - PROCESS | 15987 | __metrics Screen width/height:1600/1200 02:17:25 INFO - PROCESS | 15987 | colorDepth:24 02:17:25 INFO - PROCESS | 15987 | Browser inner width/height: 1024/697 02:17:25 INFO - PROCESS | 15987 | __metrics 02:17:26 ERROR - PROCESS | 15987 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:17:27 INFO - TEST-INFO | 15987: exit 0 02:17:27 INFO - Browser initialized. 02:17:27 INFO - Running cycle 1/1 for kraken test... 02:17:27 INFO - TEST-INFO | started process 16066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNGptcm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:39 INFO - PROCESS | 16066 | RSS: Main: 157384704 02:17:39 INFO - PROCESS | 16066 | 02:17:41 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-beat-detection) 02:17:42 INFO - PROCESS | 16066 | RSS: Main: 213078016 02:17:42 INFO - PROCESS | 16066 | 02:17:45 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-dft) 02:17:46 INFO - PROCESS | 16066 | RSS: Main: 200818688 02:17:46 INFO - PROCESS | 16066 | 02:17:49 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-fft) 02:17:50 INFO - PROCESS | 16066 | RSS: Main: 269717504 02:17:50 INFO - PROCESS | 16066 | 02:17:52 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60692/tests/kraken/driver.html?testName=audio-oscillator) 02:17:52 INFO - PROCESS | 16066 | RSS: Main: 179302400 02:17:52 INFO - PROCESS | 16066 | 02:17:55 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:17:55 INFO - PROCESS | 16066 | RSS: Main: 182874112 02:17:55 INFO - PROCESS | 16066 | 02:17:58 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-darkroom) 02:17:59 INFO - PROCESS | 16066 | RSS: Main: 219688960 02:17:59 INFO - PROCESS | 16066 | 02:18:02 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60692/tests/kraken/driver.html?testName=imaging-desaturate) 02:18:03 INFO - PROCESS | 16066 | RSS: Main: 219983872 02:18:03 INFO - PROCESS | 16066 | 02:18:06 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60692/tests/kraken/driver.html?testName=json-parse-financial) 02:18:07 INFO - PROCESS | 16066 | RSS: Main: 219430912 02:18:07 INFO - PROCESS | 16066 | 02:18:08 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:18:09 INFO - PROCESS | 16066 | RSS: Main: 207921152 02:18:09 INFO - PROCESS | 16066 | 02:18:11 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:18:11 INFO - PROCESS | 16066 | RSS: Main: 211619840 02:18:11 INFO - PROCESS | 16066 | 02:18:14 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:18:14 INFO - PROCESS | 16066 | RSS: Main: 221368320 02:18:14 INFO - PROCESS | 16066 | 02:18:17 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:18:18 INFO - PROCESS | 16066 | RSS: Main: 228450304 02:18:18 INFO - PROCESS | 16066 | 02:18:21 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:18:21 INFO - PROCESS | 16066 | RSS: Main: 225411072 02:18:21 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | Cycle 1(1): loaded http://localhost:60692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60692/tests/kraken/driver.html?testName=ai-astar) 02:18:23 INFO - PROCESS | 16066 | RSS: Main: 270946304 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | __start_tp_report 02:18:23 INFO - PROCESS | 16066 | _x_x_mozilla_page_load 02:18:23 INFO - PROCESS | 16066 | _x_x_mozilla_page_load_details 02:18:23 INFO - PROCESS | 16066 | |i|pagename|runs| 02:18:23 INFO - PROCESS | 16066 | |0;ai-astar;113;107;114;114;113;115;113;113;112;115 02:18:23 INFO - PROCESS | 16066 | |1;audio-beat-detection;157;130;140;173;140;153;158;130;204;130 02:18:23 INFO - PROCESS | 16066 | |2;audio-dft;161;161;161;161;161;161;162;160;163;162 02:18:23 INFO - PROCESS | 16066 | |3;audio-fft;76;76;76;118;76;76;75;78;118;75 02:18:23 INFO - PROCESS | 16066 | |4;audio-oscillator;84;83;131;84;85;83;119;84;83;123 02:18:23 INFO - PROCESS | 16066 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;116;116;116 02:18:23 INFO - PROCESS | 16066 | |6;imaging-darkroom;145;146;146;145;145;146;145;146;145;145 02:18:23 INFO - PROCESS | 16066 | |7;imaging-desaturate;95;95;94;94;94;95;95;96;94;94 02:18:23 INFO - PROCESS | 16066 | |8;json-parse-financial;63;63;67;63;64;75;65;81;62;62 02:18:23 INFO - PROCESS | 16066 | |9;json-stringify-tinderbox;65;65;66;70;65;64;65;65;65;65 02:18:23 INFO - PROCESS | 16066 | |10;stanford-crypto-aes;82;86;89;84;89;83;88;83;84;84 02:18:23 INFO - PROCESS | 16066 | |11;stanford-crypto-ccm;133;134;138;144;139;128;129;130;167;132 02:18:23 INFO - PROCESS | 16066 | |12;stanford-crypto-pbkdf2;175;169;172;177;176;179;176;173;167;172 02:18:23 INFO - PROCESS | 16066 | |13;stanford-crypto-sha256-iterative;66;68;67;67;68;70;67;65;69;65 02:18:23 INFO - PROCESS | 16066 | __end_tp_report 02:18:23 INFO - PROCESS | 16066 | __start_cc_report 02:18:23 INFO - PROCESS | 16066 | _x_x_mozilla_cycle_collect,1920 02:18:23 INFO - PROCESS | 16066 | __end_cc_report 02:18:23 INFO - PROCESS | 16066 | __startTimestamp1464254303722__endTimestamp 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | ------- Summary: start ------- 02:18:23 INFO - PROCESS | 16066 | Number of tests: 14 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:2.28 (2.0%) stddev-sans-first:2.42 02:18:23 INFO - PROCESS | 16066 | Values: 113.0 107.0 114.0 114.0 113.0 115.0 113.0 113.0 112.0 115.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.00 stddev:23.44 (15.1%) stddev-sans-first:24.78 02:18:23 INFO - PROCESS | 16066 | Values: 157.0 130.0 140.0 173.0 140.0 153.0 158.0 130.0 204.0 130.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:18:23 INFO - PROCESS | 16066 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 162.0 160.0 163.0 162.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#3] audio-fft Cycles:10 Average:84.40 Median:76.00 stddev:17.73 (23.3%) stddev-sans-first:18.54 02:18:23 INFO - PROCESS | 16066 | Values: 76.0 76.0 76.0 118.0 76.0 76.0 75.0 78.0 118.0 75.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:83.50 stddev:19.84 (23.8%) stddev-sans-first:20.57 02:18:23 INFO - PROCESS | 16066 | Values: 84.0 83.0 131.0 84.0 85.0 83.0 119.0 84.0 83.0 123.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:18:23 INFO - PROCESS | 16066 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:18:23 INFO - PROCESS | 16066 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:18:23 INFO - PROCESS | 16066 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 95.0 96.0 94.0 94.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:64.50 stddev:6.40 (9.9%) stddev-sans-first:6.66 02:18:23 INFO - PROCESS | 16066 | Values: 63.0 63.0 67.0 63.0 64.0 75.0 65.0 81.0 62.0 62.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.65 (2.5%) stddev-sans-first:1.74 02:18:23 INFO - PROCESS | 16066 | Values: 65.0 65.0 66.0 70.0 65.0 64.0 65.0 65.0 65.0 65.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.62 (3.1%) stddev-sans-first:2.51 02:18:23 INFO - PROCESS | 16066 | Values: 82.0 86.0 89.0 84.0 89.0 83.0 88.0 83.0 84.0 84.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:136.00 stddev:11.53 (8.5%) stddev-sans-first:12.12 02:18:23 INFO - PROCESS | 16066 | Values: 133.0 134.0 138.0 144.0 139.0 128.0 129.0 130.0 167.0 132.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:175.50 stddev:3.72 (2.1%) stddev-sans-first:3.91 02:18:23 INFO - PROCESS | 16066 | Values: 175.0 169.0 172.0 177.0 176.0 179.0 176.0 173.0 167.0 172.0 02:18:23 INFO - PROCESS | 16066 | 02:18:23 INFO - PROCESS | 16066 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.62 (2.4%) stddev-sans-first:1.66 02:18:23 INFO - PROCESS | 16066 | Values: 66.0 68.0 67.0 67.0 68.0 70.0 67.0 65.0 69.0 65.0 02:18:23 INFO - PROCESS | 16066 | -------- Summary: end -------- 02:18:23 INFO - PROCESS | 16066 | 02:18:24 INFO - TEST-INFO | 16066: exit 0 02:18:24 INFO - TEST-OK | kraken | took 63621ms 02:18:24 INFO - SUITE-END | took 1182s 02:18:24 INFO - Completed test suite (00:19:42) 02:18:24 INFO - javascript benchmark 02:18:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.9730402695973, 2711.376383431812, 2732.672079350478, 2750.931226719333, 2768.916932492025, 4500.639948804096, 4578.3819184410095, 4661.13768952744, 4730.408698912636, 4794.424669039716, 4647.558481944218, 4688.0, 4690.648201384901, 4702.0360826030665, 4719.528047195278, 4257.531671516139, 4327.783610819446, 4353.455818022747, 4390.538993405694, 4492.483364413101, 4415.911681766363, 4435.578620031108, 4438.8224471021285, 4471.686981911267, 4494.887627809315, 4235.639970602502, 4293.677974151919, 4294.806733696991, 4349.086691794727, 4365.126974605076, 4246.08709127536, 4291.935620965688, 4295.0, 4378.6934914555995, 4395.516493185779, 4326.264535029021, 4327.350897365421, 4342.522322544518, 4380.7152535085115, 4387.758673272969, 4505.864824055284, 4530.546945305443, 4600.516945720685, 4603.10239503297, 4695.225287827504, 4999.900001999976, 5016.598672106259, 5024.422191447957, 5059.898802023976, 5070.29015937769, 5034.622403319766, 5049.823256186016, 5077.111505486562, 5078.187490001619, 5100.15847385181, 4623.306504024423, 4688.2733176357715, 4727.456342520585, 4746.667733258639, 4761.714297142183, 5238.554722848525, 5250.422453530108, 5260.526552610283, 5265.736713164403, 5270.209468579667, 4983.725895075733, 5021.974890125526, 5040.1179793535985, 5043.84868453947, 5044.697318160922, 4870.780814863339, 5001.174806157016, 5048.899022019539, 5128.282040514331, 5139.434662187156, 5035.84892453227, 5038.622103342264, 5070.391553013662, 5073.492650734971, 5085.160948443539, 4985.775640096204, 5010.348654674942, 5012.097822391932, 5022.221555658879, 5062.772175252123, 4198.097409057067, 4229.577042295746, 4312.784360782011, 4330.220560299176, 4378.584034516716, 3715.442683597482, 3773.867914622975, 3778.263238668488, 3804.2391521695217, 3810.0, 4303.784810759449, 4307.160103779733, 4319.3952846601505, 4345.217860785026, 4357.716748411343, 4935.111679897581, 4989.0, 5059.696418214919, 5074.162763144113, 5116.513931176607, 4275.828966841354, 4306.397104405386, 4329.2640251156745, 4332.805023773938, 4333.046729719456, 4560.247559152769, 4565.497795242521, 4565.954340456619, 4584.174848527297, 4609.009063051393, 4593.081383723202, 4696.2955556666775, 4723.480417154179, 4730.266808644666, 4734.928976065431, 5032.094223039888, 5067.0, 5086.923696144487, 5089.567386772166, 5124.256982737407, 4750.263709125091, 4762.59517940965, 4764.094821983812, 4768.0463907218, 4808.08646357191, 4843.24929635907, 4911.845716256748, 4938.604911606991, 5004.4495105537635, 5057.367829021372, 4959.20652695567, 4979.601631869514, 4986.252062190701, 4990.775415106256, 5027.798888044437, 4860.906296083353, 4861.756912154307, 4864.0, 4872.342233798392, 4909.558139767438, 4759.190937540696, 4803.927941080957, 4829.903401932012, 4849.660523763303, 4893.168161412497, 4792.616590672807, 4797.928031079467, 4801.759912004316, 4827.831025914076, 4849.587785038311, 4899.583535399531, 4899.853004409873, 4908.067467181224, 4934.851954441372, 4955.5044495550155, 4689.155951928686, 4728.71627702339, 4747.525247475225, 4805.543473370024, 4810.783514741915], "value": 4628.044859893852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4140976204271, 592.4726992976252, 593.462916060965, 611.2909025530384, 630.9747610095596, 40260.798696006554, 41300.0, 41300.38049429261, 41358.58641413585, 45321.32018019733, 41103.38344924821, 41703.0, 41778.791106044504, 41795.16409671805, 41817.58182418175, 7503.887441688379, 7580.9241907581045, 7627.313541781238, 7632.2749338813, 7632.9236707633045, 7694.422918281123, 7809.140994490602, 7811.33603643691, 7811.804704882395, 7816.687332506693, 7822.491538050037, 7845.058592968823, 7861.410394220427, 7871.252231038042, 7872.252136047066, 7756.0304961879765, 7792.025996750434, 7796.181400952932, 7804.921950780533, 7806.102298235719, 7612.200718924544, 7671.42464315173, 7678.078630564368, 7680.500767450098, 7683.923160768377, 37906.0, 38344.616553834385, 38398.0, 38421.231575368336, 38454.23091538181, 3046.192758918888, 3127.4057928993648, 3138.9686103138906, 3180.3639272145665, 3280.7703460757757, 28868.089354798452, 29063.56404653932, 29122.854385728147, 29423.558646620317, 30839.0, 3532.131207586933, 3535.2045789697368, 3553.307105114504, 3564.7861128332383, 3665.193657395369, 261649.0, 261803.0, 261900.0, 262500.9999999981, 262713.0, 52846.414607561834, 52918.735406322725, 53290.73354633202, 53342.0, 53412.46587534153, 32722.509162362585, 33819.830900845336, 33847.32305353879, 36005.27989440197, 57412.71293643505, 15205.771913421308, 15344.232788360761, 15354.84645153534, 15367.846321536865, 15373.231338433034, 11646.70883227926, 11724.179307448398, 11737.589184378507, 11737.941310293394, 11739.29564226132, 18645.533861653297, 18679.813201867808, 18685.439436816916, 18706.345277915207, 18778.624427511375, 6835.760748373783, 6999.23008469068, 7157.713691452388, 7163.239299367873, 7220.566765994057, 802.9839403211903, 900.243795212025, 900.6847603338779, 1001.5242759689089, 1004.4977511244377, 26969.0, 27679.655453241852, 27879.096926430317, 28019.43961120766, 28330.150095497167, 943.7923656795494, 964.3972517176765, 1005.5726316315537, 1012.7113772574928, 1057.2713613242252, 14379.679518578194, 14506.927465362605, 14539.636509087357, 14783.408663653549, 14830.0, 377511.0, 386887.0, 388993.0, 391017.0, 392624.0, 48376.0, 48897.51102489001, 48949.0, 49116.0, 49154.26268605974, 1121.814900541418, 1206.0592737664635, 1214.2168301445517, 1246.6883279180206, 1251.8873301402734, 26041.218763437126, 26611.33471663224, 26781.33046673771, 26859.597106043817, 26866.59700104539, 41699.7915010423, 41805.79097104617, 42324.36513452239, 42362.99999999877, 42402.0, 326079.0, 328321.0, 328833.0, 329612.0, 329909.0, 21162.788372116083, 23788.643170352112, 25112.497750045262, 25182.607652273004, 25234.873825630755, 39775.60224397719, 39826.203475930895, 40009.0, 40623.0, 40860.59139408568, 33707.0, 35507.46738798972, 35707.64292357147, 36019.0, 36264.27471450609, 34865.0, 35294.47058294179, 35318.29363412769, 35501.0, 35564.822175888956, 33834.66165338414, 34479.827600861834, 34674.47988280228, 34740.0, 34871.65128348785, 31353.68646313599, 31810.52284215785, 31932.361352773278, 32104.357912841144, 32163.51754723728, 24276.786160691543, 26918.59622105709, 27042.594361084204, 27073.323166920985, 27081.593776093767], "value": 17471.610712733793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6917120447619, 364.64082878364803, 371.82895867900766, 375.9962400375997, 376.33952413514277, 15482.690346193083, 16806.663866722673, 16991.660166796657, 17304.221310041063, 17474.82525174748, 15590.922045389785, 15825.0, 15964.361425542993, 16152.192390380493, 16170.2723377448, 4941.654084214116, 5146.588272938156, 5181.378234611851, 5184.403793563732, 5186.092433824085, 3702.0929872181355, 3870.903227419323, 5144.945286216335, 5668.206451096849, 5993.130996005577, 6050.576459647827, 6051.606645568024, 6070.878582428349, 6074.757009719606, 6083.756649734028, 5872.970635146797, 5914.0, 5988.071848863433, 6024.819255422344, 6028.819135425944, 3321.3025264694443, 4876.0, 5200.713960732158, 5222.529972302473, 5234.947650523484, 19542.70685939712, 20370.49073773153, 20372.69440958387, 20385.898070509553, 20425.591488170303, 1969.468243574227, 1971.9507012324807, 2164.5238047629496, 2332.148765700524, 2447.2535876557645, 12494.687632809162, 13038.087333886631, 13293.335333233299, 13430.52993145245, 13467.393967271399, 1731.809500954894, 1741.939032133882, 1744.2412550540555, 1786.7230579260236, 1821.3443160462223, 67825.66087169581, 69731.65134174348, 72086.0, 81651.0, 84529.0, 15264.465743698916, 16070.75893861593, 16640.916795415946, 16837.494875153767, 16922.40771572989, 29426.11721648354, 29739.553906691417, 29935.850320748694, 30059.398812023635, 30179.698203017688, 8694.869576956351, 8746.518941458153, 8756.474611523328, 8964.0, 9688.370255933483, 7607.277308655669, 7616.0, 7721.806954826175, 7814.257645523666, 7827.686892524235, 8545.829083418297, 8614.827703445895, 8670.739877803677, 8783.91216087831, 8849.115088491099, 2598.454324591819, 3285.2180162913446, 3393.389189945784, 3446.3451944130534, 3450.6549345065796, 759.7606753872512, 901.6483571407157, 922.6678395777515, 948.3598570964572, 1004.8944860789658, 16252.918735406483, 16408.425705100264, 16515.504534863972, 16604.0, 16858.072805995787, 882.4308321132834, 884.969026084084, 914.6204325204966, 915.7573243090586, 942.8491441369348, 9015.864762028576, 9104.726858194264, 9369.109934556207, 9439.52802359893, 9588.856167157499, 366658.0, 389612.0, 395416.0, 397314.0, 402713.0, 76869.0, 81894.0, 82043.17956820475, 82080.58959705163, 83527.68877803473, 977.5014742481386, 985.1084768284713, 988.9653862114935, 993.9155171810332, 1000.2198285337448, 14795.186264755543, 15433.151176685391, 15502.147381894105, 15503.302351393988, 15856.52430427089, 34066.65933340734, 34263.657363427046, 34277.65722342845, 35286.823565882005, 35828.462573061945, 48523.0, 49965.500344996086, 50255.0, 50528.40880847016, 51250.74374628103, 6692.83267918306, 7144.785656430316, 7304.5252058616015, 7306.415486761152, 7340.302671246223, 7711.922880771121, 10838.403887786248, 10979.615713449992, 10992.340459572451, 11215.158863085464, 8676.566171691264, 8865.64537418496, 8930.910690893268, 9193.816123677623, 9332.580033898626, 9177.678781242625, 9343.71968840936, 9461.574229159567, 9482.336236463381, 9554.761130971781, 5756.539476841759, 5961.463468287875, 8945.329100317373, 8968.865467018131, 9072.682456114004, 7202.603856787927, 7235.493515454078, 7363.0, 7405.111386633638, 7702.768916932501, 6890.414314783099, 8889.599968001585, 8978.506182160045, 9107.316951228551, 9264.629414823332], "value": 8808.166894987784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.1999480342974, 1404.2417094768825, 1452.6804103097318, 1577.6134846962495, 1759.9032053237074, 6359.71381287842, 7293.416526677866, 7503.812404689872, 7512.286332798382, 7735.187805280449, 7540.585267810268, 7542.886856697154, 7607.125180604218, 7613.505122167056, 7648.541087534752, 2160.7839216078423, 2188.0481990334256, 2191.145453273217, 2193.7257842769654, 2195.7913998170147, 2180.8582442141287, 2207.0619986505753, 2208.624533829253, 2211.447138215446, 2218.8557743746605, 2172.543765809182, 2220.11195521791, 2221.1559607349186, 2224.3771743911648, 2225.944351391212, 2089.60297543467, 2091.173986275428, 2094.3298144593737, 2094.696269040996, 2096.758872729625, 2122.07689654999, 2173.250228671122, 2180.1715348167754, 2180.324099529151, 2181.7818218178213, 7443.739469118555, 7526.698932042712, 7581.696732130708, 7593.316601505836, 7604.771856844303, 4274.829006839723, 4428.468583769936, 4431.601155895953, 4433.578810013076, 4439.511653718088, 2896.391757730879, 2916.8332666933184, 2945.6023436835967, 2960.067578712699, 3010.7741919356135, 895.4671970177734, 920.7928216151313, 926.36081104038, 970.3304719743425, 986.063239922077, 10101.343412678152, 10143.543540540693, 10145.644902428454, 10150.593976241016, 10169.59321627134, 3971.424143499234, 4033.072393349546, 4118.876433706993, 4119.670426365884, 4120.587941205916, 8091.959540202261, 8127.715529956423, 8142.918570814334, 8145.877811832827, 8153.470024448392, 4271.572842715766, 4277.315629499265, 4279.679024073207, 4281.828726850891, 4285.5928686774705, 3440.9311813763584, 3816.1985982943893, 3859.459675645412, 3911.159100793286, 3967.166894952092, 3374.156460884779, 3407.6592340765724, 3485.4946032825096, 3492.5983511896457, 3512.227309991798, 1024.8565200871883, 1031.4120951057826, 1037.8547003419528, 1042.968710938673, 1050.364529459681, 805.6213579617688, 822.3256929318021, 838.9664413423517, 850.3197442046338, 861.0270394454227, 4897.14299997499, 4968.22992436173, 5124.948750512522, 5159.974200128975, 5264.15773476242, 393.84406766141467, 404.6782807667911, 404.7510780869744, 410.5894105894106, 411.71180173878406, 3525.136341596325, 3566.4115420955773, 3583.6740406049407, 3669.0093674708214, 3685.3182161300247, 9454.952725236468, 9692.563834627459, 9857.55640996157, 9893.802123957481, 9894.455804930654, 9441.15029647335, 9660.420374777395, 9693.70918872435, 9700.223982081416, 9705.854412183822, 6675.299093595199, 7342.6695798688115, 7432.777016689508, 7443.255674432622, 7454.478186527, 5033.92449113271, 5110.872228194176, 5179.585633149414, 5232.476752324737, 5310.0, 8565.27195188416, 8587.871181932402, 8635.481871087755, 8881.73354799357, 8883.600237989434, 8733.519656418957, 8846.380753347205, 8848.159424854628, 8851.424657397249, 9010.369274150746, 5806.5645076618575, 5944.970275148597, 5958.7616495341435, 6397.680115994275, 6522.445592124723, 6662.866742665023, 6749.0, 7001.054857594159, 7175.282471752783, 7183.604901730246, 6470.255920569195, 6552.312007239171, 6557.147570815763, 6633.270340262471, 6751.223609284995, 6202.658853763086, 6436.292007879036, 6519.315471875385, 6568.211814582281, 6580.407763301326, 5970.850728731816, 6187.3503282154725, 6198.442140207403, 6206.503479721701, 6213.627182369072, 4258.808353624032, 4388.736675799462, 4431.778411079497, 4433.578810013044, 4443.555644435531, 4437.8224871004795, 4448.4439445069365, 4494.865154045384, 4497.100579883971, 4516.887077822949], "value": 3937.0092966305915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.18035925277815, 284.2221902002972, 291.35901017760926, 293.165942892471, 293.2975523620927, 4749.216379297421, 4753.168195565775, 4792.568668819806, 4816.470188279291, 4817.686850354725, 4170.374443833419, 4465.888352791182, 4507.819687212507, 4724.645651576128, 4748.694109119993, 3708.814559272039, 3713.6657700806923, 3714.702823774105, 3734.618191269234, 3734.7591445132907, 3740.251949610089, 3744.1949980754134, 3745.4943582616406, 3762.604926482721, 3766.7739935603813, 3524.1189702574356, 3598.838052287653, 3699.389600715892, 3708.091517578197, 3709.2210635766387, 3701.1672373715833, 3701.1857391373856, 3704.6110158433244, 3705.906757506542, 3721.274351501458, 3278.655741147169, 3281.1305004173914, 3284.359549887773, 3284.704376606093, 3296.884609038696, 4565.885852853672, 4569.657275704336, 4575.611073058794, 4579.427571553556, 4585.72485650862, 4019.839206431739, 4135.8966025849295, 4258.701890867641, 4260.25445547028, 4270.316749320125, 4699.906001879944, 4841.273808928654, 4845.127876982177, 4854.805807767721, 4860.1008813369635, 3514.9279469761714, 3562.251927095287, 3577.3203091412547, 3581.1405262737017, 3623.202895363016, 5031.924521132222, 5136.203888397305, 5191.221316802472, 5192.818251361185, 5238.554722848562, 3632.3098611263777, 3641.471986561987, 3642.9817850910576, 3660.890173294752, 3683.4106542953, 3683.244934788362, 3711.0, 3711.7216208783907, 3721.3115573618966, 3727.1986522897705, 4173.123644034726, 4181.435506206684, 4185.434966279574, 4205.137946720976, 4228.260054490452, 4855.344528488679, 4930.8767280818265, 4968.801247950114, 4978.0, 5011.0, 1267.1889990406148, 1277.4634653445576, 1281.8974482041415, 1286.2861112082883, 1286.3696788573532, 806.6450761664848, 830.4021104804531, 834.7746108550657, 837.1958429584256, 843.9703561654771, 3967.821448034845, 3970.861019864291, 3979.4826672532963, 3982.9203415932097, 3996.7809818005207, 4527.932081018787, 4560.521145279764, 4560.726356418625, 4572.565606267399, 4592.7933243004145, 3895.668868146239, 3976.264391087658, 3993.6805055595482, 4030.556638769733, 4032.6773858091283, 2319.918802841926, 2484.565201089802, 2489.626556016612, 2490.9786987335106, 2493.6061381074373, 4334.851264414932, 4341.936225624742, 4342.913141737211, 4362.825486980485, 4380.649548036149, 4635.559621835988, 4665.743384113838, 4686.484486706459, 4689.859304220879, 4700.55344742249, 4315.8489452869, 4349.369341445473, 4581.785826755912, 4814.9518504815205, 4815.15734746411, 5113.619322782903, 5156.1750119980625, 5157.329547158845, 5166.0, 5168.767405466688, 5017.498250174954, 5018.623603229699, 5044.419891712353, 5062.367204099488, 5063.924041139459, 4611.723296602215, 4807.302941073455, 4812.374391329105, 4876.487968763229, 4883.780229889735, 3575.1955809942556, 3584.121890136829, 3600.8837260449345, 3604.85580576774, 3629.785830643358, 5234.712090834888, 5247.501487358848, 5250.766069973477, 5258.316418865523, 5262.9210561842365, 4958.380202474691, 4982.6512144149565, 5039.21892106724, 5080.212567052113, 5111.514406131411, 4958.677685950402, 4975.726335051607, 5009.920882833583, 5021.824236151717, 5026.271190677405, 4919.975400122977, 4935.457099718957, 4988.825391111293, 4993.825216117419, 5004.824831130893, 4934.235193545006, 5040.57155141817, 5056.367954005749, 5085.949140508696, 5087.186050231945, 4884.731339776205, 4906.288588154769, 4907.484714104968, 4935.629827763004, 4937.8271760488215], "value": 3681.8645591468285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.3783405764524, 747.993067867174, 766.6894907562439, 768.7155752371623, 775.8603451378754, 11305.830412543819, 11869.881301186986, 12067.4569644366, 12099.999999999989, 12124.69688257793, 12142.332171730552, 12546.937265313683, 12569.183003104792, 12596.307203103826, 12606.873931260685, 633.9904901426482, 639.3478651775209, 762.2758379539432, 767.6161919040479, 776.4448419380142, 764.0106062648855, 770.5415277909663, 771.4522688890894, 772.3512249710242, 796.8286818334057, 811.3103861717523, 812.2608426332039, 812.6911773526052, 812.92277233663, 814.7963009247688, 660.7257987935026, 793.4564823096198, 794.5907857453416, 805.1948051948052, 816.8815521749343, 590.1059894260156, 590.657418697159, 590.6603702870866, 590.6633219065135, 592.478618815444, 12552.623421297376, 12567.811482827765, 12569.245845249314, 12592.370381480889, 12618.495260189582, 11921.582744603984, 12333.938330308381, 12381.257124572554, 12464.252144871336, 12601.810972835323, 10779.461026948622, 10827.350358978487, 10872.67381978542, 10906.781864362747, 10993.560257589686, 3159.984200078985, 3281.6062072551445, 3313.867445302209, 3347.8493467794005, 4142.937855932163, 44215.33676994847, 45960.999999999665, 46113.76943115296, 46127.538724613, 46390.0, 9851.211903047739, 9942.602295908082, 9980.151687106678, 10018.899811001796, 10079.042490963348, 14961.326740296712, 14976.850231497545, 14985.325660345092, 14991.32539035746, 14993.400263989319, 6225.066240063936, 6279.780207692709, 6364.586301890362, 6515.804525864231, 6544.051112588648, 3600.4419315006216, 3651.8174091295327, 3696.2977034363385, 3710.2023065040607, 3766.4350347447553, 2683.9865800671264, 2753.765929895941, 2754.669439667253, 2763.6130941668184, 2769.3907340385085, 518.1967949677984, 527.3882296536, 527.6122050293031, 528.2235114381853, 532.9973350133303, 470.71521729353935, 473.95734383905614, 494.5450185829046, 497.6491573440788, 514.6320380927655, 6663.034949447449, 6679.599224046573, 6734.595924244561, 6769.070814817754, 6912.723491060402, 468.7937307584652, 474.43779121740846, 485.3084354794404, 486.30215640555207, 495.4566525273746, 3060.9540856887165, 3077.138401247654, 3085.460044492205, 3102.3329984053535, 3164.0666003529013, 47096.529034709216, 52519.73740131275, 53317.0, 54115.0, 54127.69276147748, 44815.77592112084, 48305.51694483081, 49585.50414495809, 50406.243906341435, 50688.0, 46222.0, 46390.5360946393, 46623.0, 47055.764721176856, 47145.29282060772, 7465.962670186615, 7497.362724168507, 7577.0907491101425, 7736.342410895137, 7792.961035195014, 30957.8452107738, 31445.371092578476, 32159.51760723638, 32219.0, 32318.35363292674, 37993.43009854799, 38438.0, 40489.39265911072, 40902.18195636011, 41035.1792964145, 10521.789564208826, 10648.627298044532, 10715.0, 10785.245032847939, 11208.495617697386, 11859.34773587461, 12040.75918481643, 12089.57686480969, 12492.125551211328, 12738.044646651353, 10806.405647689453, 11115.0, 11267.718307042389, 11535.480903359537, 12026.458809353775, 11095.445227738743, 11095.72260693489, 11110.166737494881, 11621.24461909973, 11665.416729163338, 10811.135109191404, 10820.458977051274, 10845.132389408986, 11084.168687348643, 11431.142664300378, 9449.763755906157, 9515.429074255568, 9516.23870090405, 9545.522723863918, 9978.351407158512, 9402.43585384879, 9697.709068727949, 9699.796675039084, 9706.0, 9706.369086009387], "value": 5800.358760598608, "unit": "score"}], "name": "dromaeo_css", "value": 6254.989907612769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 114.0, 113.0, 115.0, 113.0, 113.0, 112.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 140.0, 173.0, 140.0, 153.0, 158.0, 130.0, 204.0, 130.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 118.0, 76.0, 76.0, 75.0, 78.0, 118.0, 75.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 131.0, 84.0, 85.0, 83.0, 119.0, 84.0, 83.0, 123.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 67.0, 63.0, 64.0, 75.0, 65.0, 81.0, 62.0, 62.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 70.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 89.0, 84.0, 89.0, 83.0, 88.0, 83.0, 84.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 138.0, 144.0, 139.0, 128.0, 129.0, 130.0, 167.0, 132.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 172.0, 177.0, 176.0, 179.0, 176.0, 173.0, 167.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 70.0, 67.0, 65.0, 69.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1557.8000000000002, "alertThreshold": 2.0}]} 02:18:24 INFO - Return code: 0 02:18:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:18:25 ERROR - # TBPL SUCCESS # 02:18:25 INFO - Running post-action listener: _resource_record_post_action 02:18:25 INFO - ##### 02:18:25 INFO - ##### Finished run-tests step (success) 02:18:25 INFO - ##### 02:18:25 INFO - Running post-run listener: _resource_record_post_run 02:18:25 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525328384; Read time: 12; Write time: 359708 02:18:25 INFO - TinderboxPrint: CPU usage
13.1% 02:18:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:18:25 INFO - TinderboxPrint: I/O write bytes / time
525,328,384 / 359,708 02:18:25 INFO - TinderboxPrint: CPU idle
8,313.9 (86.9%) 02:18:25 INFO - TinderboxPrint: CPU user
1,213.7 (12.7%) 02:18:25 INFO - TinderboxPrint: Swap in / out
0 / 0 02:18:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236945408; Read time: 0; Write time: 182536 02:18:25 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288382976; Read time: 12; Write time: 177172 02:18:25 INFO - Running post-run listener: _upload_blobber_files 02:18:25 INFO - Blob upload gear active. 02:18:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:18:25 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 02:18:25 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'] 02:18:25 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 02:18:26 INFO - (blobuploader) - INFO - Open directory for files ... 02:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:26 INFO - (blobuploader) - INFO - Done attempting. 02:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:27 INFO - (blobuploader) - INFO - Done attempting. 02:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:18:31 INFO - (blobuploader) - INFO - Done attempting. 02:18:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:18:31 INFO - Return code: 0 02:18:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:18:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:18:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2b7e4f57822547d520db6145449ce6258dca45efaaa2e0163226f44b971eb240d66be58072ef3c6c530c391da0b3ee8d85f1957d7c5a75b18be1658c2604d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/841b1546704bca48015d7a06ea951f882758776988c374723d8d510f4f885baa5d977a74c7a2a1452223bbb584f3a3ea4bbb18ca623f42caa8f888a900c181a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90fed7e900971536be9fd066ebf7738d48a7e3fb40c4ce67d88f2830bb4ff4f8d5a6685bdf2904a7b3e63c6c2bc26b9fee2195918d158e00d29f10f823a56012"} 02:18:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:18:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:18:31 INFO - Contents: 02:18:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2b7e4f57822547d520db6145449ce6258dca45efaaa2e0163226f44b971eb240d66be58072ef3c6c530c391da0b3ee8d85f1957d7c5a75b18be1658c2604d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/841b1546704bca48015d7a06ea951f882758776988c374723d8d510f4f885baa5d977a74c7a2a1452223bbb584f3a3ea4bbb18ca623f42caa8f888a900c181a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90fed7e900971536be9fd066ebf7738d48a7e3fb40c4ce67d88f2830bb4ff4f8d5a6685bdf2904a7b3e63c6c2bc26b9fee2195918d158e00d29f10f823a56012"} 02:18:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:18:31 INFO - Copying logs to upload dir... 02:18:31 INFO - mkdir: /builds/slave/test/build/upload/logs 02:18:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.516238 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-05-26 02:18:31.346293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 02:18:31.349889) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 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/da2b7e4f57822547d520db6145449ce6258dca45efaaa2e0163226f44b971eb240d66be58072ef3c6c530c391da0b3ee8d85f1957d7c5a75b18be1658c2604d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/841b1546704bca48015d7a06ea951f882758776988c374723d8d510f4f885baa5d977a74c7a2a1452223bbb584f3a3ea4bbb18ca623f42caa8f888a900c181a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90fed7e900971536be9fd066ebf7738d48a7e3fb40c4ce67d88f2830bb4ff4f8d5a6685bdf2904a7b3e63c6c2bc26b9fee2195918d158e00d29f10f823a56012"} build_url:https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/GAlFE-9qRVSTptp2iAVe6g/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/da2b7e4f57822547d520db6145449ce6258dca45efaaa2e0163226f44b971eb240d66be58072ef3c6c530c391da0b3ee8d85f1957d7c5a75b18be1658c2604d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/841b1546704bca48015d7a06ea951f882758776988c374723d8d510f4f885baa5d977a74c7a2a1452223bbb584f3a3ea4bbb18ca623f42caa8f888a900c181a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90fed7e900971536be9fd066ebf7738d48a7e3fb40c4ce67d88f2830bb4ff4f8d5a6685bdf2904a7b3e63c6c2bc26b9fee2195918d158e00d29f10f823a56012"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 02:18:31.377736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:18:31.378562) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464251171.555062-1197876502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 02:18:31.462723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 02:18:31.463744) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 02:18:31.464348) ========= ========= Total master_lag: 0.20 =========