builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1463801223.6 results: success (0) buildid: 20160520173011 builduid: 28fac613c2754170bc0d7bfc0ae618f5 revision: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.603021) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.603508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.603798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.624072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.624444) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 20:27:03-- 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% 46.0M=0s 2016-05-20 20:27:03 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077437 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.715148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.716583) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013783 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:03.766727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 20:27:03.767082) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 911e01d2cbe0f75e5645aa5070e179885a1dbef7 --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 911e01d2cbe0f75e5645aa5070e179885a1dbef7 --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=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 20:27:04,047 truncating revision to first 12 chars 2016-05-20 20:27:04,047 Setting DEBUG logging. 2016-05-20 20:27:04,047 attempt 1/10 2016-05-20 20:27:04,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/911e01d2cbe0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 20:27:05,396 unpacking tar archive at: fx-team-911e01d2cbe0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.628015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 20:27:05.408345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:05.408684) ========= script_repo_revision: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:05.409157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:05.409429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 20:27:05.417144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-20 20:27:05.417431) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:27:05 INFO - MultiFileLogger online at 20160520 20:27:05 in /builds/slave/test 20:27:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:27:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:05 INFO - {'append_to_log': False, 20:27:05 INFO - 'base_work_dir': '/builds/slave/test', 20:27:05 INFO - 'blob_upload_branch': 'Fx-Team', 20:27:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:05 INFO - 'branch': 'Fx-Team', 20:27:05 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:05 INFO - 'config_files': ('talos/linux_config.py',), 20:27:05 INFO - 'default_actions': ('clobber', 20:27:05 INFO - 'read-buildbot-config', 20:27:05 INFO - 'download-and-extract', 20:27:05 INFO - 'populate-webroot', 20:27:05 INFO - 'create-virtualenv', 20:27:05 INFO - 'install', 20:27:05 INFO - 'run-tests'), 20:27:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:05 INFO - 'download_minidump_stackwalk': True, 20:27:05 INFO - 'download_symbols': 'ondemand', 20:27:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:05 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:05 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:05 INFO - 'installer_path': 'installer.exe', 20:27:05 INFO - 'log_level': 'info', 20:27:05 INFO - 'log_name': 'talos', 20:27:05 INFO - 'log_to_console': True, 20:27:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:27:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:27:05 INFO - 'opt_config_files': (), 20:27:05 INFO - 'pip_index': False, 20:27:05 INFO - 'sps_profile': False, 20:27:05 INFO - 'sps_profile_interval': 0, 20:27:05 INFO - 'suite': 'dromaeojs', 20:27:05 INFO - 'system_bits': '32', 20:27:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:05 INFO - 'title': 'talos-linux64-ix-064', 20:27:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:05 INFO - 'use_talos_json': True, 20:27:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:05 INFO - 'work_dir': 'build'} 20:27:05 INFO - ##### 20:27:05 INFO - ##### Running clobber step. 20:27:05 INFO - ##### 20:27:05 INFO - Running pre-action listener: _resource_record_pre_action 20:27:05 INFO - Running main action method: clobber 20:27:05 INFO - rmtree: /builds/slave/test/build 20:27:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:06 INFO - Running post-action listener: _resource_record_post_action 20:27:06 INFO - ##### 20:27:06 INFO - ##### Finished clobber step (success) 20:27:06 INFO - ##### 20:27:06 INFO - ##### 20:27:06 INFO - ##### Running read-buildbot-config step. 20:27:06 INFO - ##### 20:27:06 INFO - Running pre-action listener: _resource_record_pre_action 20:27:06 INFO - Running main action method: read_buildbot_config 20:27:06 INFO - Using buildbot properties: 20:27:06 INFO - { 20:27:06 INFO - "project": "", 20:27:06 INFO - "product": "firefox", 20:27:06 INFO - "script_repo_revision": "production", 20:27:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:27:06 INFO - "repository": "", 20:27:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:27:06 INFO - "buildid": "20160520173011", 20:27:06 INFO - "pgo_build": "True", 20:27:06 INFO - "basedir": "/builds/slave/test", 20:27:06 INFO - "buildnumber": 110, 20:27:06 INFO - "slavename": "talos-linux64-ix-064", 20:27:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:27:06 INFO - "platform": "ubuntu64_hw", 20:27:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:27:06 INFO - "branch": "fx-team", 20:27:06 INFO - "repo_path": "integration/fx-team", 20:27:06 INFO - "revision": "911e01d2cbe0f75e5645aa5070e179885a1dbef7", 20:27:06 INFO - "stage_platform": "linux64-pgo", 20:27:06 INFO - "builduid": "28fac613c2754170bc0d7bfc0ae618f5", 20:27:06 INFO - "slavebuilddir": "test" 20:27:06 INFO - } 20:27:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:27:06 INFO - Running post-action listener: _resource_record_post_action 20:27:06 INFO - ##### 20:27:06 INFO - ##### Finished read-buildbot-config step (success) 20:27:06 INFO - ##### 20:27:06 INFO - ##### 20:27:06 INFO - ##### Running download-and-extract step. 20:27:06 INFO - ##### 20:27:06 INFO - Running pre-action listener: _resource_record_pre_action 20:27:06 INFO - Running main action method: download_and_extract 20:27:06 INFO - mkdir: /builds/slave/test/build/tests 20:27: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')]} 20:27:06 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:27:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:27:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:27:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:27:07 INFO - Downloaded 1361 bytes. 20:27:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:27:07 INFO - Using the following test package requirements: 20:27:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:27:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:27:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'jsshell-linux-x86_64.zip'], 20:27:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:27:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:27:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:27:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:27:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:27:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:07 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:27:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:27:08 INFO - Downloaded 24389154 bytes. 20:27:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:10 INFO - Return code: 0 20:27:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:10 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:27:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:27:11 INFO - Downloaded 24389154 bytes. 20:27:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:12 INFO - Return code: 0 20:27: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')]} 20:27:12 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:27:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:27:13 INFO - Downloaded 10840359 bytes. 20:27:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:27:14 INFO - Return code: 0 20:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:14 INFO - https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:27:16 INFO - Downloaded 58577061 bytes. 20:27:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:27:16 INFO - mkdir: /builds/slave/test/properties 20:27:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:27:16 INFO - Writing to file /builds/slave/test/properties/build_url 20:27:16 INFO - Contents: 20:27:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:27:17 INFO - Running post-action listener: _resource_record_post_action 20:27:17 INFO - Running post-action listener: set_extra_try_arguments 20:27:17 INFO - ##### 20:27:17 INFO - ##### Finished download-and-extract step (success) 20:27:17 INFO - ##### 20:27:17 INFO - ##### 20:27:17 INFO - ##### Running populate-webroot step. 20:27:17 INFO - ##### 20:27:17 INFO - Running pre-action listener: _resource_record_pre_action 20:27:17 INFO - Running main action method: populate_webroot 20:27:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:27:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:27:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:27:17 INFO - '--tppagecycles', 20:27:17 INFO - '7'], 20:27:17 INFO - 'tests': ['tsvgm']}}, 20:27:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:27:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:27:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:27:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:27:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:27:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:27:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['damp', 'tps']}, 20:27:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'tests': ['damp', 'tps']}, 20:27:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['dromaeo_dom']}, 20:27:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:27:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'other-e10s': {'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['a11yr', 20:27:17 INFO - 'ts_paint', 20:27:17 INFO - 'tpaint', 20:27:17 INFO - 'sessionrestore', 20:27:17 INFO - 'sessionrestore_no_auto_restore', 20:27:17 INFO - 'tabpaint']}, 20:27:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['tsvgx', 20:27:17 INFO - 'tsvgr_opacity', 20:27:17 INFO - 'tart', 20:27:17 INFO - 'tscrollx', 20:27:17 INFO - 'cart']}, 20:27:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:27:17 INFO - 'tsvgr_opacity', 20:27:17 INFO - 'tart', 20:27:17 INFO - 'tscrollx', 20:27:17 INFO - 'cart']}, 20:27:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'talos_options': ['--disable-e10s'], 20:27:17 INFO - 'tests': ['tp5o']}, 20:27:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'tests': ['tp5o']}, 20:27:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'talos_options': ['--disable-e10s', 20:27:17 INFO - '--xperf_path', 20:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:27:17 INFO - 'tests': ['tp5n']}, 20:27:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:17 INFO - 'talos_options': ['--xperf_path', 20:27:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:27:17 INFO - 'tests': ['tp5n']}}, 20:27:17 INFO - 'talos.zip': {'path': '', 20:27:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:27:17 INFO - Running post-action listener: _resource_record_post_action 20:27:17 INFO - ##### 20:27:17 INFO - ##### Finished populate-webroot step (success) 20:27:17 INFO - ##### 20:27:17 INFO - ##### 20:27:17 INFO - ##### Running create-virtualenv step. 20:27:17 INFO - ##### 20:27:17 INFO - Running pre-action listener: _resource_record_pre_action 20:27:17 INFO - Running main action method: create_virtualenv 20:27:17 INFO - Creating virtualenv /builds/slave/test/build/venv 20:27:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:27:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:27:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:27:17 INFO - Using real prefix '/usr' 20:27:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:27:18 INFO - Installing distribute.............................................................................................................................................................................................done. 20:27:20 INFO - Installing pip.................done. 20:27:20 INFO - Return code: 0 20:27:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:20 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:27:20 INFO - Using env: {'DISPLAY': ':0', 20:27:20 INFO - 'HOME': '/home/cltbld', 20:27:20 INFO - 'LANG': 'en_US.UTF-8', 20:27:20 INFO - 'LANGUAGE': 'en_US:en', 20:27:20 INFO - 'LOGNAME': 'cltbld', 20:27:20 INFO - 'MAIL': '/var/mail/cltbld', 20:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:20 INFO - 'MOZ_NO_REMOTE': '1', 20:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:20 INFO - 'NO_EM_RESTART': '1', 20:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:20 INFO - 'PWD': '/builds/slave/test', 20:27:20 INFO - 'SHELL': '/bin/bash', 20:27:20 INFO - 'SHLVL': '1', 20:27:20 INFO - 'TERM': 'linux', 20:27:20 INFO - 'TMOUT': '86400', 20:27:20 INFO - 'USER': 'cltbld', 20:27:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:20 INFO - '_': '/tools/buildbot/bin/python'} 20:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:27:20 INFO - Cleaning up... 20:27:20 INFO - Return code: 0 20:27:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:20 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:27:20 INFO - Using env: {'DISPLAY': ':0', 20:27:20 INFO - 'HOME': '/home/cltbld', 20:27:20 INFO - 'LANG': 'en_US.UTF-8', 20:27:20 INFO - 'LANGUAGE': 'en_US:en', 20:27:20 INFO - 'LOGNAME': 'cltbld', 20:27:20 INFO - 'MAIL': '/var/mail/cltbld', 20:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:20 INFO - 'MOZ_NO_REMOTE': '1', 20:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:20 INFO - 'NO_EM_RESTART': '1', 20:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:20 INFO - 'PWD': '/builds/slave/test', 20:27:20 INFO - 'SHELL': '/bin/bash', 20:27:20 INFO - 'SHLVL': '1', 20:27:20 INFO - 'TERM': 'linux', 20:27:20 INFO - 'TMOUT': '86400', 20:27:20 INFO - 'USER': 'cltbld', 20:27:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:20 INFO - '_': '/tools/buildbot/bin/python'} 20:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:20 INFO - Downloading/unpacking psutil>=3.1.1 20:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:27:22 INFO - Installing collected packages: psutil 20:27:22 INFO - Running setup.py install for psutil 20:27:22 INFO - building 'psutil._psutil_linux' extension 20:27:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:27:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:27:22 INFO - building 'psutil._psutil_posix' extension 20:27:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:27:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:27:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:27:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:27:23 INFO - Successfully installed psutil 20:27:23 INFO - Cleaning up... 20:27:23 INFO - Return code: 0 20:27:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:23 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:27:23 INFO - Using env: {'DISPLAY': ':0', 20:27:23 INFO - 'HOME': '/home/cltbld', 20:27:23 INFO - 'LANG': 'en_US.UTF-8', 20:27:23 INFO - 'LANGUAGE': 'en_US:en', 20:27:23 INFO - 'LOGNAME': 'cltbld', 20:27:23 INFO - 'MAIL': '/var/mail/cltbld', 20:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:23 INFO - 'MOZ_NO_REMOTE': '1', 20:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:23 INFO - 'NO_EM_RESTART': '1', 20:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:23 INFO - 'PWD': '/builds/slave/test', 20:27:23 INFO - 'SHELL': '/bin/bash', 20:27:23 INFO - 'SHLVL': '1', 20:27:23 INFO - 'TERM': 'linux', 20:27:23 INFO - 'TMOUT': '86400', 20:27:23 INFO - 'USER': 'cltbld', 20:27:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:23 INFO - '_': '/tools/buildbot/bin/python'} 20:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:27: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 20:27: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 20:27: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 20:27: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 20:27: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 20:27: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 20:27:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:27:25 INFO - Installing collected packages: mozsystemmonitor 20:27:25 INFO - Running setup.py install for mozsystemmonitor 20:27:25 INFO - Successfully installed mozsystemmonitor 20:27:25 INFO - Cleaning up... 20:27:25 INFO - Return code: 0 20:27:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:27:25 INFO - Using env: {'DISPLAY': ':0', 20:27:25 INFO - 'HOME': '/home/cltbld', 20:27:25 INFO - 'LANG': 'en_US.UTF-8', 20:27:25 INFO - 'LANGUAGE': 'en_US:en', 20:27:25 INFO - 'LOGNAME': 'cltbld', 20:27:25 INFO - 'MAIL': '/var/mail/cltbld', 20:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:25 INFO - 'MOZ_NO_REMOTE': '1', 20:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:25 INFO - 'NO_EM_RESTART': '1', 20:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:25 INFO - 'PWD': '/builds/slave/test', 20:27:25 INFO - 'SHELL': '/bin/bash', 20:27:25 INFO - 'SHLVL': '1', 20:27:25 INFO - 'TERM': 'linux', 20:27:25 INFO - 'TMOUT': '86400', 20:27:25 INFO - 'USER': 'cltbld', 20:27:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:25 INFO - '_': '/tools/buildbot/bin/python'} 20:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:25 INFO - Downloading/unpacking blobuploader==1.2.4 20:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:27 INFO - Downloading blobuploader-1.2.4.tar.gz 20:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:27:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:27:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:28 INFO - Downloading docopt-0.6.1.tar.gz 20:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:27:28 INFO - Installing collected packages: blobuploader, requests, docopt 20:27:28 INFO - Running setup.py install for blobuploader 20:27:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:27:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:27:28 INFO - Running setup.py install for requests 20:27:29 INFO - Running setup.py install for docopt 20:27:29 INFO - Successfully installed blobuploader requests docopt 20:27:29 INFO - Cleaning up... 20:27:29 INFO - Return code: 0 20:27:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:29 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:27:29 INFO - Using env: {'DISPLAY': ':0', 20:27:29 INFO - 'HOME': '/home/cltbld', 20:27:29 INFO - 'LANG': 'en_US.UTF-8', 20:27:29 INFO - 'LANGUAGE': 'en_US:en', 20:27:29 INFO - 'LOGNAME': 'cltbld', 20:27:29 INFO - 'MAIL': '/var/mail/cltbld', 20:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:29 INFO - 'MOZ_NO_REMOTE': '1', 20:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:29 INFO - 'NO_EM_RESTART': '1', 20:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:29 INFO - 'PWD': '/builds/slave/test', 20:27:29 INFO - 'SHELL': '/bin/bash', 20:27:29 INFO - 'SHLVL': '1', 20:27:29 INFO - 'TERM': 'linux', 20:27:29 INFO - 'TMOUT': '86400', 20:27:29 INFO - 'USER': 'cltbld', 20:27:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:29 INFO - '_': '/tools/buildbot/bin/python'} 20:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:27:29 INFO - Running setup.py (path:/tmp/pip-doM18k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:27:29 INFO - Running setup.py (path:/tmp/pip-ojbwro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:27:29 INFO - Running setup.py (path:/tmp/pip-ZDz2mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:27:29 INFO - Running setup.py (path:/tmp/pip-Lx8Dcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:27:29 INFO - Running setup.py (path:/tmp/pip-MrLWAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:27:29 INFO - Running setup.py (path:/tmp/pip-RdwDCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:27:29 INFO - Running setup.py (path:/tmp/pip-TA6Asc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:27:29 INFO - Running setup.py (path:/tmp/pip-lQQJvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:27:29 INFO - Running setup.py (path:/tmp/pip-_5wdh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:27:30 INFO - Running setup.py (path:/tmp/pip-qlyq_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:27:30 INFO - Running setup.py (path:/tmp/pip-xf18Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:27:30 INFO - Running setup.py (path:/tmp/pip-A0K1uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:27:30 INFO - Running setup.py (path:/tmp/pip-eCiXmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:27:30 INFO - Running setup.py (path:/tmp/pip-OOsE1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:30 INFO - Running setup.py (path:/tmp/pip-y3i2C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:27:30 INFO - Running setup.py (path:/tmp/pip-8KeCkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:27:30 INFO - Running setup.py (path:/tmp/pip-oDWzkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:27:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:27:30 INFO - Running setup.py install for manifestparser 20:27:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:27:30 INFO - Running setup.py install for mozcrash 20:27:30 INFO - Running setup.py install for mozdebug 20:27:30 INFO - Running setup.py install for mozdevice 20:27:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozfile 20:27:31 INFO - Running setup.py install for mozhttpd 20:27:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozinfo 20:27:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozInstall 20:27:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozleak 20:27:31 INFO - Running setup.py install for mozlog 20:27:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for moznetwork 20:27:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozprocess 20:27:31 INFO - Running setup.py install for mozprofile 20:27:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:27:31 INFO - Running setup.py install for mozrunner 20:27:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:27:32 INFO - Running setup.py install for mozscreenshot 20:27:32 INFO - Running setup.py install for moztest 20:27:32 INFO - Running setup.py install for mozversion 20:27:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:27:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:27:32 INFO - Cleaning up... 20:27:32 INFO - Return code: 0 20:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:32 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:27:32 INFO - Using env: {'DISPLAY': ':0', 20:27:32 INFO - 'HOME': '/home/cltbld', 20:27:32 INFO - 'LANG': 'en_US.UTF-8', 20:27:32 INFO - 'LANGUAGE': 'en_US:en', 20:27:32 INFO - 'LOGNAME': 'cltbld', 20:27:32 INFO - 'MAIL': '/var/mail/cltbld', 20:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:32 INFO - 'MOZ_NO_REMOTE': '1', 20:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:32 INFO - 'NO_EM_RESTART': '1', 20:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:32 INFO - 'PWD': '/builds/slave/test', 20:27:32 INFO - 'SHELL': '/bin/bash', 20:27:32 INFO - 'SHLVL': '1', 20:27:32 INFO - 'TERM': 'linux', 20:27:32 INFO - 'TMOUT': '86400', 20:27:32 INFO - 'USER': 'cltbld', 20:27:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:32 INFO - '_': '/tools/buildbot/bin/python'} 20:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:27:32 INFO - Running setup.py (path:/tmp/pip-4Wuj7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:27:32 INFO - Running setup.py (path:/tmp/pip-15SVC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:27:32 INFO - Running setup.py (path:/tmp/pip-B30gPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:27:32 INFO - Running setup.py (path:/tmp/pip-cdF3ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:27:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:27:32 INFO - Running setup.py (path:/tmp/pip-AmIzbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:27:33 INFO - Running setup.py (path:/tmp/pip-sOJWCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:27:33 INFO - Running setup.py (path:/tmp/pip-TGF4wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:27:33 INFO - Running setup.py (path:/tmp/pip-r5EWfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:27:33 INFO - Running setup.py (path:/tmp/pip-vVok2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:27:33 INFO - Running setup.py (path:/tmp/pip-wcrgc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:27:33 INFO - Running setup.py (path:/tmp/pip-rpTkVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:27:33 INFO - Running setup.py (path:/tmp/pip-xgYoSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:27:33 INFO - Running setup.py (path:/tmp/pip-rHMhbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:27:33 INFO - Running setup.py (path:/tmp/pip-8uEzT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:33 INFO - Running setup.py (path:/tmp/pip-PlVznE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:27:33 INFO - Running setup.py (path:/tmp/pip-alPUlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:27:33 INFO - Running setup.py (path:/tmp/pip-bzXbrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:27:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:35 INFO - Downloading blessings-1.6.tar.gz 20:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:27:35 INFO - Installing collected packages: blessings 20:27:35 INFO - Running setup.py install for blessings 20:27:36 INFO - Successfully installed blessings 20:27:36 INFO - Cleaning up... 20:27:36 INFO - Return code: 0 20:27:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:27:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:27:36 INFO - Reading from file tmpfile_stdout 20:27:36 INFO - Current package versions: 20:27:36 INFO - argparse == 1.2.1 20:27:36 INFO - blessings == 1.6 20:27:36 INFO - blobuploader == 1.2.4 20:27:36 INFO - docopt == 0.6.1 20:27:36 INFO - manifestparser == 1.1 20:27:36 INFO - mozInstall == 1.12 20:27:36 INFO - mozcrash == 0.17 20:27:36 INFO - mozdebug == 0.1 20:27:36 INFO - mozdevice == 0.48 20:27:36 INFO - mozfile == 1.2 20:27:36 INFO - mozhttpd == 0.7 20:27:36 INFO - mozinfo == 0.9 20:27:36 INFO - mozleak == 0.1 20:27:36 INFO - mozlog == 3.2 20:27:36 INFO - moznetwork == 0.27 20:27:36 INFO - mozprocess == 0.22 20:27:36 INFO - mozprofile == 0.28 20:27:36 INFO - mozrunner == 6.11 20:27:36 INFO - mozscreenshot == 0.1 20:27:36 INFO - mozsystemmonitor == 0.3 20:27:36 INFO - moztest == 0.7 20:27:36 INFO - mozversion == 1.4 20:27:36 INFO - psutil == 3.1.1 20:27:36 INFO - requests == 1.2.3 20:27:36 INFO - wsgiref == 0.1.2 20:27:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:36 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:27:36 INFO - Using env: {'DISPLAY': ':0', 20:27:36 INFO - 'HOME': '/home/cltbld', 20:27:36 INFO - 'LANG': 'en_US.UTF-8', 20:27:36 INFO - 'LANGUAGE': 'en_US:en', 20:27:36 INFO - 'LOGNAME': 'cltbld', 20:27:36 INFO - 'MAIL': '/var/mail/cltbld', 20:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:36 INFO - 'MOZ_NO_REMOTE': '1', 20:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:36 INFO - 'NO_EM_RESTART': '1', 20:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:36 INFO - 'PWD': '/builds/slave/test', 20:27:36 INFO - 'SHELL': '/bin/bash', 20:27:36 INFO - 'SHLVL': '1', 20:27:36 INFO - 'TERM': 'linux', 20:27:36 INFO - 'TMOUT': '86400', 20:27:36 INFO - 'USER': 'cltbld', 20:27:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:36 INFO - '_': '/tools/buildbot/bin/python'} 20:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:27:36 INFO - Cleaning up... 20:27:36 INFO - Return code: 0 20:27:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:36 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:27:36 INFO - Using env: {'DISPLAY': ':0', 20:27:36 INFO - 'HOME': '/home/cltbld', 20:27:36 INFO - 'LANG': 'en_US.UTF-8', 20:27:36 INFO - 'LANGUAGE': 'en_US:en', 20:27:36 INFO - 'LOGNAME': 'cltbld', 20:27:36 INFO - 'MAIL': '/var/mail/cltbld', 20:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:36 INFO - 'MOZ_NO_REMOTE': '1', 20:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:36 INFO - 'NO_EM_RESTART': '1', 20:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:36 INFO - 'PWD': '/builds/slave/test', 20:27:36 INFO - 'SHELL': '/bin/bash', 20:27:36 INFO - 'SHLVL': '1', 20:27:36 INFO - 'TERM': 'linux', 20:27:36 INFO - 'TMOUT': '86400', 20:27:36 INFO - 'USER': 'cltbld', 20:27:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:36 INFO - '_': '/tools/buildbot/bin/python'} 20:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:36 INFO - Downloading/unpacking jsonschema 20:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:27:38 INFO - Downloading/unpacking functools32 (from jsonschema) 20:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:38 INFO - Downloading functools32-3.2.3-2.tar.gz 20:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:27:38 INFO - warning: no files found matching '*.txt' 20:27:38 INFO - no previously-included directories found matching 'build' 20:27:38 INFO - no previously-included directories found matching 'dist' 20:27:38 INFO - no previously-included directories found matching '.git*' 20:27:38 INFO - Installing collected packages: jsonschema, functools32 20:27:38 INFO - Running setup.py install for functools32 20:27:38 INFO - warning: no files found matching '*.txt' 20:27:38 INFO - no previously-included directories found matching 'build' 20:27:38 INFO - no previously-included directories found matching 'dist' 20:27:38 INFO - no previously-included directories found matching '.git*' 20:27:39 INFO - Successfully installed jsonschema functools32 20:27:39 INFO - Cleaning up... 20:27:39 INFO - Return code: 0 20:27:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:39 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 0x7fa2a4209f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:27:39 INFO - Using env: {'DISPLAY': ':0', 20:27:39 INFO - 'HOME': '/home/cltbld', 20:27:39 INFO - 'LANG': 'en_US.UTF-8', 20:27:39 INFO - 'LANGUAGE': 'en_US:en', 20:27:39 INFO - 'LOGNAME': 'cltbld', 20:27:39 INFO - 'MAIL': '/var/mail/cltbld', 20:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:39 INFO - 'MOZ_NO_REMOTE': '1', 20:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:39 INFO - 'NO_EM_RESTART': '1', 20:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:39 INFO - 'PWD': '/builds/slave/test', 20:27:39 INFO - 'SHELL': '/bin/bash', 20:27:39 INFO - 'SHLVL': '1', 20:27:39 INFO - 'TERM': 'linux', 20:27:39 INFO - 'TMOUT': '86400', 20:27:39 INFO - 'USER': 'cltbld', 20:27:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:39 INFO - '_': '/tools/buildbot/bin/python'} 20:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:39 INFO - Downloading/unpacking flake8 20:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:27:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:27:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:27:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:27:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:27:41 INFO - no previously-included directories found matching 'docs/_build' 20:27:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:27:41 INFO - Running setup.py install for pep8 20:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:27:42 INFO - no previously-included directories found matching 'docs/_build' 20:27:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:27:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:27:42 INFO - Cleaning up... 20:27:42 INFO - Return code: 0 20:27:42 INFO - Running post-action listener: _resource_record_post_action 20:27:42 INFO - Running post-action listener: _start_resource_monitoring 20:27:42 INFO - Starting resource monitoring. 20:27:42 INFO - ##### 20:27:42 INFO - ##### Finished create-virtualenv step (success) 20:27:42 INFO - ##### 20:27:42 INFO - ##### 20:27:42 INFO - ##### Running install step. 20:27:42 INFO - ##### 20:27:42 INFO - Running pre-action listener: _resource_record_pre_action 20:27:42 INFO - Running main action method: install 20:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:27:42 INFO - Reading from file tmpfile_stdout 20:27:42 INFO - Detecting whether we're running mozinstall >=1.0... 20:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:27:42 INFO - Reading from file tmpfile_stdout 20:27:42 INFO - Output received: 20:27:42 INFO - Usage: mozinstall [options] installer 20:27:42 INFO - Options: 20:27:42 INFO - -h, --help show this help message and exit 20:27:42 INFO - -d DEST, --destination=DEST 20:27:42 INFO - Directory to install application into. [default: 20:27:42 INFO - "/builds/slave/test"] 20:27:42 INFO - --app=APP Application being installed. [default: firefox] 20:27:42 INFO - mkdir: /builds/slave/test/build/application 20:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:27:59 INFO - Reading from file tmpfile_stdout 20:27:59 INFO - Output received: 20:27:59 INFO - /builds/slave/test/build/application/firefox/firefox 20:27:59 INFO - Running post-action listener: _resource_record_post_action 20:27:59 INFO - ##### 20:27:59 INFO - ##### Finished install step (success) 20:27:59 INFO - ##### 20:27:59 INFO - ##### 20:27:59 INFO - ##### Running run-tests step. 20:27:59 INFO - ##### 20:27:59 INFO - Running pre-action listener: _resource_record_pre_action 20:27:59 INFO - Running main action method: run_tests 20:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:27:59 INFO - Python 2.7.3 20:27:59 INFO - Return code: 0 20:27:59 INFO - grabbing minidump binary from tooltool 20:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:27:59 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 0x1b459c0>, '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 0x1b468c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b46d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:27:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:27:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:27:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:27:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:27:59 INFO - Return code: 0 20:27:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:27:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:27:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:27:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:27:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:28:00 INFO - Return code: 0 20:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:28:00 INFO - Using env: {'DISPLAY': ':0', 20:28:00 INFO - 'HOME': '/home/cltbld', 20:28:00 INFO - 'LANG': 'en_US.UTF-8', 20:28:00 INFO - 'LANGUAGE': 'en_US:en', 20:28:00 INFO - 'LOGNAME': 'cltbld', 20:28:00 INFO - 'MAIL': '/var/mail/cltbld', 20:28:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:28:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:00 INFO - 'MOZ_NO_REMOTE': '1', 20:28:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:00 INFO - 'NO_EM_RESTART': '1', 20:28:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:00 INFO - 'PWD': '/builds/slave/test', 20:28:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:28:00 INFO - 'SHELL': '/bin/bash', 20:28:00 INFO - 'SHLVL': '1', 20:28:00 INFO - 'TERM': 'linux', 20:28:00 INFO - 'TMOUT': '86400', 20:28:00 INFO - 'USER': 'cltbld', 20:28:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645', 20:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:00 INFO - '_': '/tools/buildbot/bin/python'} 20:28:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:28:00 INFO - mozversion application_buildid: 20160520173011 20:28:00 INFO - mozversion application_changeset: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 20:28:00 INFO - mozversion application_display_name: Nightly 20:28:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:28:00 INFO - mozversion application_name: Firefox 20:28:00 INFO - mozversion application_remotingname: firefox 20:28:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:28:00 INFO - mozversion application_vendor: Mozilla 20:28:00 INFO - mozversion application_version: 49.0a1 20:28:00 INFO - mozversion platform_buildid: 20160520173011 20:28:00 INFO - mozversion platform_changeset: 911e01d2cbe0f75e5645aa5070e179885a1dbef7 20:28:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:28:00 INFO - mozversion platform_version: 49.0a1 20:28:00 INFO - using testdate: 1463801280 20:28:00 INFO - actual date: 1463801280 20:28:00 INFO - starting webserver on 'localhost:52443' 20:28:00 INFO - SUITE-START | Running 2 tests 20:28:00 INFO - TEST-START | dromaeo_css 20:28:00 INFO - operating with platform_type : linux_ 20:28:00 INFO - Initialising browser for dromaeo_css test... 20:28:00 INFO - TEST-INFO | started process 26491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4EWrgd/profile http://localhost:52443/getInfo.html) 20:28:04 INFO - PROCESS | 26491 | __metrics Screen width/height:1600/1200 20:28:04 INFO - PROCESS | 26491 | colorDepth:24 20:28:04 INFO - PROCESS | 26491 | Browser inner width/height: 1024/697 20:28:04 INFO - PROCESS | 26491 | __metrics 20:28:05 ERROR - PROCESS | 26491 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:28:05 INFO - PROCESS | 26491 | console.error: PushService: 20:28:05 INFO - PROCESS | 26491 | stateChangeProcessEnqueue: Error transitioning state 20:28:05 INFO - PROCESS | 26491 | UnknownError 20:28:06 INFO - TEST-INFO | 26491: exit 0 20:28:06 INFO - Browser initialized. 20:28:06 INFO - Running cycle 1/1 for dromaeo_css test... 20:28:06 INFO - TEST-INFO | started process 26574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4EWrgd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:18 INFO - PROCESS | 26574 | RSS: Main: 153247744 20:28:18 INFO - PROCESS | 26574 | 20:29:09 INFO - PROCESS | 26574 | 1463801349367 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:31:17 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52443/tests/dromaeo/cssquery-ext.html) 20:31:18 INFO - PROCESS | 26574 | RSS: Main: 283787264 20:31:18 INFO - PROCESS | 26574 | 20:34:20 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-ext.html (next: http://localhost:52443/tests/dromaeo/cssquery-jquery.html) 20:34:21 INFO - PROCESS | 26574 | RSS: Main: 237215744 20:34:21 INFO - PROCESS | 26574 | 20:37:23 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52443/tests/dromaeo/cssquery-mootools.html) 20:37:24 INFO - PROCESS | 26574 | RSS: Main: 237752320 20:37:24 INFO - PROCESS | 26574 | 20:40:26 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52443/tests/dromaeo/cssquery-prototype.html) 20:40:26 INFO - PROCESS | 26574 | RSS: Main: 230719488 20:40:26 INFO - PROCESS | 26574 | 20:43:29 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52443/tests/dromaeo/cssquery-yui.html) 20:43:30 INFO - PROCESS | 26574 | RSS: Main: 220463104 20:43:30 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | Cycle 1(1): loaded http://localhost:52443/tests/dromaeo/cssquery-yui.html (next: http://localhost:52443/tests/dromaeo/cssquery-dojo.html) 20:46:32 INFO - PROCESS | 26574 | RSS: Main: 261349376 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | __start_tp_report 20:46:32 INFO - PROCESS | 26574 | _x_x_mozilla_page_load 20:46:32 INFO - PROCESS | 26574 | _x_x_mozilla_page_load_details 20:46:32 INFO - PROCESS | 26574 | |i|pagename|runs| 20:46:32 INFO - PROCESS | 26574 | |0;dojo.html;3146.6853314668538;3152.353767477667;3184.156198607369;3190.186502441877;3216.9195770105744;5340.706261155635;5408.756605952732;5465.890682186359;5552.083906155484;5558.610897237195;5509.3664228613725;5511.944880551193;5526.226328314039;5557.277553917995;5654.293213348332;4908.656394052427;5004.12427825131;5025.1708468102715;5027.271045698371;5062.873428164307;4993.925091123636;5091.516305950947;5111.335526381584;5112.488751124895;5144.768485418165;4789.904201915977;4800.351952486404;4823.541763532458;5010.949890501103;5040.042391945519;4960.2559616057515;5010.674306170124;5040.243963405482;5043.041822053835;5048.3184770056305;4985.1774457214515;4999.9500004999845;5005.124103281911;5008.899822003539;5050.823221187277;5258.579313654898;5406.459354064601;5495.890082198333;5528.253685752412;5549.5837812163845;5888.970555147197;5971.223740913697;5973.910391344133;6004.879902401971;6007.519398448114;6010.278766547998;6026.186464827236;6027.065804800263;6027.065804800263;6036.577439579231;5218.425973142951;5492.752826122834;5547.084731019418;5617.578681598897;5633.802816901389;6085.564856685653;6094.781163214289;6095.146679464879;6095.238095238095;6100.847478812976;5849.736761845727;5886.23478947734;5892.970535147297;5896.380880007538;5898.410158984153;5711.400302968212;5782.335031471434;5812.331581868055;5849.970750146307;5995.070764031582;5842.182094506772;5850.531957443394;5854.882902341929;5855.824325270249;5856.209411729362;5840.795572154954;5875.794347197828;5887;5889.793857214977;5897.941020589825;4313.654907607384;4420.823167073281;4464;4468.64250859937;4514.413126293561;3958.980205098956;3967.6230758077936;3967.7420967637013;4004.3593025115842;4012.7592344459426;5613.298337707786;5630.4369563043365;5630.8029218977135;5636.2954630671165;5637.661740295595;5749.482546570829;5829.7376618052285;5892.882142357129;5903.26209223847;5907.881842363215;5587.05020146576;5595.272614560081;5596.132599447011;5599.244102046253;5599.32808063035;4931.432885218246;5079.720615366116;5084;5085.847424577269;5133.820316288987;6008.639481631116;6082.452579267887;6101.877962440726;6121.418465245794;6125.356837532084;5929.347771745019;5930.614510056833;5947.04847224442;5949.0481522956115;5951.137085122719;5938.257717785277;6064.3935606439;6098.664573448325;6122.908156377569;6137.232845894263;5830.82507524775;5863.970680146572;5866.149408335853;5871;5925.851853703692;5894.115882617642;5899.233099697183;5930.733117009659;5947.910781338197;5962.135490353961;5626.2967129108865;5697.544196464356;5745.482906538432;5812.273465816773;5814.3604203538425;5770.50950669181;5774.884502310014;5776.046952252831;5779.393163717749;5818.592698511064;5634.971825140848;5638.88722225545;5641.774329026957;5642.520385767256;5648.85877853057;5593.300837395325;5596.384397716167;5688.772449102155;5756.827295181151;5802.158686990447;5608.411116832837;5624.3250809903075;5636.633618814764;5661.179129026185;5714.942850571441 20:46:32 INFO - PROCESS | 26574 | |1;ext.html;589.1545632018054;633.4742164003877;645.40622627183;646.1793522226769;657.2113463843386;43811.78094109529;45337;45396.773016134954;45431.77284113579;48699.756501217445;47034;47727.522724772745;47749.283760743616;47778;47790.283145752845;8732.91267087329;8930.55347232639;8932.285417166611;8933.330000249975;8934.240589549896;8787.64849406023;8870.379073464828;8888.288936885034;8890.288776897865;8892.066333035003;8890.022097569263;8925.598348074353;8932;8936.776580585505;8939.106089391074;8872.8669069964;8902.643894244222;8902.86645700315;8919.955400222958;8920.776980575472;8714.912850871473;8825.29397648193;8827.911720882774;8828.823423531558;8833.205011548927;39446.21107577832;39471.8026409869;39638.801805991076;39918.20163596712;39928.20143597141;3593.065802891267;3678.668919797204;3701.2782507411066;3732.7182037417024;4234.364845273203;31632.841835790903;33894;34240.48639270413;34255.143621409414;34430.31139377198;4299.699021068526;4322.459692538433;4389.385486031958;4404.097160082176;4481.126180394825;352632;355956;357833;358039.9999999974;359251;64476.35523644704;64535;65021.34978650248;65397;65469;69456.65271673609;69648;69658;69692.65153674301;70247.29752702407;17692.734608980874;17872.106394680213;17885.46343609694;17914;17937;13278.20330780137;13355.933220334031;13474.258915759532;13477.730445391036;13521.797173042412;18316.74333756346;20585.382438526867;20622.79377206239;20627.17491300361;20670.379888603366;7497.0652146765115;7547;7664.923350766421;7690.923270742101;7968.482048666818;772.7836205862368;1061.2942393308363;1065.7708592652616;1151.4875880233217;1227.8403807505147;30549.85340905143;31664.525032124537;31708.682913171033;32305.676943230268;32586.348273034408;1175.2184797109826;1214.0773012510379;1223.920445171061;1233.6792433967232;1233.8704436034266;16635.16824158787;16890.40883569069;16985.439350477754;17047.48857534251;17072.743908841378;522862;528053;529862;531068;533382;57411;58572.707136464895;58620.70689646524;58714;59013;1295.7602843473987;1402.6283034995733;1417.4613646814144;1421.4981632326972;1442.019426789772;31603.36793264168;33384.49923251104;33433.33133337271;33624.49563256504;34299.14252143716;49965.50034499754;50353.74823125861;50479.49520504895;50544.24183637175;50549.49450505448;370740;375769;376195;377414;377738.33392498584;37975.620243798316;42580.36129457998;45549.54450455453;46560.53439465698;47221;48131.518684812705;48673.75663121662;48976;49179.7541012307;49777.50222497729;40036;40554.59445405626;40823.1835363297;40838;41482.79258603688;40094.39858402068;40209;40265.59734402619;40759.388609170295;41213.58786412098;38878.4168237471;41260.58739412567;42314;42357.15285694331;42494;35945;37192.814035929645;37611;37712.17158713053;37920.43119353267;28525.28686782847;28579.142625721262;28634.28414289576;28800.711992879802;28932.56601150942 20:46:32 INFO - PROCESS | 26574 | |2;jquery.html;392.23318412503556;393.30974140383614;393.521870926824;402.97582145071294;413.87790601772474;14004.509842155527;15765.21173941304;17494.30022799088;19023.143958521865;19087.52281192969;14320.42718291267;17557.297708091693;17763;17895.64208715825;18802;5451.509364157235;5562.916556251659;5681.318241810988;5689.6017278790505;5696.174054762057;4034.5965403459713;5458.563314934796;5621.747021384048;5657.094864821629;5935.584509084366;6227.065940108974;6236.719347629368;6328.177336946191;6333.08170315304;6364.936350636481;6227.190465239535;6254.874902501947;6297.685115744241;6312.621242725429;6320.356707256124;5619.80330688424;5622.971885140548;5637.210790489335;5641.435856414326;5668.064769313059;21750.673739893915;22732;22947.42631434211;23212.651810222862;23221.7677823223;2340.2511196417154;2534.936626584332;2562.308176792256;2573.240893936293;2925.531914893607;13866.4453421863;14104.012719109667;14144.151350918977;14234;14498.130112193303;1918.5299601597558;1925.2202857842597;1994.331898813899;2013.1242909334487;2041.4488088216247;78439.60780196119;79406;81656;82115.17884821135;82888.58555707244;10548.789024219474;10611.204159688054;10626.096781773636;10650.786984260427;10871.239013269153;14909.701805964038;14947.327370268364;15012.924935375253;15042.699146017017;15044.548663540112;7093;7638.388928885787;7689.38484921205;7899.447038707351;8026.678932842621;7526.09686837583;7602.42981776369;7627.54234745917;7957.244061814118;8028.4781489203015;6592.76925307612;6646.60120392778;6690.933090669031;6750.8649827004165;6782.457403407716;1885.4909174522802;1906.4661894669237;1914.0908068667272;1926.8747531410413;1966.2036875065621;971.2375785008734;1013.1337706261188;1030.175859312547;1046.837740150278;1047.889971552976;19548.902255488632;19947.60104797896;20229.19083236654;20304.18783248683;20319.593608127754;1004.9799004020025;1010.1867996263079;1020.7193021918883;1045.7751583409604;1048.2714513413105;10659.73350666224;11133.443327833576;11177.72055698614;11199.776004479865;11227.326360418401;466829;498360;507330;507651;507655;92570;93379.53310233406;93421;94225;94245.5287723557;1044.603050840691;1056.5615269663003;1086.869575650927;1105.958613812017;1113.9610113645983;17364.131793410026;17515.82484175142;17708.380206692706;17776.288948441917;18007.459776206735;38407.03982400463;39545.406818897165;39568.60431395649;40871.591284086775;42335.153296934506;59572.70213648904;59610.40389596049;60920.39079609325;61061;61154;8487.490750554987;8503.617337219963;8638.308935285288;8699.782505437415;9005.954970225106;12097.395130243629;13285.933570332087;13358.532451364155;13461.932690336485;13468.79796803029;11727.35499547533;11931.701707457383;12002.879971200176;12051.216670916363;12213.633590992284;11621.302721836717;11643.184977051525;11737.295762254293;11774.823377649513;11851.348175850411;12025.278483291031;12095.39523023863;12145.056790913412;12382.690432738893;12488.875111248772;8595.140485951355;8620.267277281502;8728.08355122703;8781.121887811169;8839.51382673959;11988.64034078979;12160.270383777002;12301.569445069379;12320.876791231973;12519.24884506896 20:46:32 INFO - PROCESS | 26574 | |3;mootools.html;1344.549575892076;1510.969780604388;1554.7667849822528;1695.4405046334712;1820.7086866101426;8215.548144852031;8487.91512084879;8539.530325832076;8682.435641683287;8812.16284452976;8543.487390756543;8721.084286149959;8727.214550690436;8732.51971141587;8739.475631462117;2011.1653663729535;2284.1662793080573;2320.118355025088;2338.4153961509624;2356.670066190726;2386.4511162432564;2387.8328517003815;2389.916352927648;2390.6653068570413;2391.6532102845076;2343.273585188597;2346.049849810821;2373.991053802127;2375.9881200593973;2377.940551486209;1935.380678182982;2200.251914349129;2243.5288589396246;2260.16373941641;2292.4039749665126;2266.5466906618744;2279.4985103277254;2281.634938409863;2296.207808306132;2298.161171172527;8388.37087218461;8429.957850210709;8439.57802109892;8442.240198382113;8449.155084491564;5018.749062546858;5110.6422550421485;5124.154514505102;5128.871778205537;5162.432132465426;3389.5424117744283;3420.1278673937986;3449.292894956528;3532.6997205237585;3533.2403533240476;1125.7185703574107;1176.4823477669884;1179.8938095571355;1187.3113594115393;1217.7868872947288;11953.342566158944;12053.0960177987;12060.216085954386;12061.33662648554;12085;4484.394606728115;4592.517785632527;4631.8842028948875;4658.627309815207;4666.603338716247;10131.64539241123;10133.64532241368;10144.391336519833;10172.186225101974;10173.745656358502;5251.448597897166;5253.711045892436;5265.131253343232;5268.473152684777;5271.789128434896;4182.602652747984;4631.120087183424;4756.524347565285;4782.067496838084;4837;3889.3582558878034;3971.324874771296;3997.340438827561;4060.6954478414236;4065.959340406558;1268.5052829396543;1271.313490715022;1277.5209296513808;1277.9041571882146;1279.59053103008;974.7319487141093;986.161762501882;989.2728844299434;998.8901220865699;1021.923355748307;5661.235733176051;5734.569907256972;5757;5887.970560147171;5893.057110862242;987.2842189412619;994.2443742755557;996.3971797062673;1006.8590397344377;1034.332855308322;3924.274009308287;4017.9397309040387;4082.0611259410502;4110.403991421227;4119.608637179464;10623.415712135908;10864.945675271572;10866.61966831157;10924.344539327507;10971.177161712743;10765.56937722498;10811.243212975016;10852.782944341227;10858.837117443245;10866.402347870784;7729.884051739228;7735.61321933901;7858.1356050834365;7914.960425197722;7960.243776841191;5569.254526887313;5618.803341883015;5684.687342196054;5693.686847223443;5740.512056475246;9525.666601668909;9758.268129890144;9846.556904939438;10105.24210684187;10126.59493620247;10114.848277275994;10138.543765530421;10167.881533031508;10246.282760206714;10351.120154786928;6939.236683964861;7368.115826100902;7476;7688.308052275322;7819.0617125945255;8591;8644.524551149747;8664.956675216583;8693.826123477369;8700.56497175126;7563.281488258606;7688.423368247516;7756.340711039625;7843.215678432111;7848.64681089341;7162.89255661176;7602.391808655184;7653.234676532302;7801.414893882868;7829.7259595913865;6576.506761992965;6618.2719900811835;6632.602043877383;6646.9335306648245;6647.933520664731;4656.278276867091;4718.433787945469;4769.594584460359;4831.710097394168;4877.926831097608;4924.236743304794;4988.82762550793;5039.344885165052;5072.1123803335;5110.9488905110475 20:46:32 INFO - PROCESS | 26574 | |4;prototype.html;318.5906110647818;324.6899211253253;325.1335191714082;328.66312030169087;329.6456309467323;5289.709066001368;5343.183317671991;5345.7594408251625;5350.063738845706;5374.140137577989;5290.867728306785;5299;5311.57507399408;5320.095583750762;5325.4142044375085;3966.0877998060464;3982.7012974027066;4108.295057551113;4118.691098167649;4125.174965006996;4087.4890638670167;4103.692223083266;4105.794710264489;4112.547619761839;4136.772477513736;3920.6863450924;4085;4089.20260549193;4112.814923328442;4137.6482998944975;3996.780177090259;4072.572379900127;4083.673306135502;4098.221337945811;4130.855420060314;3612.2594868052247;3631.654992775682;3645.1616128290643;3645.8359373828243;3665.633436656313;5087.516685914832;5101.540861322499;5104.744762761884;5106.489351064901;5110.463401342842;4542.318652202163;4644.094401591691;4656.790444430008;4691.507391723888;4697.4832768395445;5353.330833645794;5399.487048730364;5400.243965844785;5447.536959358459;5464.480874316933;3980.7810570418906;3986.720929534934;4006;4006.399040143973;4012.578679238667;5441.83674489766;5653.597221181023;5667.546596272288;5714.971305165069;5722.685252311121;3958.4062390641634;3968.7817170055346;3973.589375771617;3985.3099158068767;4002.2795896738285;3999.060220848098;4034.435179074932;4056.8377264909072;4062.5734297898885;4071.898202544901;4458.372693966744;4588.3805686231935;4600.7469589172915;4671.766411679402;4679.4618618858585;5448.645838020516;5449.7275136243825;5463.399026107125;5469.56243500519;5469.972650136803;1373.8351397832323;1381.6614929342375;1391.867772561605;1396.1483495068;1397.322298685137;886.2112719679491;892.6250974590688;987.8814542254976;1007.7279134633608;1010.3836659637615;5249.790008399621;5297.947020529822;5301.1783173608155;5347.625666203407;5370.543503802142;5651;5683.971580142155;5690.459406356389;5693.348928810598;5721.542276617861;5126.128558145049;5373.543248823894;5398.406175320712;5427.48438898304;5456.263404440349;3038.9392212155635;3052.8856967207253;3059.791382403938;3060.648025477054;3063.969360306413;5611.3266408031295;5771.278590176228;5799.5650326225705;5810.389909059572;5921.171036054956;5684.488396044376;5711.171880077365;5713.542916566665;5733;5776;5820.76716931318;5841.335219462433;5844.415558444121;5865.149553314745;5872.853178670396;5428.782848686008;5636;5670.234518339971;5690.9430905690415;5696;5599.664020158641;5607.214989901336;5620.831375058755;5630.5777066720975;5636.126400407943;5619.381867994599;5815.651060936358;5845.649261044351;5884.705764711833;5895.764169433174;4027.154297597537;4036.8385264589087;4076.1440097578657;4078.1639763847747;4079;5713.342965559014;5738.9139162913425;5763.769449221984;5777.584491799536;5782.392848750821;5329.626926115135;5579.721013949367;5600.831975040755;5622.7750889963945;5641.746121424628;5543.61194716366;5561.165825126263;5568.415316391721;5584.748686309044;5586.832395028156;5149.742512874416;5184.662996905189;5304.552041173269;5353.304070470814;5425.457454254543;5517.862053448535;5561.249231353715;5566.248556444828;5576.498115169654;5587.944120558743;5430.972845135749;5438.83683489496;5442.564594832483;5449.564034877121;5467.316585426822 20:46:32 INFO - PROCESS | 26574 | |5;yui.html;766.0316274436558;781.8201813582875;791.040178083417;804.6298702596807;809.7813590330608;13555.52555660552;13675.589732308033;13788.241646709426;13837.930810345946;13860.861391386083;12770;13147.342632868365;13189.538366157187;13212.339383030834;13396.196228226314;794.6622685358728;800.65171650332;806.5563939833098;806.5846089264033;807.4791759315239;693.1716598664598;799.448380617375;824.7773101262655;825.1294883897485;825.2036784502953;851.7913111287743;856.2678909532353;856.5032281276845;857.7512521368795;857.8498762716531;715.1096884378929;853.9146085391442;854.0605334132466;854.3080105114846;854.6111519258723;613.7637009751234;627.4791922704145;627.6641996531879;627.9591826531306;628.9025201093838;12461.688457788538;12515.687107822378;12516.499340026388;12517.687057823627;12519;13086.672833179247;13277.933610331984;13584.252866092362;13673.589792306248;13722.862771372258;12158.939205303917;12200.694982625417;12284.262944223376;12387.690307742288;12522.060845436628;4428.955710442919;4434.977825110854;4454.754988475633;4467.597916187558;4521.367008618796;56747;56750;56788.716056419864;56907.71546142243;56971.71514142403;10238.283320167666;10396.844047339297;10505.968732830497;10717.0890474309;11306.547738090385;18711.812881871007;18959.336423225395;18978.810211897704;18986.71519927202;19001.714974275397;7457.179710231979;7500.624968751541;7535.54786712799;7599.506032107895;7867.527948323119;4310.181065597589;4313.069529397079;4315.438992930899;4341.804618792162;4417.977910110493;3182.6658200889037;3266.6896644818703;3267.575215222006;3279.1638132276116;3290.983545082307;592.771782863592;607.7204485936519;609.9512039036866;613.1997742945409;619.755196697302;613.2028363127915;615.4922189193933;632.9272133704591;639.7888696730068;655.452696998012;8269.421140520226;8272.917270827335;8287.295579875778;8394.931098677887;8634.654613815503;564.9999500883496;619.8946179149556;622.9470495007976;640.2285246278224;646.9094326794252;3976.741511801724;4122.732022418533;4149.564295748964;4171.624553790113;4234.851780187679;64232.35767642264;65824.34175658182;65990.67004664947;66048.33951660518;66734.33265667378;57338.7133064332;58021;58768.70615646894;58867;58890.41109588935;53898;53967;54250.72874635601;54404.72797635986;55839.44160558424;8788.42875213109;8895.599698013475;8906.153915378029;9017.2786177107;9217.400868943498;36033.81983090068;36486.45270320894;36685.44971825478;37075.44386834253;37083.629163708014;47612.52387476219;48309;48408.27387589119;48579;49633;10914.617988370368;10981.231313807957;11233.438328083726;11260.718482037686;11394.658160255205;12826.688429307924;13015;13053.412596433373;13074.673133171747;13088.411021504246;7360.595167265852;10727.624533141303;10853.186011049045;11719.179657423898;11830.349330786888;11528.135389845627;11727.865944596006;11783.88216117862;12162.574309899112;12335.814962775745;11392.25950313227;11520.251183673034;11859.881401186223;11934.701632459259;12457.626271211879;9108.316876234441;9566.61733530651;9641.469719165232;9782.41305521671;10088.798224035332;9798.18225115101;10110.344347895316;10130.71083025492;10203.489825508546;10315.329503582243 20:46:32 INFO - PROCESS | 26574 | __end_tp_report 20:46:32 INFO - PROCESS | 26574 | __start_cc_report 20:46:32 INFO - PROCESS | 26574 | _x_x_mozilla_cycle_collect,1131 20:46:32 INFO - PROCESS | 26574 | __end_cc_report 20:46:32 INFO - PROCESS | 26574 | __startTimestamp1463802392879__endTimestamp 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | ------- Summary: start ------- 20:46:32 INFO - PROCESS | 26574 | Number of tests: 6 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#0] dojo.html Cycles:165 Average:5474.65 Median:5641.77 stddev:636.64 (11.3%) stddev-sans-first:611.84 20:46:32 INFO - PROCESS | 26574 | Values: 3146.7 3152.4 3184.2 3190.2 3216.9 5340.7 5408.8 5465.9 5552.1 5558.6 5509.4 5511.9 5526.2 5557.3 5654.3 4908.7 5004.1 5025.2 5027.3 5062.9 4993.9 5091.5 5111.3 5112.5 5144.8 4789.9 4800.4 4823.5 5010.9 5040.0 4960.3 5010.7 5040.2 5043.0 5048.3 4985.2 5000.0 5005.1 5008.9 5050.8 5258.6 5406.5 5495.9 5528.3 5549.6 5889.0 5971.2 5973.9 6004.9 6007.5 6010.3 6026.2 6027.1 6027.1 6036.6 5218.4 5492.8 5547.1 5617.6 5633.8 6085.6 6094.8 6095.1 6095.2 6100.8 5849.7 5886.2 5893.0 5896.4 5898.4 5711.4 5782.3 5812.3 5850.0 5995.1 5842.2 5850.5 5854.9 5855.8 5856.2 5840.8 5875.8 5887.0 5889.8 5897.9 4313.7 4420.8 4464.0 4468.6 4514.4 3959.0 3967.6 3967.7 4004.4 4012.8 5613.3 5630.4 5630.8 5636.3 5637.7 5749.5 5829.7 5892.9 5903.3 5907.9 5587.1 5595.3 5596.1 5599.2 5599.3 4931.4 5079.7 5084.0 5085.8 5133.8 6008.6 6082.5 6101.9 6121.4 6125.4 5929.3 5930.6 5947.0 5949.0 5951.1 5938.3 6064.4 6098.7 6122.9 6137.2 5830.8 5864.0 5866.1 5871.0 5925.9 5894.1 5899.2 5930.7 5947.9 5962.1 5626.3 5697.5 5745.5 5812.3 5814.4 5770.5 5774.9 5776.0 5779.4 5818.6 5635.0 5638.9 5641.8 5642.5 5648.9 5593.3 5596.4 5688.8 5756.8 5802.2 5608.4 5624.3 5636.6 5661.2 5714.9 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#1] ext.html Cycles:180 Average:59755.53 Median:41898.40 stddev:113006.27 (269.7%) stddev-sans-first:113235.97 20:46:32 INFO - PROCESS | 26574 | Values: 589.2 633.5 645.4 646.2 657.2 43811.8 45337.0 45396.8 45431.8 48699.8 47034.0 47727.5 47749.3 47778.0 47790.3 8732.9 8930.6 8932.3 8933.3 8934.2 8787.6 8870.4 8888.3 8890.3 8892.1 8890.0 8925.6 8932.0 8936.8 8939.1 8872.9 8902.6 8902.9 8920.0 8920.8 8714.9 8825.3 8827.9 8828.8 8833.2 39446.2 39471.8 39638.8 39918.2 39928.2 3593.1 3678.7 3701.3 3732.7 4234.4 31632.8 33894.0 34240.5 34255.1 34430.3 4299.7 4322.5 4389.4 4404.1 4481.1 352632.0 355956.0 357833.0 358040.0 359251.0 64476.4 64535.0 65021.3 65397.0 65469.0 69456.7 69648.0 69658.0 69692.7 70247.3 17692.7 17872.1 17885.5 17914.0 17937.0 13278.2 13355.9 13474.3 13477.7 13521.8 18316.7 20585.4 20622.8 20627.2 20670.4 7497.1 7547.0 7664.9 7690.9 7968.5 772.8 1061.3 1065.8 1151.5 1227.8 30549.9 31664.5 31708.7 32305.7 32586.3 1175.2 1214.1 1223.9 1233.7 1233.9 16635.2 16890.4 16985.4 17047.5 17072.7 522862.0 528053.0 529862.0 531068.0 533382.0 57411.0 58572.7 58620.7 58714.0 59013.0 1295.8 1402.6 1417.5 1421.5 1442.0 31603.4 33384.5 33433.3 33624.5 34299.1 49965.5 50353.7 50479.5 50544.2 50549.5 370740.0 375769.0 376195.0 377414.0 377738.3 37975.6 42580.4 45549.5 46560.5 47221.0 48131.5 48673.8 48976.0 49179.8 49777.5 40036.0 40554.6 40823.2 40838.0 41482.8 40094.4 40209.0 40265.6 40759.4 41213.6 38878.4 41260.6 42314.0 42357.2 42494.0 35945.0 37192.8 37611.0 37712.2 37920.4 28525.3 28579.1 28634.3 28800.7 28932.6 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#2] jquery.html Cycles:180 Average:29400.48 Median:22839.71 stddev:82052.06 (359.3%) stddev-sans-first:82253.33 20:46:32 INFO - PROCESS | 26574 | Values: 392.2 393.3 393.5 403.0 413.9 14004.5 15765.2 17494.3 19023.1 19087.5 14320.4 17557.3 17763.0 17895.6 18802.0 5451.5 5562.9 5681.3 5689.6 5696.2 4034.6 5458.6 5621.7 5657.1 5935.6 6227.1 6236.7 6328.2 6333.1 6364.9 6227.2 6254.9 6297.7 6312.6 6320.4 5619.8 5623.0 5637.2 5641.4 5668.1 21750.7 22732.0 22947.4 23212.7 23221.8 2340.3 2534.9 2562.3 2573.2 2925.5 13866.4 14104.0 14144.2 14234.0 14498.1 1918.5 1925.2 1994.3 2013.1 2041.4 78439.6 79406.0 81656.0 82115.2 82888.6 10548.8 10611.2 10626.1 10650.8 10871.2 14909.7 14947.3 15012.9 15042.7 15044.5 7093.0 7638.4 7689.4 7899.4 8026.7 7526.1 7602.4 7627.5 7957.2 8028.5 6592.8 6646.6 6690.9 6750.9 6782.5 1885.5 1906.5 1914.1 1926.9 1966.2 971.2 1013.1 1030.2 1046.8 1047.9 19548.9 19947.6 20229.2 20304.2 20319.6 1005.0 1010.2 1020.7 1045.8 1048.3 10659.7 11133.4 11177.7 11199.8 11227.3 466829.0 498360.0 507330.0 507651.0 507655.0 92570.0 93379.5 93421.0 94225.0 94245.5 1044.6 1056.6 1086.9 1106.0 1114.0 17364.1 17515.8 17708.4 17776.3 18007.5 38407.0 39545.4 39568.6 40871.6 42335.2 59572.7 59610.4 60920.4 61061.0 61154.0 8487.5 8503.6 8638.3 8699.8 9006.0 12097.4 13285.9 13358.5 13461.9 13468.8 11727.4 11931.7 12002.9 12051.2 12213.6 11621.3 11643.2 11737.3 11774.8 11851.3 12025.3 12095.4 12145.1 12382.7 12488.9 8595.1 8620.3 8728.1 8781.1 8839.5 11988.6 12160.3 12301.6 12320.9 12519.2 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#3] mootools.html Cycles:180 Average:5706.90 Median:4657.45 stddev:3234.49 (69.4%) stddev-sans-first:3226.95 20:46:32 INFO - PROCESS | 26574 | Values: 1344.5 1511.0 1554.8 1695.4 1820.7 8215.5 8487.9 8539.5 8682.4 8812.2 8543.5 8721.1 8727.2 8732.5 8739.5 2011.2 2284.2 2320.1 2338.4 2356.7 2386.5 2387.8 2389.9 2390.7 2391.7 2343.3 2346.0 2374.0 2376.0 2377.9 1935.4 2200.3 2243.5 2260.2 2292.4 2266.5 2279.5 2281.6 2296.2 2298.2 8388.4 8430.0 8439.6 8442.2 8449.2 5018.7 5110.6 5124.2 5128.9 5162.4 3389.5 3420.1 3449.3 3532.7 3533.2 1125.7 1176.5 1179.9 1187.3 1217.8 11953.3 12053.1 12060.2 12061.3 12085.0 4484.4 4592.5 4631.9 4658.6 4666.6 10131.6 10133.6 10144.4 10172.2 10173.7 5251.4 5253.7 5265.1 5268.5 5271.8 4182.6 4631.1 4756.5 4782.1 4837.0 3889.4 3971.3 3997.3 4060.7 4066.0 1268.5 1271.3 1277.5 1277.9 1279.6 974.7 986.2 989.3 998.9 1021.9 5661.2 5734.6 5757.0 5888.0 5893.1 987.3 994.2 996.4 1006.9 1034.3 3924.3 4017.9 4082.1 4110.4 4119.6 10623.4 10864.9 10866.6 10924.3 10971.2 10765.6 10811.2 10852.8 10858.8 10866.4 7729.9 7735.6 7858.1 7915.0 7960.2 5569.3 5618.8 5684.7 5693.7 5740.5 9525.7 9758.3 9846.6 10105.2 10126.6 10114.8 10138.5 10167.9 10246.3 10351.1 6939.2 7368.1 7476.0 7688.3 7819.1 8591.0 8644.5 8665.0 8693.8 8700.6 7563.3 7688.4 7756.3 7843.2 7848.6 7162.9 7602.4 7653.2 7801.4 7829.7 6576.5 6618.3 6632.6 6646.9 6647.9 4656.3 4718.4 4769.6 4831.7 4877.9 4924.2 4988.8 5039.3 5072.1 5110.9 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#4] prototype.html Cycles:180 Average:4644.78 Median:5336.41 stddev:1365.71 (25.6%) stddev-sans-first:1330.38 20:46:32 INFO - PROCESS | 26574 | Values: 318.6 324.7 325.1 328.7 329.6 5289.7 5343.2 5345.8 5350.1 5374.1 5290.9 5299.0 5311.6 5320.1 5325.4 3966.1 3982.7 4108.3 4118.7 4125.2 4087.5 4103.7 4105.8 4112.5 4136.8 3920.7 4085.0 4089.2 4112.8 4137.6 3996.8 4072.6 4083.7 4098.2 4130.9 3612.3 3631.7 3645.2 3645.8 3665.6 5087.5 5101.5 5104.7 5106.5 5110.5 4542.3 4644.1 4656.8 4691.5 4697.5 5353.3 5399.5 5400.2 5447.5 5464.5 3980.8 3986.7 4006.0 4006.4 4012.6 5441.8 5653.6 5667.5 5715.0 5722.7 3958.4 3968.8 3973.6 3985.3 4002.3 3999.1 4034.4 4056.8 4062.6 4071.9 4458.4 4588.4 4600.7 4671.8 4679.5 5448.6 5449.7 5463.4 5469.6 5470.0 1373.8 1381.7 1391.9 1396.1 1397.3 886.2 892.6 987.9 1007.7 1010.4 5249.8 5297.9 5301.2 5347.6 5370.5 5651.0 5684.0 5690.5 5693.3 5721.5 5126.1 5373.5 5398.4 5427.5 5456.3 3038.9 3052.9 3059.8 3060.6 3064.0 5611.3 5771.3 5799.6 5810.4 5921.2 5684.5 5711.2 5713.5 5733.0 5776.0 5820.8 5841.3 5844.4 5865.1 5872.9 5428.8 5636.0 5670.2 5690.9 5696.0 5599.7 5607.2 5620.8 5630.6 5636.1 5619.4 5815.7 5845.6 5884.7 5895.8 4027.2 4036.8 4076.1 4078.2 4079.0 5713.3 5738.9 5763.8 5777.6 5782.4 5329.6 5579.7 5600.8 5622.8 5641.7 5543.6 5561.2 5568.4 5584.7 5586.8 5149.7 5184.7 5304.6 5353.3 5425.5 5517.9 5561.2 5566.2 5576.5 5587.9 5431.0 5438.8 5442.6 5449.6 5467.3 20:46:32 INFO - PROCESS | 26574 | 20:46:32 INFO - PROCESS | 26574 | [#5] yui.html Cycles:180 Average:15033.11 Median:48358.64 stddev:18293.55 (37.8%) stddev-sans-first:18313.49 20:46:32 INFO - PROCESS | 26574 | Values: 766.0 781.8 791.0 804.6 809.8 13555.5 13675.6 13788.2 13837.9 13860.9 12770.0 13147.3 13189.5 13212.3 13396.2 794.7 800.7 806.6 806.6 807.5 693.2 799.4 824.8 825.1 825.2 851.8 856.3 856.5 857.8 857.8 715.1 853.9 854.1 854.3 854.6 613.8 627.5 627.7 628.0 628.9 12461.7 12515.7 12516.5 12517.7 12519.0 13086.7 13277.9 13584.3 13673.6 13722.9 12158.9 12200.7 12284.3 12387.7 12522.1 4429.0 4435.0 4454.8 4467.6 4521.4 56747.0 56750.0 56788.7 56907.7 56971.7 10238.3 10396.8 10506.0 10717.1 11306.5 18711.8 18959.3 18978.8 18986.7 19001.7 7457.2 7500.6 7535.5 7599.5 7867.5 4310.2 4313.1 4315.4 4341.8 4418.0 3182.7 3266.7 3267.6 3279.2 3291.0 592.8 607.7 610.0 613.2 619.8 613.2 615.5 632.9 639.8 655.5 8269.4 8272.9 8287.3 8394.9 8634.7 565.0 619.9 622.9 640.2 646.9 3976.7 4122.7 4149.6 4171.6 4234.9 64232.4 65824.3 65990.7 66048.3 66734.3 57338.7 58021.0 58768.7 58867.0 58890.4 53898.0 53967.0 54250.7 54404.7 55839.4 8788.4 8895.6 8906.2 9017.3 9217.4 36033.8 36486.5 36685.4 37075.4 37083.6 47612.5 48309.0 48408.3 48579.0 49633.0 10914.6 10981.2 11233.4 11260.7 11394.7 12826.7 13015.0 13053.4 13074.7 13088.4 7360.6 10727.6 10853.2 11719.2 11830.3 11528.1 11727.9 11783.9 12162.6 12335.8 11392.3 11520.3 11859.9 11934.7 12457.6 9108.3 9566.6 9641.5 9782.4 10088.8 9798.2 10110.3 10130.7 10203.5 10315.3 20:46:32 INFO - PROCESS | 26574 | -------- Summary: end -------- 20:46:32 INFO - PROCESS | 26574 | 20:46:33 INFO - TEST-INFO | 26574: exit 0 20:46:33 INFO - TEST-OK | dromaeo_css | took 1113215ms 20:46:33 INFO - TEST-START | kraken 20:46:33 INFO - operating with platform_type : linux_ 20:46:33 INFO - Initialising browser for kraken test... 20:46:33 INFO - TEST-INFO | started process 26752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0yLWR/profile http://localhost:52443/getInfo.html) 20:46:37 INFO - PROCESS | 26752 | __metrics Screen width/height:1600/1200 20:46:37 INFO - PROCESS | 26752 | colorDepth:24 20:46:37 INFO - PROCESS | 26752 | Browser inner width/height: 1024/697 20:46:37 INFO - PROCESS | 26752 | __metrics 20:46:39 ERROR - PROCESS | 26752 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:46:39 INFO - TEST-INFO | 26752: exit 0 20:46:39 INFO - Browser initialized. 20:46:39 INFO - Running cycle 1/1 for kraken test... 20:46:39 INFO - TEST-INFO | started process 26834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0yLWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:51 INFO - PROCESS | 26834 | RSS: Main: 153067520 20:46:51 INFO - PROCESS | 26834 | 20:46:54 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52443/tests/kraken/driver.html?testName=audio-beat-detection) 20:46:55 INFO - PROCESS | 26834 | RSS: Main: 209162240 20:46:55 INFO - PROCESS | 26834 | 20:46:57 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52443/tests/kraken/driver.html?testName=audio-dft) 20:46:58 INFO - PROCESS | 26834 | RSS: Main: 197492736 20:46:58 INFO - PROCESS | 26834 | 20:47:01 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52443/tests/kraken/driver.html?testName=audio-fft) 20:47:02 INFO - PROCESS | 26834 | RSS: Main: 265711616 20:47:02 INFO - PROCESS | 26834 | 20:47:04 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52443/tests/kraken/driver.html?testName=audio-oscillator) 20:47:05 INFO - PROCESS | 26834 | RSS: Main: 174870528 20:47:05 INFO - PROCESS | 26834 | 20:47:07 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:47:07 INFO - PROCESS | 26834 | RSS: Main: 179277824 20:47:07 INFO - PROCESS | 26834 | 20:47:11 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52443/tests/kraken/driver.html?testName=imaging-darkroom) 20:47:11 INFO - PROCESS | 26834 | RSS: Main: 214769664 20:47:11 INFO - PROCESS | 26834 | 20:47:15 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52443/tests/kraken/driver.html?testName=imaging-desaturate) 20:47:15 INFO - PROCESS | 26834 | RSS: Main: 212844544 20:47:15 INFO - PROCESS | 26834 | 20:47:18 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52443/tests/kraken/driver.html?testName=json-parse-financial) 20:47:19 INFO - PROCESS | 26834 | RSS: Main: 214671360 20:47:19 INFO - PROCESS | 26834 | 20:47:21 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:47:21 INFO - PROCESS | 26834 | RSS: Main: 203108352 20:47:21 INFO - PROCESS | 26834 | 20:47:23 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:47:24 INFO - PROCESS | 26834 | RSS: Main: 206368768 20:47:24 INFO - PROCESS | 26834 | 20:47:26 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:47:26 INFO - PROCESS | 26834 | RSS: Main: 216961024 20:47:26 INFO - PROCESS | 26834 | 20:47:29 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:47:30 INFO - PROCESS | 26834 | RSS: Main: 223510528 20:47:30 INFO - PROCESS | 26834 | 20:47:32 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:47:33 INFO - PROCESS | 26834 | RSS: Main: 219721728 20:47:33 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | Cycle 1(1): loaded http://localhost:52443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52443/tests/kraken/driver.html?testName=ai-astar) 20:47:35 INFO - PROCESS | 26834 | RSS: Main: 266518528 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | __start_tp_report 20:47:35 INFO - PROCESS | 26834 | _x_x_mozilla_page_load 20:47:35 INFO - PROCESS | 26834 | _x_x_mozilla_page_load_details 20:47:35 INFO - PROCESS | 26834 | |i|pagename|runs| 20:47:35 INFO - PROCESS | 26834 | |0;ai-astar;111;106;113;113;109;109;110;111;110;111 20:47:35 INFO - PROCESS | 26834 | |1;audio-beat-detection;149;127;128;207;133;126;153;126;158;123 20:47:35 INFO - PROCESS | 26834 | |2;audio-dft;161;161;161;160;162;162;163;163;161;161 20:47:35 INFO - PROCESS | 26834 | |3;audio-fft;76;76;75;141;75;77;74;76;123;74 20:47:35 INFO - PROCESS | 26834 | |4;audio-oscillator;92;92;155;93;92;93;122;91;92;128 20:47:35 INFO - PROCESS | 26834 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;116;116;118 20:47:35 INFO - PROCESS | 26834 | |6;imaging-darkroom;146;145;145;146;146;146;145;146;146;146 20:47:35 INFO - PROCESS | 26834 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 20:47:35 INFO - PROCESS | 26834 | |8;json-parse-financial;55;55;55;54;55;55;54;106;52;51 20:47:35 INFO - PROCESS | 26834 | |9;json-stringify-tinderbox;65;65;64;64;64;64;65;64;64;65 20:47:35 INFO - PROCESS | 26834 | |10;stanford-crypto-aes;78;78;81;79;84;79;79;84;79;85 20:47:35 INFO - PROCESS | 26834 | |11;stanford-crypto-ccm;123;121;127;124;125;122;124;117;189;128 20:47:35 INFO - PROCESS | 26834 | |12;stanford-crypto-pbkdf2;162;163;159;161;158;159;161;160;160;159 20:47:35 INFO - PROCESS | 26834 | |13;stanford-crypto-sha256-iterative;62;63;62;62;62;61;62;65;61;63 20:47:35 INFO - PROCESS | 26834 | __end_tp_report 20:47:35 INFO - PROCESS | 26834 | __start_cc_report 20:47:35 INFO - PROCESS | 26834 | _x_x_mozilla_cycle_collect,1889 20:47:35 INFO - PROCESS | 26834 | __end_cc_report 20:47:35 INFO - PROCESS | 26834 | __startTimestamp1463802455550__endTimestamp 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | ------- Summary: start ------- 20:47:35 INFO - PROCESS | 26834 | Number of tests: 14 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.06 (1.9%) stddev-sans-first:2.17 20:47:35 INFO - PROCESS | 26834 | Values: 111.0 106.0 113.0 113.0 109.0 109.0 110.0 111.0 110.0 111.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:141.00 stddev:25.85 (18.3%) stddev-sans-first:27.33 20:47:35 INFO - PROCESS | 26834 | Values: 149.0 127.0 128.0 207.0 133.0 126.0 153.0 126.0 158.0 123.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 20:47:35 INFO - PROCESS | 26834 | Values: 161.0 161.0 161.0 160.0 162.0 162.0 163.0 163.0 161.0 161.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.50 stddev:24.27 (32.1%) stddev-sans-first:25.43 20:47:35 INFO - PROCESS | 26834 | Values: 76.0 76.0 75.0 141.0 75.0 77.0 74.0 76.0 123.0 74.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:92.00 stddev:22.31 (24.2%) stddev-sans-first:23.16 20:47:35 INFO - PROCESS | 26834 | Values: 92.0 92.0 155.0 93.0 92.0 93.0 122.0 91.0 92.0 128.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:47:35 INFO - PROCESS | 26834 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:47:35 INFO - PROCESS | 26834 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:47:35 INFO - PROCESS | 26834 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:55.00 stddev:16.50 (30.0%) stddev-sans-first:17.44 20:47:35 INFO - PROCESS | 26834 | Values: 55.0 55.0 55.0 54.0 55.0 55.0 54.0 106.0 52.0 51.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:47:35 INFO - PROCESS | 26834 | Values: 65.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.72 (3.4%) stddev-sans-first:2.71 20:47:35 INFO - PROCESS | 26834 | Values: 78.0 78.0 81.0 79.0 84.0 79.0 79.0 84.0 79.0 85.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:124.50 stddev:20.96 (16.8%) stddev-sans-first:22.08 20:47:35 INFO - PROCESS | 26834 | Values: 123.0 121.0 127.0 124.0 125.0 122.0 124.0 117.0 189.0 128.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:1.55 (1.0%) stddev-sans-first:1.50 20:47:35 INFO - PROCESS | 26834 | Values: 162.0 163.0 159.0 161.0 158.0 159.0 161.0 160.0 160.0 159.0 20:47:35 INFO - PROCESS | 26834 | 20:47:35 INFO - PROCESS | 26834 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 20:47:35 INFO - PROCESS | 26834 | Values: 62.0 63.0 62.0 62.0 62.0 61.0 62.0 65.0 61.0 63.0 20:47:35 INFO - PROCESS | 26834 | -------- Summary: end -------- 20:47:35 INFO - PROCESS | 26834 | 20:47:36 INFO - TEST-INFO | 26834: exit 0 20:47:36 INFO - TEST-OK | kraken | took 62962ms 20:47:36 INFO - SUITE-END | took 1176s 20:47:36 INFO - Completed test suite (00:19:36) 20:47:36 INFO - javascript benchmark 20:47:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.6853314668538, 3152.353767477667, 3184.156198607369, 3190.186502441877, 3216.9195770105744, 5340.706261155635, 5408.756605952732, 5465.890682186359, 5552.083906155484, 5558.610897237195, 5509.3664228613725, 5511.944880551193, 5526.226328314039, 5557.277553917995, 5654.293213348332, 4908.656394052427, 5004.12427825131, 5025.1708468102715, 5027.271045698371, 5062.873428164307, 4993.925091123636, 5091.516305950947, 5111.335526381584, 5112.488751124895, 5144.768485418165, 4789.904201915977, 4800.351952486404, 4823.541763532458, 5010.949890501103, 5040.042391945519, 4960.2559616057515, 5010.674306170124, 5040.243963405482, 5043.041822053835, 5048.3184770056305, 4985.1774457214515, 4999.9500004999845, 5005.124103281911, 5008.899822003539, 5050.823221187277, 5258.579313654898, 5406.459354064601, 5495.890082198333, 5528.253685752412, 5549.5837812163845, 5888.970555147197, 5971.223740913697, 5973.910391344133, 6004.879902401971, 6007.519398448114, 6010.278766547998, 6026.186464827236, 6027.065804800263, 6027.065804800263, 6036.577439579231, 5218.425973142951, 5492.752826122834, 5547.084731019418, 5617.578681598897, 5633.802816901389, 6085.564856685653, 6094.781163214289, 6095.146679464879, 6095.238095238095, 6100.847478812976, 5849.736761845727, 5886.23478947734, 5892.970535147297, 5896.380880007538, 5898.410158984153, 5711.400302968212, 5782.335031471434, 5812.331581868055, 5849.970750146307, 5995.070764031582, 5842.182094506772, 5850.531957443394, 5854.882902341929, 5855.824325270249, 5856.209411729362, 5840.795572154954, 5875.794347197828, 5887.0, 5889.793857214977, 5897.941020589825, 4313.654907607384, 4420.823167073281, 4464.0, 4468.64250859937, 4514.413126293561, 3958.980205098956, 3967.6230758077936, 3967.7420967637013, 4004.3593025115842, 4012.7592344459426, 5613.298337707786, 5630.4369563043365, 5630.8029218977135, 5636.2954630671165, 5637.661740295595, 5749.482546570829, 5829.7376618052285, 5892.882142357129, 5903.26209223847, 5907.881842363215, 5587.05020146576, 5595.272614560081, 5596.132599447011, 5599.244102046253, 5599.32808063035, 4931.432885218246, 5079.720615366116, 5084.0, 5085.847424577269, 5133.820316288987, 6008.639481631116, 6082.452579267887, 6101.877962440726, 6121.418465245794, 6125.356837532084, 5929.347771745019, 5930.614510056833, 5947.04847224442, 5949.0481522956115, 5951.137085122719, 5938.257717785277, 6064.3935606439, 6098.664573448325, 6122.908156377569, 6137.232845894263, 5830.82507524775, 5863.970680146572, 5866.149408335853, 5871.0, 5925.851853703692, 5894.115882617642, 5899.233099697183, 5930.733117009659, 5947.910781338197, 5962.135490353961, 5626.2967129108865, 5697.544196464356, 5745.482906538432, 5812.273465816773, 5814.3604203538425, 5770.50950669181, 5774.884502310014, 5776.046952252831, 5779.393163717749, 5818.592698511064, 5634.971825140848, 5638.88722225545, 5641.774329026957, 5642.520385767256, 5648.85877853057, 5593.300837395325, 5596.384397716167, 5688.772449102155, 5756.827295181151, 5802.158686990447, 5608.411116832837, 5624.3250809903075, 5636.633618814764, 5661.179129026185, 5714.942850571441], "value": 5430.735396284222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1545632018054, 633.4742164003877, 645.40622627183, 646.1793522226769, 657.2113463843386, 43811.78094109529, 45337.0, 45396.773016134954, 45431.77284113579, 48699.756501217445, 47034.0, 47727.522724772745, 47749.283760743616, 47778.0, 47790.283145752845, 8732.91267087329, 8930.55347232639, 8932.285417166611, 8933.330000249975, 8934.240589549896, 8787.64849406023, 8870.379073464828, 8888.288936885034, 8890.288776897865, 8892.066333035003, 8890.022097569263, 8925.598348074353, 8932.0, 8936.776580585505, 8939.106089391074, 8872.8669069964, 8902.643894244222, 8902.86645700315, 8919.955400222958, 8920.776980575472, 8714.912850871473, 8825.29397648193, 8827.911720882774, 8828.823423531558, 8833.205011548927, 39446.21107577832, 39471.8026409869, 39638.801805991076, 39918.20163596712, 39928.20143597141, 3593.065802891267, 3678.668919797204, 3701.2782507411066, 3732.7182037417024, 4234.364845273203, 31632.841835790903, 33894.0, 34240.48639270413, 34255.143621409414, 34430.31139377198, 4299.699021068526, 4322.459692538433, 4389.385486031958, 4404.097160082176, 4481.126180394825, 352632.0, 355956.0, 357833.0, 358039.9999999974, 359251.0, 64476.35523644704, 64535.0, 65021.34978650248, 65397.0, 65469.0, 69456.65271673609, 69648.0, 69658.0, 69692.65153674301, 70247.29752702407, 17692.734608980874, 17872.106394680213, 17885.46343609694, 17914.0, 17937.0, 13278.20330780137, 13355.933220334031, 13474.258915759532, 13477.730445391036, 13521.797173042412, 18316.74333756346, 20585.382438526867, 20622.79377206239, 20627.17491300361, 20670.379888603366, 7497.0652146765115, 7547.0, 7664.923350766421, 7690.923270742101, 7968.482048666818, 772.7836205862368, 1061.2942393308363, 1065.7708592652616, 1151.4875880233217, 1227.8403807505147, 30549.85340905143, 31664.525032124537, 31708.682913171033, 32305.676943230268, 32586.348273034408, 1175.2184797109826, 1214.0773012510379, 1223.920445171061, 1233.6792433967232, 1233.8704436034266, 16635.16824158787, 16890.40883569069, 16985.439350477754, 17047.48857534251, 17072.743908841378, 522862.0, 528053.0, 529862.0, 531068.0, 533382.0, 57411.0, 58572.707136464895, 58620.70689646524, 58714.0, 59013.0, 1295.7602843473987, 1402.6283034995733, 1417.4613646814144, 1421.4981632326972, 1442.019426789772, 31603.36793264168, 33384.49923251104, 33433.33133337271, 33624.49563256504, 34299.14252143716, 49965.50034499754, 50353.74823125861, 50479.49520504895, 50544.24183637175, 50549.49450505448, 370740.0, 375769.0, 376195.0, 377414.0, 377738.33392498584, 37975.620243798316, 42580.36129457998, 45549.54450455453, 46560.53439465698, 47221.0, 48131.518684812705, 48673.75663121662, 48976.0, 49179.7541012307, 49777.50222497729, 40036.0, 40554.59445405626, 40823.1835363297, 40838.0, 41482.79258603688, 40094.39858402068, 40209.0, 40265.59734402619, 40759.388609170295, 41213.58786412098, 38878.4168237471, 41260.58739412567, 42314.0, 42357.15285694331, 42494.0, 35945.0, 37192.814035929645, 37611.0, 37712.17158713053, 37920.43119353267, 28525.28686782847, 28579.142625721262, 28634.28414289576, 28800.711992879802, 28932.56601150942], "value": 20837.39484074121, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.23318412503556, 393.30974140383614, 393.521870926824, 402.97582145071294, 413.87790601772474, 14004.509842155527, 15765.21173941304, 17494.30022799088, 19023.143958521865, 19087.52281192969, 14320.42718291267, 17557.297708091693, 17763.0, 17895.64208715825, 18802.0, 5451.509364157235, 5562.916556251659, 5681.318241810988, 5689.6017278790505, 5696.174054762057, 4034.5965403459713, 5458.563314934796, 5621.747021384048, 5657.094864821629, 5935.584509084366, 6227.065940108974, 6236.719347629368, 6328.177336946191, 6333.08170315304, 6364.936350636481, 6227.190465239535, 6254.874902501947, 6297.685115744241, 6312.621242725429, 6320.356707256124, 5619.80330688424, 5622.971885140548, 5637.210790489335, 5641.435856414326, 5668.064769313059, 21750.673739893915, 22732.0, 22947.42631434211, 23212.651810222862, 23221.7677823223, 2340.2511196417154, 2534.936626584332, 2562.308176792256, 2573.240893936293, 2925.531914893607, 13866.4453421863, 14104.012719109667, 14144.151350918977, 14234.0, 14498.130112193303, 1918.5299601597558, 1925.2202857842597, 1994.331898813899, 2013.1242909334487, 2041.4488088216247, 78439.60780196119, 79406.0, 81656.0, 82115.17884821135, 82888.58555707244, 10548.789024219474, 10611.204159688054, 10626.096781773636, 10650.786984260427, 10871.239013269153, 14909.701805964038, 14947.327370268364, 15012.924935375253, 15042.699146017017, 15044.548663540112, 7093.0, 7638.388928885787, 7689.38484921205, 7899.447038707351, 8026.678932842621, 7526.09686837583, 7602.42981776369, 7627.54234745917, 7957.244061814118, 8028.4781489203015, 6592.76925307612, 6646.60120392778, 6690.933090669031, 6750.8649827004165, 6782.457403407716, 1885.4909174522802, 1906.4661894669237, 1914.0908068667272, 1926.8747531410413, 1966.2036875065621, 971.2375785008734, 1013.1337706261188, 1030.175859312547, 1046.837740150278, 1047.889971552976, 19548.902255488632, 19947.60104797896, 20229.19083236654, 20304.18783248683, 20319.593608127754, 1004.9799004020025, 1010.1867996263079, 1020.7193021918883, 1045.7751583409604, 1048.2714513413105, 10659.73350666224, 11133.443327833576, 11177.72055698614, 11199.776004479865, 11227.326360418401, 466829.0, 498360.0, 507330.0, 507651.0, 507655.0, 92570.0, 93379.53310233406, 93421.0, 94225.0, 94245.5287723557, 1044.603050840691, 1056.5615269663003, 1086.869575650927, 1105.958613812017, 1113.9610113645983, 17364.131793410026, 17515.82484175142, 17708.380206692706, 17776.288948441917, 18007.459776206735, 38407.03982400463, 39545.406818897165, 39568.60431395649, 40871.591284086775, 42335.153296934506, 59572.70213648904, 59610.40389596049, 60920.39079609325, 61061.0, 61154.0, 8487.490750554987, 8503.617337219963, 8638.308935285288, 8699.782505437415, 9005.954970225106, 12097.395130243629, 13285.933570332087, 13358.532451364155, 13461.932690336485, 13468.79796803029, 11727.35499547533, 11931.701707457383, 12002.879971200176, 12051.216670916363, 12213.633590992284, 11621.302721836717, 11643.184977051525, 11737.295762254293, 11774.823377649513, 11851.348175850411, 12025.278483291031, 12095.39523023863, 12145.056790913412, 12382.690432738893, 12488.875111248772, 8595.140485951355, 8620.267277281502, 8728.08355122703, 8781.121887811169, 8839.51382673959, 11988.64034078979, 12160.270383777002, 12301.569445069379, 12320.876791231973, 12519.24884506896], "value": 9460.713146743743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.549575892076, 1510.969780604388, 1554.7667849822528, 1695.4405046334712, 1820.7086866101426, 8215.548144852031, 8487.91512084879, 8539.530325832076, 8682.435641683287, 8812.16284452976, 8543.487390756543, 8721.084286149959, 8727.214550690436, 8732.51971141587, 8739.475631462117, 2011.1653663729535, 2284.1662793080573, 2320.118355025088, 2338.4153961509624, 2356.670066190726, 2386.4511162432564, 2387.8328517003815, 2389.916352927648, 2390.6653068570413, 2391.6532102845076, 2343.273585188597, 2346.049849810821, 2373.991053802127, 2375.9881200593973, 2377.940551486209, 1935.380678182982, 2200.251914349129, 2243.5288589396246, 2260.16373941641, 2292.4039749665126, 2266.5466906618744, 2279.4985103277254, 2281.634938409863, 2296.207808306132, 2298.161171172527, 8388.37087218461, 8429.957850210709, 8439.57802109892, 8442.240198382113, 8449.155084491564, 5018.749062546858, 5110.6422550421485, 5124.154514505102, 5128.871778205537, 5162.432132465426, 3389.5424117744283, 3420.1278673937986, 3449.292894956528, 3532.6997205237585, 3533.2403533240476, 1125.7185703574107, 1176.4823477669884, 1179.8938095571355, 1187.3113594115393, 1217.7868872947288, 11953.342566158944, 12053.0960177987, 12060.216085954386, 12061.33662648554, 12085.0, 4484.394606728115, 4592.517785632527, 4631.8842028948875, 4658.627309815207, 4666.603338716247, 10131.64539241123, 10133.64532241368, 10144.391336519833, 10172.186225101974, 10173.745656358502, 5251.448597897166, 5253.711045892436, 5265.131253343232, 5268.473152684777, 5271.789128434896, 4182.602652747984, 4631.120087183424, 4756.524347565285, 4782.067496838084, 4837.0, 3889.3582558878034, 3971.324874771296, 3997.340438827561, 4060.6954478414236, 4065.959340406558, 1268.5052829396543, 1271.313490715022, 1277.5209296513808, 1277.9041571882146, 1279.59053103008, 974.7319487141093, 986.161762501882, 989.2728844299434, 998.8901220865699, 1021.923355748307, 5661.235733176051, 5734.569907256972, 5757.0, 5887.970560147171, 5893.057110862242, 987.2842189412619, 994.2443742755557, 996.3971797062673, 1006.8590397344377, 1034.332855308322, 3924.274009308287, 4017.9397309040387, 4082.0611259410502, 4110.403991421227, 4119.608637179464, 10623.415712135908, 10864.945675271572, 10866.61966831157, 10924.344539327507, 10971.177161712743, 10765.56937722498, 10811.243212975016, 10852.782944341227, 10858.837117443245, 10866.402347870784, 7729.884051739228, 7735.61321933901, 7858.1356050834365, 7914.960425197722, 7960.243776841191, 5569.254526887313, 5618.803341883015, 5684.687342196054, 5693.686847223443, 5740.512056475246, 9525.666601668909, 9758.268129890144, 9846.556904939438, 10105.24210684187, 10126.59493620247, 10114.848277275994, 10138.543765530421, 10167.881533031508, 10246.282760206714, 10351.120154786928, 6939.236683964861, 7368.115826100902, 7476.0, 7688.308052275322, 7819.0617125945255, 8591.0, 8644.524551149747, 8664.956675216583, 8693.826123477369, 8700.56497175126, 7563.281488258606, 7688.423368247516, 7756.340711039625, 7843.215678432111, 7848.64681089341, 7162.89255661176, 7602.391808655184, 7653.234676532302, 7801.414893882868, 7829.7259595913865, 6576.506761992965, 6618.2719900811835, 6632.602043877383, 6646.9335306648245, 6647.933520664731, 4656.278276867091, 4718.433787945469, 4769.594584460359, 4831.710097394168, 4877.926831097608, 4924.236743304794, 4988.82762550793, 5039.344885165052, 5072.1123803335, 5110.9488905110475], "value": 4593.778052602001, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.5906110647818, 324.6899211253253, 325.1335191714082, 328.66312030169087, 329.6456309467323, 5289.709066001368, 5343.183317671991, 5345.7594408251625, 5350.063738845706, 5374.140137577989, 5290.867728306785, 5299.0, 5311.57507399408, 5320.095583750762, 5325.4142044375085, 3966.0877998060464, 3982.7012974027066, 4108.295057551113, 4118.691098167649, 4125.174965006996, 4087.4890638670167, 4103.692223083266, 4105.794710264489, 4112.547619761839, 4136.772477513736, 3920.6863450924, 4085.0, 4089.20260549193, 4112.814923328442, 4137.6482998944975, 3996.780177090259, 4072.572379900127, 4083.673306135502, 4098.221337945811, 4130.855420060314, 3612.2594868052247, 3631.654992775682, 3645.1616128290643, 3645.8359373828243, 3665.633436656313, 5087.516685914832, 5101.540861322499, 5104.744762761884, 5106.489351064901, 5110.463401342842, 4542.318652202163, 4644.094401591691, 4656.790444430008, 4691.507391723888, 4697.4832768395445, 5353.330833645794, 5399.487048730364, 5400.243965844785, 5447.536959358459, 5464.480874316933, 3980.7810570418906, 3986.720929534934, 4006.0, 4006.399040143973, 4012.578679238667, 5441.83674489766, 5653.597221181023, 5667.546596272288, 5714.971305165069, 5722.685252311121, 3958.4062390641634, 3968.7817170055346, 3973.589375771617, 3985.3099158068767, 4002.2795896738285, 3999.060220848098, 4034.435179074932, 4056.8377264909072, 4062.5734297898885, 4071.898202544901, 4458.372693966744, 4588.3805686231935, 4600.7469589172915, 4671.766411679402, 4679.4618618858585, 5448.645838020516, 5449.7275136243825, 5463.399026107125, 5469.56243500519, 5469.972650136803, 1373.8351397832323, 1381.6614929342375, 1391.867772561605, 1396.1483495068, 1397.322298685137, 886.2112719679491, 892.6250974590688, 987.8814542254976, 1007.7279134633608, 1010.3836659637615, 5249.790008399621, 5297.947020529822, 5301.1783173608155, 5347.625666203407, 5370.543503802142, 5651.0, 5683.971580142155, 5690.459406356389, 5693.348928810598, 5721.542276617861, 5126.128558145049, 5373.543248823894, 5398.406175320712, 5427.48438898304, 5456.263404440349, 3038.9392212155635, 3052.8856967207253, 3059.791382403938, 3060.648025477054, 3063.969360306413, 5611.3266408031295, 5771.278590176228, 5799.5650326225705, 5810.389909059572, 5921.171036054956, 5684.488396044376, 5711.171880077365, 5713.542916566665, 5733.0, 5776.0, 5820.76716931318, 5841.335219462433, 5844.415558444121, 5865.149553314745, 5872.853178670396, 5428.782848686008, 5636.0, 5670.234518339971, 5690.9430905690415, 5696.0, 5599.664020158641, 5607.214989901336, 5620.831375058755, 5630.5777066720975, 5636.126400407943, 5619.381867994599, 5815.651060936358, 5845.649261044351, 5884.705764711833, 5895.764169433174, 4027.154297597537, 4036.8385264589087, 4076.1440097578657, 4078.1639763847747, 4079.0, 5713.342965559014, 5738.9139162913425, 5763.769449221984, 5777.584491799536, 5782.392848750821, 5329.626926115135, 5579.721013949367, 5600.831975040755, 5622.7750889963945, 5641.746121424628, 5543.61194716366, 5561.165825126263, 5568.415316391721, 5584.748686309044, 5586.832395028156, 5149.742512874416, 5184.662996905189, 5304.552041173269, 5353.304070470814, 5425.457454254543, 5517.862053448535, 5561.249231353715, 5566.248556444828, 5576.498115169654, 5587.944120558743, 5430.972845135749, 5438.83683489496, 5442.564594832483, 5449.564034877121, 5467.316585426822], "value": 4208.679000746847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.0316274436558, 781.8201813582875, 791.040178083417, 804.6298702596807, 809.7813590330608, 13555.52555660552, 13675.589732308033, 13788.241646709426, 13837.930810345946, 13860.861391386083, 12770.0, 13147.342632868365, 13189.538366157187, 13212.339383030834, 13396.196228226314, 794.6622685358728, 800.65171650332, 806.5563939833098, 806.5846089264033, 807.4791759315239, 693.1716598664598, 799.448380617375, 824.7773101262655, 825.1294883897485, 825.2036784502953, 851.7913111287743, 856.2678909532353, 856.5032281276845, 857.7512521368795, 857.8498762716531, 715.1096884378929, 853.9146085391442, 854.0605334132466, 854.3080105114846, 854.6111519258723, 613.7637009751234, 627.4791922704145, 627.6641996531879, 627.9591826531306, 628.9025201093838, 12461.688457788538, 12515.687107822378, 12516.499340026388, 12517.687057823627, 12519.0, 13086.672833179247, 13277.933610331984, 13584.252866092362, 13673.589792306248, 13722.862771372258, 12158.939205303917, 12200.694982625417, 12284.262944223376, 12387.690307742288, 12522.060845436628, 4428.955710442919, 4434.977825110854, 4454.754988475633, 4467.597916187558, 4521.367008618796, 56747.0, 56750.0, 56788.716056419864, 56907.71546142243, 56971.71514142403, 10238.283320167666, 10396.844047339297, 10505.968732830497, 10717.0890474309, 11306.547738090385, 18711.812881871007, 18959.336423225395, 18978.810211897704, 18986.71519927202, 19001.714974275397, 7457.179710231979, 7500.624968751541, 7535.54786712799, 7599.506032107895, 7867.527948323119, 4310.181065597589, 4313.069529397079, 4315.438992930899, 4341.804618792162, 4417.977910110493, 3182.6658200889037, 3266.6896644818703, 3267.575215222006, 3279.1638132276116, 3290.983545082307, 592.771782863592, 607.7204485936519, 609.9512039036866, 613.1997742945409, 619.755196697302, 613.2028363127915, 615.4922189193933, 632.9272133704591, 639.7888696730068, 655.452696998012, 8269.421140520226, 8272.917270827335, 8287.295579875778, 8394.931098677887, 8634.654613815503, 564.9999500883496, 619.8946179149556, 622.9470495007976, 640.2285246278224, 646.9094326794252, 3976.741511801724, 4122.732022418533, 4149.564295748964, 4171.624553790113, 4234.851780187679, 64232.35767642264, 65824.34175658182, 65990.67004664947, 66048.33951660518, 66734.33265667378, 57338.7133064332, 58021.0, 58768.70615646894, 58867.0, 58890.41109588935, 53898.0, 53967.0, 54250.72874635601, 54404.72797635986, 55839.44160558424, 8788.42875213109, 8895.599698013475, 8906.153915378029, 9017.2786177107, 9217.400868943498, 36033.81983090068, 36486.45270320894, 36685.44971825478, 37075.44386834253, 37083.629163708014, 47612.52387476219, 48309.0, 48408.27387589119, 48579.0, 49633.0, 10914.617988370368, 10981.231313807957, 11233.438328083726, 11260.718482037686, 11394.658160255205, 12826.688429307924, 13015.0, 13053.412596433373, 13074.673133171747, 13088.411021504246, 7360.595167265852, 10727.624533141303, 10853.186011049045, 11719.179657423898, 11830.349330786888, 11528.135389845627, 11727.865944596006, 11783.88216117862, 12162.574309899112, 12335.814962775745, 11392.25950313227, 11520.251183673034, 11859.881401186223, 11934.701632459259, 12457.626271211879, 9108.316876234441, 9566.61733530651, 9641.469719165232, 9782.41305521671, 10088.798224035332, 9798.18225115101, 10110.344347895316, 10130.71083025492, 10203.489825508546, 10315.329503582243], "value": 6566.249013491013, "unit": "score"}], "name": "dromaeo_css", "value": 7170.526508182513, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 113.0, 113.0, 109.0, 109.0, 110.0, 111.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 128.0, 207.0, 133.0, 126.0, 153.0, 126.0, 158.0, 123.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 163.0, 163.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 141.0, 75.0, 77.0, 74.0, 76.0, 123.0, 74.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 93.0, 92.0, 93.0, 122.0, 91.0, 92.0, 128.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 106.0, 52.0, 51.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 81.0, 79.0, 84.0, 79.0, 79.0, 84.0, 79.0, 85.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 127.0, 124.0, 125.0, 122.0, 124.0, 117.0, 189.0, 128.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 159.0, 161.0, 158.0, 159.0, 161.0, 160.0, 160.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 65.0, 61.0, 63.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1520.8, "alertThreshold": 2.0}]} 20:47:36 INFO - Return code: 0 20:47:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:47:36 ERROR - # TBPL SUCCESS # 20:47:36 INFO - Running post-action listener: _resource_record_post_action 20:47:36 INFO - ##### 20:47:36 INFO - ##### Finished run-tests step (success) 20:47:36 INFO - ##### 20:47:36 INFO - Running post-run listener: _resource_record_post_run 20:47:36 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537968640; Read time: 12; Write time: 538680 20:47:36 INFO - TinderboxPrint: CPU usage
13.1% 20:47:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:47:36 INFO - TinderboxPrint: I/O write bytes / time
537,968,640 / 538,680 20:47:36 INFO - TinderboxPrint: CPU idle
8,278.5 (86.9%) 20:47:36 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 20:47:36 INFO - TinderboxPrint: Swap in / out
0 / 0 20:47:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247050240; Read time: 0; Write time: 317844 20:47:36 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290918400; Read time: 12; Write time: 220836 20:47:37 INFO - Running post-run listener: _upload_blobber_files 20:47:37 INFO - Blob upload gear active. 20:47:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:47:37 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 20:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:47:37 INFO - (blobuploader) - INFO - Open directory for files ... 20:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:38 INFO - (blobuploader) - INFO - Done attempting. 20:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:43 INFO - (blobuploader) - INFO - Done attempting. 20:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:44 INFO - (blobuploader) - INFO - Done attempting. 20:47:44 INFO - (blobuploader) - INFO - Iteration through files over. 20:47:44 INFO - Return code: 0 20:47:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:47:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:47:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1f1a48443b91a91124f9a5080ce4110a61271b0c82068fdfeca1ace2549dd85547905155f7643242c0e3aebca2a759f2fae403c767e865a4420599bcc9de3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d64595146c42ec3c64a7bdaf67b69a9b4183b1329eecd943a0e7d0ed124a956da94a23a361ad0a82bedaee831a8b4cf7b679106ee389c379ab936a52f8292c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e873cc6f53ba6c81dc3adb190d89ce981eff2e1f6c1b9ba9dacb07149ff5a16fb80b46634d97414bd36715a8ff2f79fd5fe3e3743923c6d5e81dc3ecb63e1c"} 20:47:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:47:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:47:44 INFO - Contents: 20:47:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1f1a48443b91a91124f9a5080ce4110a61271b0c82068fdfeca1ace2549dd85547905155f7643242c0e3aebca2a759f2fae403c767e865a4420599bcc9de3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d64595146c42ec3c64a7bdaf67b69a9b4183b1329eecd943a0e7d0ed124a956da94a23a361ad0a82bedaee831a8b4cf7b679106ee389c379ab936a52f8292c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e873cc6f53ba6c81dc3adb190d89ce981eff2e1f6c1b9ba9dacb07149ff5a16fb80b46634d97414bd36715a8ff2f79fd5fe3e3743923c6d5e81dc3ecb63e1c"} 20:47:44 INFO - Running post-run listener: copy_logs_to_upload_dir 20:47:44 INFO - Copying logs to upload dir... 20:47:44 INFO - mkdir: /builds/slave/test/build/upload/logs 20:47:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.713447 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-20 20:47:44.122204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 20:47:44.125883) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1f1a48443b91a91124f9a5080ce4110a61271b0c82068fdfeca1ace2549dd85547905155f7643242c0e3aebca2a759f2fae403c767e865a4420599bcc9de3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d64595146c42ec3c64a7bdaf67b69a9b4183b1329eecd943a0e7d0ed124a956da94a23a361ad0a82bedaee831a8b4cf7b679106ee389c379ab936a52f8292c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e873cc6f53ba6c81dc3adb190d89ce981eff2e1f6c1b9ba9dacb07149ff5a16fb80b46634d97414bd36715a8ff2f79fd5fe3e3743923c6d5e81dc3ecb63e1c"} build_url:https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/WKmOENWsTuK3raohyc2Wvw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1f1a48443b91a91124f9a5080ce4110a61271b0c82068fdfeca1ace2549dd85547905155f7643242c0e3aebca2a759f2fae403c767e865a4420599bcc9de3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d64595146c42ec3c64a7bdaf67b69a9b4183b1329eecd943a0e7d0ed124a956da94a23a361ad0a82bedaee831a8b4cf7b679106ee389c379ab936a52f8292c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e873cc6f53ba6c81dc3adb190d89ce981eff2e1f6c1b9ba9dacb07149ff5a16fb80b46634d97414bd36715a8ff2f79fd5fe3e3743923c6d5e81dc3ecb63e1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 20:47:44.150637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:47:44.150949) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1463801223.74278-1342334645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 20:47:44.235329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 20:47:44.235663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 20:47:44.235946) ========= ========= Total master_lag: 0.15 =========