builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1463454375.03 results: success (0) buildid: 20160516173016 builduid: 1557819d61294a6b8fc8022ab87cecc4 revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.026841) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.027296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.027759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.049248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.049584) ========= 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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 20:06:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-16 20:06:15 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.159711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.160077) ========= 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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019218 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:15.212630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 20:06:15.213063) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf83a5943afc01c163b8fbe438e332a31f08701a --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 cf83a5943afc01c163b8fbe438e332a31f08701a --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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 20:06:15,807 truncating revision to first 12 chars 2016-05-16 20:06:15,807 Setting DEBUG logging. 2016-05-16 20:06:15,807 attempt 1/10 2016-05-16 20:06:15,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf83a5943afc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 20:06:16,818 unpacking tar archive at: fx-team-cf83a5943afc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 20:06:16.539217) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:16.539556) ========= script_repo_revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:16.540003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:16.540309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:06:16.548639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-16 20:06:16.549072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:17 INFO - MultiFileLogger online at 20160516 20:06:17 in /builds/slave/test 20:06:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:06:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:17 INFO - {'append_to_log': False, 20:06:17 INFO - 'base_work_dir': '/builds/slave/test', 20:06:17 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:17 INFO - 'branch': 'Fx-Team', 20:06:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:17 INFO - 'config_files': ('talos/linux_config.py',), 20:06:17 INFO - 'default_actions': ('clobber', 20:06:17 INFO - 'read-buildbot-config', 20:06:17 INFO - 'download-and-extract', 20:06:17 INFO - 'populate-webroot', 20:06:17 INFO - 'create-virtualenv', 20:06:17 INFO - 'install', 20:06:17 INFO - 'run-tests'), 20:06:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:17 INFO - 'download_minidump_stackwalk': True, 20:06:17 INFO - 'download_symbols': 'ondemand', 20:06:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:17 INFO - 'installer_path': 'installer.exe', 20:06:17 INFO - 'log_level': 'info', 20:06:17 INFO - 'log_name': 'talos', 20:06:17 INFO - 'log_to_console': True, 20:06:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:17 INFO - 'opt_config_files': (), 20:06:17 INFO - 'pip_index': False, 20:06:17 INFO - 'sps_profile': False, 20:06:17 INFO - 'sps_profile_interval': 0, 20:06:17 INFO - 'suite': 'dromaeojs-e10s', 20:06:17 INFO - 'system_bits': '32', 20:06:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:17 INFO - 'title': 'talos-linux64-ix-063', 20:06:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:17 INFO - 'use_talos_json': True, 20:06:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:17 INFO - 'work_dir': 'build'} 20:06:17 INFO - ##### 20:06:17 INFO - ##### Running clobber step. 20:06:17 INFO - ##### 20:06:17 INFO - Running pre-action listener: _resource_record_pre_action 20:06:17 INFO - Running main action method: clobber 20:06:17 INFO - rmtree: /builds/slave/test/build 20:06:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:17 INFO - Running post-action listener: _resource_record_post_action 20:06:17 INFO - ##### 20:06:17 INFO - ##### Finished clobber step (success) 20:06:17 INFO - ##### 20:06:17 INFO - ##### 20:06:17 INFO - ##### Running read-buildbot-config step. 20:06:17 INFO - ##### 20:06:17 INFO - Running pre-action listener: _resource_record_pre_action 20:06:17 INFO - Running main action method: read_buildbot_config 20:06:17 INFO - Using buildbot properties: 20:06:17 INFO - { 20:06:17 INFO - "project": "", 20:06:17 INFO - "product": "firefox", 20:06:17 INFO - "script_repo_revision": "production", 20:06:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:06:17 INFO - "repository": "", 20:06:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:06:17 INFO - "buildid": "20160516173016", 20:06:17 INFO - "pgo_build": "True", 20:06:17 INFO - "basedir": "/builds/slave/test", 20:06:17 INFO - "buildnumber": 335, 20:06:17 INFO - "slavename": "talos-linux64-ix-063", 20:06:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:06:17 INFO - "platform": "ubuntu64_hw", 20:06:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:06:17 INFO - "branch": "fx-team", 20:06:17 INFO - "repo_path": "integration/fx-team", 20:06:17 INFO - "revision": "cf83a5943afc01c163b8fbe438e332a31f08701a", 20:06:17 INFO - "stage_platform": "linux64-pgo", 20:06:17 INFO - "builduid": "1557819d61294a6b8fc8022ab87cecc4", 20:06:17 INFO - "slavebuilddir": "test" 20:06:17 INFO - } 20:06:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:06:17 INFO - Running post-action listener: _resource_record_post_action 20:06:17 INFO - ##### 20:06:17 INFO - ##### Finished read-buildbot-config step (success) 20:06:17 INFO - ##### 20:06:17 INFO - ##### 20:06:17 INFO - ##### Running download-and-extract step. 20:06:17 INFO - ##### 20:06:17 INFO - Running pre-action listener: _resource_record_pre_action 20:06:17 INFO - Running main action method: download_and_extract 20:06:17 INFO - mkdir: /builds/slave/test/build/tests 20:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:17 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:20 INFO - Downloaded 1361 bytes. 20:06:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:06:21 INFO - Using the following test package requirements: 20:06:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'jsshell-linux-x86_64.zip'], 20:06:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:21 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:26 INFO - Downloaded 24023206 bytes. 20:06:26 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:06:26 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:06:27 INFO - Return code: 0 20:06:27 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:06:27 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:06:27 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:29 INFO - Downloaded 24023206 bytes. 20:06:29 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:06:29 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:06:31 INFO - Return code: 0 20:06:31 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:06:31 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:32 INFO - Downloaded 10840194 bytes. 20:06:32 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:06:32 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:06:32 INFO - Return code: 0 20:06: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:06:32 INFO - https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y3HsucFLTr26WQZZFgJcEg/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:06:34 INFO - Downloaded 58427509 bytes. 20:06:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:06:34 INFO - mkdir: /builds/slave/test/properties 20:06:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:34 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:34 INFO - Contents: 20:06:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:06:34 INFO - Running post-action listener: _resource_record_post_action 20:06:34 INFO - Running post-action listener: set_extra_try_arguments 20:06:34 INFO - ##### 20:06:34 INFO - ##### Finished download-and-extract step (success) 20:06:34 INFO - ##### 20:06:34 INFO - ##### 20:06:34 INFO - ##### Running populate-webroot step. 20:06:34 INFO - ##### 20:06:34 INFO - Running pre-action listener: _resource_record_pre_action 20:06:34 INFO - Running main action method: populate_webroot 20:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:34 INFO - '--tppagecycles', 20:06:34 INFO - '7'], 20:06:34 INFO - 'tests': ['tsvgm']}}, 20:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s', 20:06:34 INFO - '--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}, 20:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}}, 20:06:34 INFO - 'talos.zip': {'path': '', 20:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:34 INFO - Running post-action listener: _resource_record_post_action 20:06:34 INFO - ##### 20:06:34 INFO - ##### Finished populate-webroot step (success) 20:06:34 INFO - ##### 20:06:34 INFO - ##### 20:06:34 INFO - ##### Running create-virtualenv step. 20:06:34 INFO - ##### 20:06:34 INFO - Running pre-action listener: _resource_record_pre_action 20:06:34 INFO - Running main action method: create_virtualenv 20:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:34 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:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:35 INFO - Using real prefix '/usr' 20:06:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:37 INFO - Installing pip.................done. 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 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:06:37 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:37 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:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:37 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:06:37 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:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 INFO - Downloading/unpacking psutil>=3.1.1 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:40 INFO - Installing collected packages: psutil 20:06:40 INFO - Running setup.py install for psutil 20:06:41 INFO - building 'psutil._psutil_linux' extension 20:06:41 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:06:41 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:06:41 INFO - building 'psutil._psutil_posix' extension 20:06:41 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:06:41 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:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:41 INFO - Successfully installed psutil 20:06:41 INFO - Cleaning up... 20:06:41 INFO - Return code: 0 20:06:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:41 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:41 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:06:41 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:06:41 INFO - Using env: {'DISPLAY': ':0', 20:06:41 INFO - 'HOME': '/home/cltbld', 20:06:41 INFO - 'LANG': 'en_US.UTF-8', 20:06:41 INFO - 'LANGUAGE': 'en_US:en', 20:06:41 INFO - 'LOGNAME': 'cltbld', 20:06:41 INFO - 'MAIL': '/var/mail/cltbld', 20:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:41 INFO - 'MOZ_NO_REMOTE': '1', 20:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:41 INFO - 'NO_EM_RESTART': '1', 20:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:41 INFO - 'PWD': '/builds/slave/test', 20:06:41 INFO - 'SHELL': '/bin/bash', 20:06:41 INFO - 'SHLVL': '1', 20:06:41 INFO - 'TERM': 'linux', 20:06:41 INFO - 'TMOUT': '86400', 20:06:41 INFO - 'USER': 'cltbld', 20:06:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:41 INFO - '_': '/tools/buildbot/bin/python'} 20:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06: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:06: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:06: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:06: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:06: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:06: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:06:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:43 INFO - Installing collected packages: mozsystemmonitor 20:06:43 INFO - Running setup.py install for mozsystemmonitor 20:06:43 INFO - Successfully installed mozsystemmonitor 20:06:43 INFO - Cleaning up... 20:06:43 INFO - Return code: 0 20:06:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:43 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:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:43 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:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:43 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:43 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:06:43 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:06:43 INFO - Using env: {'DISPLAY': ':0', 20:06:43 INFO - 'HOME': '/home/cltbld', 20:06:43 INFO - 'LANG': 'en_US.UTF-8', 20:06:43 INFO - 'LANGUAGE': 'en_US:en', 20:06:43 INFO - 'LOGNAME': 'cltbld', 20:06:43 INFO - 'MAIL': '/var/mail/cltbld', 20:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:43 INFO - 'MOZ_NO_REMOTE': '1', 20:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:43 INFO - 'NO_EM_RESTART': '1', 20:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:43 INFO - 'PWD': '/builds/slave/test', 20:06:43 INFO - 'SHELL': '/bin/bash', 20:06:43 INFO - 'SHLVL': '1', 20:06:43 INFO - 'TERM': 'linux', 20:06:43 INFO - 'TMOUT': '86400', 20:06:43 INFO - 'USER': 'cltbld', 20:06:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:43 INFO - '_': '/tools/buildbot/bin/python'} 20:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:44 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:06:44 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:06:44 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:06:44 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:06:44 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:06:44 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:06:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:46 INFO - Downloading docopt-0.6.1.tar.gz 20:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:46 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:46 INFO - Running setup.py install for blobuploader 20:06:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:46 INFO - Running setup.py install for requests 20:06:47 INFO - Running setup.py install for docopt 20:06:47 INFO - Successfully installed blobuploader requests docopt 20:06:47 INFO - Cleaning up... 20:06:47 INFO - Return code: 0 20:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:47 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:47 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:06:47 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:06:47 INFO - Using env: {'DISPLAY': ':0', 20:06:47 INFO - 'HOME': '/home/cltbld', 20:06:47 INFO - 'LANG': 'en_US.UTF-8', 20:06:47 INFO - 'LANGUAGE': 'en_US:en', 20:06:47 INFO - 'LOGNAME': 'cltbld', 20:06:47 INFO - 'MAIL': '/var/mail/cltbld', 20:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:47 INFO - 'MOZ_NO_REMOTE': '1', 20:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:47 INFO - 'NO_EM_RESTART': '1', 20:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:47 INFO - 'PWD': '/builds/slave/test', 20:06:47 INFO - 'SHELL': '/bin/bash', 20:06:47 INFO - 'SHLVL': '1', 20:06:47 INFO - 'TERM': 'linux', 20:06:47 INFO - 'TMOUT': '86400', 20:06:47 INFO - 'USER': 'cltbld', 20:06:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:47 INFO - '_': '/tools/buildbot/bin/python'} 20:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:47 INFO - Running setup.py (path:/tmp/pip-ILp4np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:47 INFO - Running setup.py (path:/tmp/pip-MUf7TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:47 INFO - Running setup.py (path:/tmp/pip-Y_maUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:47 INFO - Running setup.py (path:/tmp/pip-lysKsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:47 INFO - Running setup.py (path:/tmp/pip-NzyWxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:47 INFO - Running setup.py (path:/tmp/pip-ChS7tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:47 INFO - Running setup.py (path:/tmp/pip-JsQyuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:48 INFO - Running setup.py (path:/tmp/pip-hnzEi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:48 INFO - Running setup.py (path:/tmp/pip-l3AwqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:48 INFO - Running setup.py (path:/tmp/pip-cyKyoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:48 INFO - Running setup.py (path:/tmp/pip-Y_8njp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:48 INFO - Running setup.py (path:/tmp/pip-cbupgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:48 INFO - Running setup.py (path:/tmp/pip-A2setM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:48 INFO - Running setup.py (path:/tmp/pip-zFa06a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:48 INFO - Running setup.py (path:/tmp/pip-1k3VPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:48 INFO - Running setup.py (path:/tmp/pip-tQWAvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:48 INFO - Running setup.py (path:/tmp/pip-zETKCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:48 INFO - Running setup.py install for manifestparser 20:06:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:48 INFO - Running setup.py install for mozcrash 20:06:48 INFO - Running setup.py install for mozdebug 20:06:49 INFO - Running setup.py install for mozdevice 20:06:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozfile 20:06:49 INFO - Running setup.py install for mozhttpd 20:06:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozinfo 20:06:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozInstall 20:06:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozleak 20:06:49 INFO - Running setup.py install for mozlog 20:06:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for moznetwork 20:06:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:49 INFO - Running setup.py install for mozprocess 20:06:49 INFO - Running setup.py install for mozprofile 20:06:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozrunner 20:06:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozscreenshot 20:06:50 INFO - Running setup.py install for moztest 20:06:50 INFO - Running setup.py install for mozversion 20:06:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:50 INFO - Cleaning up... 20:06:50 INFO - Return code: 0 20:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:50 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:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:50 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:50 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:06:50 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:06:50 INFO - Using env: {'DISPLAY': ':0', 20:06:50 INFO - 'HOME': '/home/cltbld', 20:06:50 INFO - 'LANG': 'en_US.UTF-8', 20:06:50 INFO - 'LANGUAGE': 'en_US:en', 20:06:50 INFO - 'LOGNAME': 'cltbld', 20:06:50 INFO - 'MAIL': '/var/mail/cltbld', 20:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:50 INFO - 'MOZ_NO_REMOTE': '1', 20:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:50 INFO - 'NO_EM_RESTART': '1', 20:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:50 INFO - 'PWD': '/builds/slave/test', 20:06:50 INFO - 'SHELL': '/bin/bash', 20:06:50 INFO - 'SHLVL': '1', 20:06:50 INFO - 'TERM': 'linux', 20:06:50 INFO - 'TMOUT': '86400', 20:06:50 INFO - 'USER': 'cltbld', 20:06:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:50 INFO - '_': '/tools/buildbot/bin/python'} 20:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:50 INFO - Running setup.py (path:/tmp/pip-2EtHf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:50 INFO - Running setup.py (path:/tmp/pip-m8nEPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:50 INFO - Running setup.py (path:/tmp/pip-fgjIfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:50 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:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:50 INFO - Running setup.py (path:/tmp/pip-jNA5ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:51 INFO - Running setup.py (path:/tmp/pip-fmdoax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:51 INFO - Running setup.py (path:/tmp/pip-qHoiD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:51 INFO - Running setup.py (path:/tmp/pip-V5_VPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:51 INFO - Running setup.py (path:/tmp/pip-k67IAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:51 INFO - Running setup.py (path:/tmp/pip-3V2HHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:51 INFO - Running setup.py (path:/tmp/pip-ORZorN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:51 INFO - Running setup.py (path:/tmp/pip-IfqXyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:51 INFO - Running setup.py (path:/tmp/pip-jNqong-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:51 INFO - Running setup.py (path:/tmp/pip-85rldQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:51 INFO - Running setup.py (path:/tmp/pip-b_Sd8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:51 INFO - Running setup.py (path:/tmp/pip-II7ML6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:51 INFO - Running setup.py (path:/tmp/pip-oz8mU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:51 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:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:51 INFO - Running setup.py (path:/tmp/pip-hWh1eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:52 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:06:52 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:06:52 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:06:52 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:06:52 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:06:52 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:06:53 INFO - Downloading blessings-1.6.tar.gz 20:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:53 INFO - Installing collected packages: blessings 20:06:53 INFO - Running setup.py install for blessings 20:06:54 INFO - Successfully installed blessings 20:06:54 INFO - Cleaning up... 20:06:54 INFO - Return code: 0 20:06:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Current package versions: 20:06:54 INFO - argparse == 1.2.1 20:06:54 INFO - blessings == 1.6 20:06:54 INFO - blobuploader == 1.2.4 20:06:54 INFO - docopt == 0.6.1 20:06:54 INFO - manifestparser == 1.1 20:06:54 INFO - mozInstall == 1.12 20:06:54 INFO - mozcrash == 0.17 20:06:54 INFO - mozdebug == 0.1 20:06:54 INFO - mozdevice == 0.48 20:06:54 INFO - mozfile == 1.2 20:06:54 INFO - mozhttpd == 0.7 20:06:54 INFO - mozinfo == 0.9 20:06:54 INFO - mozleak == 0.1 20:06:54 INFO - mozlog == 3.2 20:06:54 INFO - moznetwork == 0.27 20:06:54 INFO - mozprocess == 0.22 20:06:54 INFO - mozprofile == 0.28 20:06:54 INFO - mozrunner == 6.11 20:06:54 INFO - mozscreenshot == 0.1 20:06:54 INFO - mozsystemmonitor == 0.3 20:06:54 INFO - moztest == 0.7 20:06:54 INFO - mozversion == 1.4 20:06:54 INFO - psutil == 3.1.1 20:06:54 INFO - requests == 1.2.3 20:06:54 INFO - wsgiref == 0.1.2 20:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:54 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:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 INFO - Cleaning up... 20:06:54 INFO - Return code: 0 20:06:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:54 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:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:54 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:54 INFO - Downloading/unpacking jsonschema 20:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:54 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:06:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:56 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:56 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:06:56 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:06:56 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:06:56 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:06:56 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:06:56 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:06:56 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:56 INFO - warning: no files found matching '*.txt' 20:06:56 INFO - no previously-included directories found matching 'build' 20:06:56 INFO - no previously-included directories found matching 'dist' 20:06:56 INFO - no previously-included directories found matching '.git*' 20:06:56 INFO - Installing collected packages: jsonschema, functools32 20:06:56 INFO - Running setup.py install for functools32 20:06:57 INFO - warning: no files found matching '*.txt' 20:06:57 INFO - no previously-included directories found matching 'build' 20:06:57 INFO - no previously-included directories found matching 'dist' 20:06:57 INFO - no previously-included directories found matching '.git*' 20:06:57 INFO - Successfully installed jsonschema functools32 20:06:57 INFO - Cleaning up... 20:06:57 INFO - Return code: 0 20:06:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:57 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 0x7f8bf10eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, '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': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', '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:06:57 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:06:57 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:06:57 INFO - Using env: {'DISPLAY': ':0', 20:06:57 INFO - 'HOME': '/home/cltbld', 20:06:57 INFO - 'LANG': 'en_US.UTF-8', 20:06:57 INFO - 'LANGUAGE': 'en_US:en', 20:06:57 INFO - 'LOGNAME': 'cltbld', 20:06:57 INFO - 'MAIL': '/var/mail/cltbld', 20:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:57 INFO - 'MOZ_NO_REMOTE': '1', 20:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:57 INFO - 'NO_EM_RESTART': '1', 20:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:57 INFO - 'PWD': '/builds/slave/test', 20:06:57 INFO - 'SHELL': '/bin/bash', 20:06:57 INFO - 'SHLVL': '1', 20:06:57 INFO - 'TERM': 'linux', 20:06:57 INFO - 'TMOUT': '86400', 20:06:57 INFO - 'USER': 'cltbld', 20:06:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:57 INFO - '_': '/tools/buildbot/bin/python'} 20:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:57 INFO - Downloading/unpacking flake8 20:06:57 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:06:57 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:06:57 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:06:57 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:06:57 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:06:57 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:06:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:59 INFO - no previously-included directories found matching 'docs/_build' 20:06:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:07:00 INFO - Running setup.py install for pep8 20:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:07:00 INFO - no previously-included directories found matching 'docs/_build' 20:07:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:07:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:07:00 INFO - Cleaning up... 20:07:00 INFO - Return code: 0 20:07:00 INFO - Running post-action listener: _resource_record_post_action 20:07:00 INFO - Running post-action listener: _start_resource_monitoring 20:07:00 INFO - Starting resource monitoring. 20:07:00 INFO - ##### 20:07:00 INFO - ##### Finished create-virtualenv step (success) 20:07:00 INFO - ##### 20:07:00 INFO - ##### 20:07:00 INFO - ##### Running install step. 20:07:00 INFO - ##### 20:07:00 INFO - Running pre-action listener: _resource_record_pre_action 20:07:00 INFO - Running main action method: install 20:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:00 INFO - Reading from file tmpfile_stdout 20:07:00 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:00 INFO - Reading from file tmpfile_stdout 20:07:00 INFO - Output received: 20:07:00 INFO - Usage: mozinstall [options] installer 20:07:00 INFO - Options: 20:07:00 INFO - -h, --help show this help message and exit 20:07:00 INFO - -d DEST, --destination=DEST 20:07:00 INFO - Directory to install application into. [default: 20:07:00 INFO - "/builds/slave/test"] 20:07:00 INFO - --app=APP Application being installed. [default: firefox] 20:07:00 INFO - mkdir: /builds/slave/test/build/application 20:07:00 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:07:00 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:07:17 INFO - Reading from file tmpfile_stdout 20:07:17 INFO - Output received: 20:07:17 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:17 INFO - Running post-action listener: _resource_record_post_action 20:07:17 INFO - ##### 20:07:17 INFO - ##### Finished install step (success) 20:07:17 INFO - ##### 20:07:17 INFO - ##### 20:07:17 INFO - ##### Running run-tests step. 20:07:17 INFO - ##### 20:07:17 INFO - Running pre-action listener: _resource_record_pre_action 20:07:17 INFO - Running main action method: run_tests 20:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:17 INFO - Python 2.7.3 20:07:17 INFO - Return code: 0 20:07:17 INFO - grabbing minidump binary from tooltool 20:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:07:17 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 0x210d9c0>, '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 0x210e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:17 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:07:17 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:07:17 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:07:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:17 INFO - Return code: 0 20:07:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:07:18 INFO - Return code: 0 20:07:18 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:07:18 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:07:18 INFO - Using env: {'DISPLAY': ':0', 20:07:18 INFO - 'HOME': '/home/cltbld', 20:07:18 INFO - 'LANG': 'en_US.UTF-8', 20:07:18 INFO - 'LANGUAGE': 'en_US:en', 20:07:18 INFO - 'LOGNAME': 'cltbld', 20:07:18 INFO - 'MAIL': '/var/mail/cltbld', 20:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:18 INFO - 'MOZ_NO_REMOTE': '1', 20:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:18 INFO - 'NO_EM_RESTART': '1', 20:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:18 INFO - 'PWD': '/builds/slave/test', 20:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:18 INFO - 'SHELL': '/bin/bash', 20:07:18 INFO - 'SHLVL': '1', 20:07:18 INFO - 'TERM': 'linux', 20:07:18 INFO - 'TMOUT': '86400', 20:07:18 INFO - 'USER': 'cltbld', 20:07:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542', 20:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:18 INFO - '_': '/tools/buildbot/bin/python'} 20:07:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:07:18 INFO - mozversion application_buildid: 20160516173016 20:07:18 INFO - mozversion application_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:07:18 INFO - mozversion application_display_name: Nightly 20:07:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:18 INFO - mozversion application_name: Firefox 20:07:18 INFO - mozversion application_remotingname: firefox 20:07:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:18 INFO - mozversion application_vendor: Mozilla 20:07:18 INFO - mozversion application_version: 49.0a1 20:07:18 INFO - mozversion platform_buildid: 20160516173016 20:07:18 INFO - mozversion platform_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:07:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:18 INFO - mozversion platform_version: 49.0a1 20:07:18 INFO - using testdate: 1463454438 20:07:18 INFO - actual date: 1463454438 20:07:18 INFO - starting webserver on 'localhost:50952' 20:07:18 INFO - SUITE-START | Running 2 tests 20:07:18 INFO - TEST-START | dromaeo_css 20:07:18 INFO - operating with platform_type : linux_ 20:07:18 INFO - Initialising browser for dromaeo_css test... 20:07:18 INFO - TEST-INFO | started process 7324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9umBnK/profile http://localhost:50952/getInfo.html) 20:07:22 INFO - PROCESS | 7324 | 20:07:22 INFO - PROCESS | 7324 | (process:7391): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:23 INFO - PROCESS | 7324 | __metrics Screen width/height:1600/1200 20:07:23 INFO - PROCESS | 7324 | colorDepth:24 20:07:23 INFO - PROCESS | 7324 | Browser inner width/height: 1024/697 20:07:23 INFO - PROCESS | 7324 | __metrics 20:07:24 ERROR - PROCESS | 7324 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:07:25 INFO - TEST-INFO | 7324: exit 0 20:07:25 INFO - Browser initialized. 20:07:25 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:25 INFO - TEST-INFO | started process 7442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9umBnK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:27 INFO - PROCESS | 7442 | 20:07:27 INFO - PROCESS | 7442 | (process:7502): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:37 INFO - PROCESS | 7442 | RSS: Main: 164077568 20:07:37 INFO - PROCESS | 7442 | 20:08:27 INFO - PROCESS | 7442 | 1463454507019 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:10:35 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50952/tests/dromaeo/cssquery-ext.html) 20:10:36 INFO - PROCESS | 7442 | RSS: Main: 166629376 20:10:36 INFO - PROCESS | 7442 | 20:13:38 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-ext.html (next: http://localhost:50952/tests/dromaeo/cssquery-jquery.html) 20:13:38 INFO - PROCESS | 7442 | RSS: Main: 166961152 20:13:38 INFO - PROCESS | 7442 | 20:16:40 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50952/tests/dromaeo/cssquery-mootools.html) 20:16:41 INFO - PROCESS | 7442 | RSS: Main: 168042496 20:16:41 INFO - PROCESS | 7442 | 20:19:42 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50952/tests/dromaeo/cssquery-prototype.html) 20:19:43 INFO - PROCESS | 7442 | RSS: Main: 165470208 20:19:43 INFO - PROCESS | 7442 | 20:22:45 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50952/tests/dromaeo/cssquery-yui.html) 20:22:46 INFO - PROCESS | 7442 | RSS: Main: 167108608 20:22:46 INFO - PROCESS | 7442 | 20:25:48 INFO - PROCESS | 7442 | Cycle 1(1): loaded http://localhost:50952/tests/dromaeo/cssquery-yui.html (next: http://localhost:50952/tests/dromaeo/cssquery-dojo.html) 20:25:49 INFO - PROCESS | 7442 | RSS: Main: 169017344 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | __start_tp_report 20:25:49 INFO - PROCESS | 7442 | _x_x_mozilla_page_load 20:25:49 INFO - PROCESS | 7442 | _x_x_mozilla_page_load_details 20:25:49 INFO - PROCESS | 7442 | |i|pagename|runs| 20:25:49 INFO - PROCESS | 7442 | |0;dojo.html;3159.5102759072342;3182.5226216067585;3186.4901615741487;3201.80789152651;3226.419244535984;5320.334958130234;5335.546478549323;5339.199120131977;5411.188321751739;5477.5070243678065;5353.5984801139975;5361.329833770778;5387.703676297802;5410.026195284857;5468.207109969052;4876.049170411762;4900.656954013202;4991.276264941581;5033.597312215014;5081.949180508184;663.8904534584167;4965.627577931651;5035.967626636549;5072;5106.821261255838;4868.342773725537;4873.390826146731;4878.146324393217;4882.121218180726;4931.5315045070665;4889.926651100236;4890.095332363524;4891.804327826882;4912.508749125094;4957.132501812169;4892.266160075981;4898.461169271377;4910.607151427877;4929.359183306147;4972.279019542182;5285.207218917155;5308.203769434615;5339.6262261641705;5391.973040134774;5419.729013549346;5785.652860828363;5794.072948328248;5795.536357091422;5814.389489103625;5867.647941123546;5883;5894.17481552583;5936.495397891184;5957.791477298317;5960.761569537213;5495.725213739297;5533.723313834333;5545.473180047889;5548.55611551079;5555.472230138131;5814.680192589363;5943.257092863392;6039.124326972652;6079.422454866781;6081.787137450168;5639.802606908738;5695.658260504383;5706.343770466367;5714.342850572238;5724.79963201286;5792.189093526909;5836.970815145897;5848.502877255481;5849.883002340014;5856.092305692625;5490.6431081980345;5690.800821971211;5698.686572238484;5728.427157284238;5734.598578099493;5549.528290095306;5668.829935101953;5679.346875109332;5705.74324155414;5885.352611212763;4419.64642828573;4431.911361772746;4438.7114837535455;4447.555244475527;4476.820927162942;3924.9215015699524;3982.422548730418;3985.4021896715726;3993.780342081155;4009.398590211433;5548.889022219533;5561.77752889888;5601.915971260434;5615.354234263031;5630.5214056805635;5961.642301461926;5970.731317090741;6004;6007.879842403127;6017.368176341509;5527.419620939743;5672.12082127271;5682.403347648437;5685.346185188673;5688.800891968761;4887.902241955141;4888.071266459361;4906.632002599819;4951;4959.925601115986;6136.846578835565;6185.597936134137;6190.969045154746;6194.163787888668;6209.751609935643;5744.195812586325;5826.76692932278;5987.311459182162;5992.250968628921;5996.220491336098;5965.075413310944;6088.965113858168;6101.587207021918;6142.447179753844;6143.201383820254;5700.942990570041;5714.399988001366;5743;5752.511036561772;5793.623414478046;5715.799947001835;5857.326407463196;5904.439078287556;5909.497692696169;5920.555958303231;5758.856028599151;5768.2501274834;5784.652920824764;5784.884302314014;5820.097884827858;5751.798687045934;5760.366359700513;5763.6541807491685;5775.797847075332;5784.2769653793275;5459.044667183306;5569.387367389503;5577.0797818359515;5621.606487545996;5665.66006039639;5698.629589076697;5771.884562308646;5774.884502310014;5780.710964451845;5820.447057529528;5684.772609095755;5709.143628455765;5726.455986681259;5748.770049197985;5762.884742305214 20:25:49 INFO - PROCESS | 7442 | |1;ext.html;610.6031079798133;623.8471574464257;660.3792435110993;662.3409707341194;675.2673349415882;43754.12491750163;44924.55075449245;44956.32565511516;48814.75592622032;49033.99999999991;46241;47055.29417058747;47059.294110588366;47132;47365.52634473654;8657.350698697592;8805.20753132218;8824.338174636896;8824.382293239476;8829.249513791336;8838.072002439747;8899.37704360695;8901.465912045265;8901.599428025755;8906.06486318937;8937.150970657776;8970.461772293684;8973.192412682858;9013.188813006827;9028.187463128317;8848.823023539557;8897.68858089967;8926.598303076376;8935.151160639729;8948.149925757076;8741.25699315559;8813.823723525558;8880.73357799267;8919.68781092665;8937.329700272441;42540.78729606363;43006.78496607497;43036;43051;43056.569434305566;3465.913352166216;3479.9652003479896;3494.545709057806;3611.205534782344;3689.5572531296148;32868.178295542566;33123.171920701934;33365;33475.665243347496;33478.330433391195;4257.808398622038;4261.2329780639475;4282.464691913511;4375.803088860977;4390.802413891351;339202;339352;340151;341501;342124;36064.63935360613;61847.6907615468;62492.37507624865;62784.37215627877;62806.371936280964;35409;35513.75701850423;35556.46665300023;35588.822055889555;35604.465933010506;15862.127582982816;16058.116803575682;16059.116748578941;16072.75890861638;16098.275577599035;12613.558525451564;12714.046446516548;12796;12816.935915320364;12858.228506289652;8629;8629.43908645936;8679.6528138875;8735.082816304324;8748.825023499621;3295.9011229663147;3312.1222875937897;3325.418051840918;3341.131305860445;3358.37869994047;1074.3500182389541;1137.7245508982037;1150.045462266317;1172.2263306217856;1237.888590026902;31437.842810785798;31746.841265793522;31769.764147426406;31816.363672726417;32227.194320142185;1030.5465595138114;1140.686311264409;1148.8563929508812;1174.8179032250016;1177.375990724917;17153;17323.826761732475;17342.739858902125;17507.47477575675;18664.44006679802;366374;532427;532519;536629;537520;62659.6867015662;63938;64101;64583;64618.67690661517;1471.7130159618985;1494.2006026775841;1502.4516051641071;1505.9849401506065;1508.2684897824547;33641.49537756887;34095.14762130967;34830.82584587061;34958.475622866186;35331.82334088313;54925.72537137449;55124.72437637786;55372;55776;56111.71944140253;494604;495164;495524;496431;497632;45684.31473527966;45812.77093614644;46484;47087;47163.056738865715;45298;47464.7626761864;49888;50326.74836625793;51295.74352128216;41731.7913410431;43076.56923430851;43762.56237437585;43840.561594384926;44556.55443445524;43153.626550538764;43363.56636433595;43583;44335.55664443314;44523;42061;42822;43673.56326436695;44170.77914610406;44544.10911781811;37495.25009499849;37696.43455348227;38748.49578820657;39057.6094239054;39126.2174756509;29613.555796662637;29660.851695741385;29689.5546566806;29862.70137298686;30165.547516787705 20:25:49 INFO - PROCESS | 7442 | |2;jquery.html;416.70830418706896;418.17201940158486;422.1746485620612;425.7275343779979;437.94744630644306;17572.736408953875;18426.262949482003;18790.81209187906;19158.233670653157;19190.616187676238;18254.17856196471;18548.165332560035;19210.615787684237;19295.4211373659;19387.224511019544;5600.775968961237;5862.853428664275;5919.467247947684;5942.940570594282;5947.434993675594;5640.323161220639;5787;5826.592138550282;5848.356680765112;5873.500752436048;5823.06830907055;5827.592068555203;5831.562632802556;5839.591228613998;5874.177615133864;5712.742926568314;5723.255976723;5842.5618078644275;5845.152452894327;5854.677992710399;5176.55999240065;5199.038177937094;5224.190250511138;5242.239875218072;5257.579393648537;19734;20992;21020.579588408298;21702.348929532138;21798.673019904712;2210.303754317385;2256.4246117240164;2297.666838308436;2317.6523521471913;2388.7491813359693;9756.560954757053;9785.706428807147;9844.95077524615;10632.840507392395;14835.332410041574;1894.9621007579772;1954.980450195494;1994.2023190723683;2023.3633681524623;2054.5377290109755;80071.59964200141;83000.16999829985;83813.16186838114;84619;86193.56903215506;11218.66344009681;11243.60647377338;11247.718807029725;11469.88530114705;11471.254368466023;15923.283452244445;15970.680586388207;15982;15997.760033599505;16037.278322475284;7940.602969851484;8119.837603247902;8155.34757219421;8167.63245653947;8311.418200725891;7583.658735356922;7666.65500052499;7706.922930770621;7844.843103137905;7916.445848790529;4858.5384388483035;4858.684185527929;4886.413630364308;4971.353724015927;5007.749612519359;1995.580928005135;2068.637988352032;2084.1871670048695;2098.6809575419247;2137.070374387147;961.8845738511424;995.2933417273672;998.5706146357136;1009.7929924365487;1095.9752631289768;18168.545786355447;18589.628207435777;18592.163352649164;18714.1578628962;18795.530111747317;1053.4943227250963;1075.6665433715573;1087.6247694545368;1088.357868857378;1108.0913650806262;10284.948575257076;10591.470426478645;10629.84055239172;10773.138148948065;10781.730456738487;454367;459703;467920;468270;469727;68181;85397;86728;92141.53929230446;95441;1039.4698703661188;1068.8396740488988;1078.3691540448926;1080.9243352965375;1083.47992963378;16765.1617419131;17168.484945451655;17171.399001035403;17282.48152555375;17360.479185624452;40394;40774.38838417367;41048.79475602603;42028.94927626834;43457.565424345354;58536;59803.70098149481;60392;61075.389246108745;61351.6932415335;8536.914630853613;8605.741827744927;8809.735707928772;8845.734627961172;8861.158189971942;9252.444853308823;12734.426950787052;13061.21632702041;13298.135621184592;13497.39261733244;11630.476628551567;11722.23805452677;11879.940600296943;11883.524659013543;12066.698332541757;11477.655670329903;11493.94253028763;11627.53489860396;11632.407968000965;11875.109366797698;11850.940745296219;12024.879751202376;12032.157748957488;12169.452374642986;12637;8666.480011199348;8690.130986901511;8742.781430464289;8743.956280218557;8882.555872206492;8601.483910965362;8638.524881131598;8778.91221087781;8788.472691638523;8865.379423440298 20:25:49 INFO - PROCESS | 7442 | |3;mootools.html;1420.9147451152928;1497.0344128037416;1649.958751031224;1884.7455593494874;1896.7818700849407;8142.145074767153;8837.734867953955;9032.09679032098;9469.952650236748;9511.334206605532;9302.441853488779;9322.207612352959;9379.39033962792;9380.906190938089;9382.296327775428;2294.827887908405;2326.9650955235684;2330.592146374386;2331.0326214620914;2334.5681049005902;2292.3695983604475;2322.7096612923383;2360.87015214164;2364.267077206063;2364.9645255321184;2271.8636881787147;2284.097781376355;2294.4263934016494;2357.139644029934;2362.8464149830206;2253.256425379629;2259.548090381922;2265.716785401825;2268.3761965459466;2271.3526644906287;2221.955560888773;2235.273536100774;2237.038073628339;2237.284069097889;2239.193890199527;9082.40964337316;9135.725928222164;9144.451332920045;9160.954195229047;9194.12655797698;5146.279520867081;5201.661891977009;5232.189010703347;5247.816326428557;5259.526642602184;3196.568463257454;3281.425750493654;3339.8664053437833;3357.2781851901714;3370.5618269624792;1092.180864351736;1105.9612913547987;1121.4224674292745;1156.2368836567825;1172.6892373521023;12753.362331883369;12770.106092573524;12783;12801.48794048237;12802.039847011418;4569.022999373026;4611.953880461219;4618.653600979873;4620.2607582786595;4647.256438969748;10761.83857242142;10824.512896919658;10838.512266948006;10875.07561857251;10880.510377033053;5247.790088396498;5265.078611243017;5396.865078372994;5401.459854014567;5408.5402740766685;4213.47331583552;4556.703814252063;4731.148393289172;4733.644976626698;4955.2567114933045;4136;4145.647619952338;4232;4232.661387089025;4244.278472659656;1322.5172811923578;1345.4618152738983;1352.094096955023;1352.905296629246;1370.3422357268369;918.3158546882615;944.3436811416137;952.2667545989549;961.7595601099725;962.2157941277836;5690.260266165372;5744.913826292609;5793.768249270066;5904.704764761831;5914.497267732205;396.5162501747863;403.8970062634068;403.94748682671064;413.4294673350757;419.7963987466077;3981.785555405629;3983.203359328146;4026.1142548639255;4032.778197199182;4078.3882417636996;11363.37501437429;11677.649670509898;11744.76510469803;11763.705907352214;11767.646970590897;11490.253133546294;11490.540378384938;11583.420828958519;11594.594189203337;11616.535338586531;8336.291415229653;8550.700725474579;8601.268892144113;8605.569721513899;8688.261497772633;5601.355844077983;5694.345150307768;5694.515966142924;5707.258056452634;5841.620294680833;10233.692989210336;10494.737631559272;10525.105366043972;10852.67441976742;10864.130869530261;10914.399708016135;10919.672409827717;10966.287191332538;11150.10799136051;11165.441727913734;7325.7802265932105;8040.959795200986;8155.143709910374;8248.711295104642;8282.544460054754;9072.727818165466;9182.127697868691;9187.081291871027;9198;9248.583813728534;8095.433319667803;8264.545450000307;8308.33533317321;8341.040780310343;8375.497470151811;7929.960350198212;7993.320567751573;8046.356291496549;8046.718364857202;8101.189881011852;7238.312360325761;7242.818929526804;7261;7300.379467745089;7354.852902941804;5249.2126181073145;5282.260483532232;5338.172583249602;5342.572594192533;5352.0366334060245;5149.922751158811;5314.468553144655;5330.813421530228;5338.75975581092;5344.5991550634635 20:25:49 INFO - PROCESS | 7442 | |4;prototype.html;329.39671959619835;338.50747162878014;344.1911507956302;344.29763282902877;347.8625942752614;5458.2904222451125;5618.662880227189;5644.633098848577;5658.726786473047;5705.942940570593;5622.887542249153;5638.154276858473;5677.744501497432;5680.886382272352;5699.829005129843;4364.956350436502;4415.690901636886;4417.27115026022;4419.668524860632;4450.485475706224;4075.755454672714;4351.195028919644;4354.238008348526;4397.626201772853;4417.845375411861;4299.656027517791;4303.74177549348;4315.8994456413575;4319.805608747598;4348.5216626171095;4360.345948107793;4362.367456718774;4369.890752731176;4382.8904277393;4397.428334316518;3756.948054544732;3790;3836.827342769582;3840.827162777654;3855.267499175148;5390.059578551718;5404.702741349224;5415.539679127279;5424.566034717213;5434.565234781208;4942.283368911523;4949.975250123763;4950.653454258203;4964.205727083686;4968;5539.473749993744;5791.536677065867;5800.361960184377;5818.21454103699;5824.330202026778;4143.97928010358;4146.834126634931;4169.353750168729;4170.791460426966;4175.352820312856;6050.2437195350585;6100.749346383981;6112.908306375408;6139.785107521216;6152.753889844401;4165.229432554987;4202.8739137825305;4231.30183519722;4293.935590966138;4303.225419424533;4215.473065866767;4242.469691288589;4262.614650238685;4279.239890270758;4300;4837.854864354075;4878.82924097662;4905.23968784839;4919.385076865392;4947.851564453073;5750.712464376765;5880.529557635379;5905.43898329658;5908.763649453974;5939.851503712442;1477.6848604741574;1477.933492992818;1491.313995562032;1496.3864815425623;1502.2413681091198;912.309368191718;928.7585227840675;943.061653654618;948.5162567090833;951.6574033347989;4941.135301322254;5033.2701758245585;5058.342415485963;5064.620153488503;5122.641415100908;5290.804316208807;5327.413984461706;5338.252644629677;5339.919901201485;5399.757010934517;4919.335889654851;4986.800527978913;4988.725620090857;5285.63000589955;5733.741981610838;3242.0922141800334;3248.4964830451318;3276.361109583656;3279.2785587170783;3282.803031818051;6054.243219597551;6265.342139075331;6283.277423096311;6337.397947195009;6356.396142366468;6144.648177400964;6171.783987560414;6177.444030037228;6196.411340922605;6237.500999919996;6277.52918531112;6285.931391663428;6317.799618072551;6321;6327.367263273728;5818.31268932005;6047.274327080779;6058.878822423439;6062.818115456544;6090.847728806638;5880.676562789087;6002.609830361012;6004.219451471281;6081.969590152021;6107.6640784757265;6084.513238940785;6288.585068359583;6343;6346.524010699124;6359.427651511386;4184.539700632867;4184.895377615584;4198.202341555095;4217.578242175758;4220.029393239511;6039.037312873422;6045.818625441244;6072.271327440559;6075.574709770273;6105.45050945417;5693.886122277614;5809.9419005809405;5890.468478195786;5899.846556006941;5917.1715959766525;5825.75708352279;5841.737121829443;5870.765169393348;5880.529557635465;5899.380565040609;5475.780968761205;5755.1942728017275;5756.827295181151;5775.768969241183;5779.2775903012125;5894.11388355722;5903.586748927705;5919.763209471573;5933.554983376178;5933.762649493972;5738.741756620879;5741.885162296814;5793.971030144991;5814.94185058144;5817.738201780845 20:25:49 INFO - PROCESS | 7442 | |5;yui.html;699.4474365251451;710.6730903784259;799.0132186749368;851.9361047921406;866.3978534918232;14676.926615366921;14898.255087245621;15183.316750746215;15211.391544338214;15230.466933657324;13846.238456884892;14022.649433764136;14124.223167725771;14176.858231417682;14187.929060354709;685.0819901332226;834.6244190114443;852.4842470305468;855.84166929118;858.2833334165948;849.6601359456205;850.9873250831522;855.5807654249404;855.670566831768;856.7429771068654;880.0451510111536;880.8854848869638;881.6649673124203;883.1433509495779;883.3816328569994;877.7542288159326;881.0132651430375;881.3037700216821;882.6513527156737;883.266888482558;630.4987534909758;635.3582881289931;637.8724255148989;638.6232123047424;638.8115505925763;12940.676483087904;13083;13114.213147211103;13132.737345253137;13133.34333283332;14490;14657.633559161;14697.191654459;14753.77869331961;14885.106893586311;11799.292042477478;11835.11236657254;11918.642440726791;12117.030637548974;12201.267923924594;3861.4400911867624;3917.7061720371084;3923.548791888912;3926.312895243321;3961.5444223914333;57248.71375643095;57498;57562.71218643922;58038.7098064507;58487;11368.374739389248;11409.771804563863;11458.140639451907;11484.99012672779;11653.30080195174;20840.1663933444;21076.894615526824;21079.156833726785;21123.78876211218;21130.154793808382;8250.54621995784;8278.71024514139;8322.20939010793;8430.578471076544;8581.699640512552;4423.181711383404;4540.977295113504;4568.81724731007;4583.083383323348;4674.579287864109;3427.7943323400677;3527.5943266524164;3541.8760343387858;3545.468179773003;3560.092176494977;656.7307403964447;663.7444583835259;679.3715812873171;720.6648908257686;723.9493235473572;731.7731503233908;768.4198430185286;769.9076110866732;769.9576523291273;802.626778547978;10226.53980570876;10318.122959548373;10490.16078713701;10490.947545262225;10493.685189444328;621.5711159300068;696.2550071423528;760.3202289905639;786.3591173193829;807.4428644235576;4902.460729319772;4919.1391506486225;5031.899362012739;5038.622103342264;5071.7971281149075;73003;74617.25382746103;74769;74899;76449;65890.39931605867;66053.669731652;66129.33870661329;66492.33507664861;66869.99999999903;61041.69479152664;61187.08219376713;61541.15376538711;61549.384506155264;61699.383006169366;9458.668946586837;9595.808083838423;9612.807743845224;9622.51887405641;9694.709158725249;39155;39388.40917386299;39459.2108157841;40339.596604033584;40341;50526.24210636917;52301.215481768566;52807.47192528025;53204.73397632987;54654;11986.340751258764;12276.87723122793;12361.567345142877;12658.87341126577;12990;14359.138451692932;14502.85497145015;14854.405823766929;15021.624459388602;15526.61183470377;12956.870431295567;13330.466781328638;13559.254241016444;13661.931690341882;13709.588712338646;13631.522896698569;13730.382132804247;14181;14204.431822726976;14679.706405872037;14142.363593638105;14206.573802785933;14327;14507;14646.853531464974;10422.635207767995;10904.182186335898;10988.725281867697;11198.552057917592;11376.374299413612;10842.566297348018;11045.33727976324;11284.492197851281;11458.197926145423;11846.11154163424 20:25:49 INFO - PROCESS | 7442 | __end_tp_report 20:25:49 INFO - PROCESS | 7442 | __start_cc_report 20:25:49 INFO - PROCESS | 7442 | _x_x_mozilla_cycle_collect,334 20:25:49 INFO - PROCESS | 7442 | __end_cc_report 20:25:49 INFO - PROCESS | 7442 | __startTimestamp1463455549073__endTimestamp 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | ------- Summary: start ------- 20:25:49 INFO - PROCESS | 7442 | Number of tests: 6 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#0] dojo.html Cycles:165 Average:5403.74 Median:5684.77 stddev:732.03 (12.9%) stddev-sans-first:712.79 20:25:49 INFO - PROCESS | 7442 | Values: 3159.5 3182.5 3186.5 3201.8 3226.4 5320.3 5335.5 5339.2 5411.2 5477.5 5353.6 5361.3 5387.7 5410.0 5468.2 4876.0 4900.7 4991.3 5033.6 5081.9 663.9 4965.6 5036.0 5072.0 5106.8 4868.3 4873.4 4878.1 4882.1 4931.5 4889.9 4890.1 4891.8 4912.5 4957.1 4892.3 4898.5 4910.6 4929.4 4972.3 5285.2 5308.2 5339.6 5392.0 5419.7 5785.7 5794.1 5795.5 5814.4 5867.6 5883.0 5894.2 5936.5 5957.8 5960.8 5495.7 5533.7 5545.5 5548.6 5555.5 5814.7 5943.3 6039.1 6079.4 6081.8 5639.8 5695.7 5706.3 5714.3 5724.8 5792.2 5837.0 5848.5 5849.9 5856.1 5490.6 5690.8 5698.7 5728.4 5734.6 5549.5 5668.8 5679.3 5705.7 5885.4 4419.6 4431.9 4438.7 4447.6 4476.8 3924.9 3982.4 3985.4 3993.8 4009.4 5548.9 5561.8 5601.9 5615.4 5630.5 5961.6 5970.7 6004.0 6007.9 6017.4 5527.4 5672.1 5682.4 5685.3 5688.8 4887.9 4888.1 4906.6 4951.0 4959.9 6136.8 6185.6 6191.0 6194.2 6209.8 5744.2 5826.8 5987.3 5992.3 5996.2 5965.1 6089.0 6101.6 6142.4 6143.2 5700.9 5714.4 5743.0 5752.5 5793.6 5715.8 5857.3 5904.4 5909.5 5920.6 5758.9 5768.3 5784.7 5784.9 5820.1 5751.8 5760.4 5763.7 5775.8 5784.3 5459.0 5569.4 5577.1 5621.6 5665.7 5698.6 5771.9 5774.9 5780.7 5820.4 5684.8 5709.1 5726.5 5748.8 5762.9 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#1] ext.html Cycles:180 Average:60964.82 Median:43473.28 stddev:120383.87 (276.9%) stddev-sans-first:120636.29 20:25:49 INFO - PROCESS | 7442 | Values: 610.6 623.8 660.4 662.3 675.3 43754.1 44924.6 44956.3 48814.8 49034.0 46241.0 47055.3 47059.3 47132.0 47365.5 8657.4 8805.2 8824.3 8824.4 8829.2 8838.1 8899.4 8901.5 8901.6 8906.1 8937.2 8970.5 8973.2 9013.2 9028.2 8848.8 8897.7 8926.6 8935.2 8948.1 8741.3 8813.8 8880.7 8919.7 8937.3 42540.8 43006.8 43036.0 43051.0 43056.6 3465.9 3480.0 3494.5 3611.2 3689.6 32868.2 33123.2 33365.0 33475.7 33478.3 4257.8 4261.2 4282.5 4375.8 4390.8 339202.0 339352.0 340151.0 341501.0 342124.0 36064.6 61847.7 62492.4 62784.4 62806.4 35409.0 35513.8 35556.5 35588.8 35604.5 15862.1 16058.1 16059.1 16072.8 16098.3 12613.6 12714.0 12796.0 12816.9 12858.2 8629.0 8629.4 8679.7 8735.1 8748.8 3295.9 3312.1 3325.4 3341.1 3358.4 1074.4 1137.7 1150.0 1172.2 1237.9 31437.8 31746.8 31769.8 31816.4 32227.2 1030.5 1140.7 1148.9 1174.8 1177.4 17153.0 17323.8 17342.7 17507.5 18664.4 366374.0 532427.0 532519.0 536629.0 537520.0 62659.7 63938.0 64101.0 64583.0 64618.7 1471.7 1494.2 1502.5 1506.0 1508.3 33641.5 34095.1 34830.8 34958.5 35331.8 54925.7 55124.7 55372.0 55776.0 56111.7 494604.0 495164.0 495524.0 496431.0 497632.0 45684.3 45812.8 46484.0 47087.0 47163.1 45298.0 47464.8 49888.0 50326.7 51295.7 41731.8 43076.6 43762.6 43840.6 44556.6 43153.6 43363.6 43583.0 44335.6 44523.0 42061.0 42822.0 43673.6 44170.8 44544.1 37495.3 37696.4 38748.5 39057.6 39126.2 29613.6 29660.9 29689.6 29862.7 30165.5 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#2] jquery.html Cycles:180 Average:28098.63 Median:20732.75 stddev:76626.54 (369.6%) stddev-sans-first:76813.31 20:25:49 INFO - PROCESS | 7442 | Values: 416.7 418.2 422.2 425.7 437.9 17572.7 18426.3 18790.8 19158.2 19190.6 18254.2 18548.2 19210.6 19295.4 19387.2 5600.8 5862.9 5919.5 5942.9 5947.4 5640.3 5787.0 5826.6 5848.4 5873.5 5823.1 5827.6 5831.6 5839.6 5874.2 5712.7 5723.3 5842.6 5845.2 5854.7 5176.6 5199.0 5224.2 5242.2 5257.6 19734.0 20992.0 21020.6 21702.3 21798.7 2210.3 2256.4 2297.7 2317.7 2388.7 9756.6 9785.7 9845.0 10632.8 14835.3 1895.0 1955.0 1994.2 2023.4 2054.5 80071.6 83000.2 83813.2 84619.0 86193.6 11218.7 11243.6 11247.7 11469.9 11471.3 15923.3 15970.7 15982.0 15997.8 16037.3 7940.6 8119.8 8155.3 8167.6 8311.4 7583.7 7666.7 7706.9 7844.8 7916.4 4858.5 4858.7 4886.4 4971.4 5007.7 1995.6 2068.6 2084.2 2098.7 2137.1 961.9 995.3 998.6 1009.8 1096.0 18168.5 18589.6 18592.2 18714.2 18795.5 1053.5 1075.7 1087.6 1088.4 1108.1 10284.9 10591.5 10629.8 10773.1 10781.7 454367.0 459703.0 467920.0 468270.0 469727.0 68181.0 85397.0 86728.0 92141.5 95441.0 1039.5 1068.8 1078.4 1080.9 1083.5 16765.2 17168.5 17171.4 17282.5 17360.5 40394.0 40774.4 41048.8 42028.9 43457.6 58536.0 59803.7 60392.0 61075.4 61351.7 8536.9 8605.7 8809.7 8845.7 8861.2 9252.4 12734.4 13061.2 13298.1 13497.4 11630.5 11722.2 11879.9 11883.5 12066.7 11477.7 11493.9 11627.5 11632.4 11875.1 11850.9 12024.9 12032.2 12169.5 12637.0 8666.5 8690.1 8742.8 8744.0 8882.6 8601.5 8638.5 8778.9 8788.5 8865.4 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#3] mootools.html Cycles:180 Average:5992.25 Median:4400.49 stddev:3548.79 (80.6%) stddev-sans-first:3542.12 20:25:49 INFO - PROCESS | 7442 | Values: 1420.9 1497.0 1650.0 1884.7 1896.8 8142.1 8837.7 9032.1 9470.0 9511.3 9302.4 9322.2 9379.4 9380.9 9382.3 2294.8 2327.0 2330.6 2331.0 2334.6 2292.4 2322.7 2360.9 2364.3 2365.0 2271.9 2284.1 2294.4 2357.1 2362.8 2253.3 2259.5 2265.7 2268.4 2271.4 2222.0 2235.3 2237.0 2237.3 2239.2 9082.4 9135.7 9144.5 9161.0 9194.1 5146.3 5201.7 5232.2 5247.8 5259.5 3196.6 3281.4 3339.9 3357.3 3370.6 1092.2 1106.0 1121.4 1156.2 1172.7 12753.4 12770.1 12783.0 12801.5 12802.0 4569.0 4612.0 4618.7 4620.3 4647.3 10761.8 10824.5 10838.5 10875.1 10880.5 5247.8 5265.1 5396.9 5401.5 5408.5 4213.5 4556.7 4731.1 4733.6 4955.3 4136.0 4145.6 4232.0 4232.7 4244.3 1322.5 1345.5 1352.1 1352.9 1370.3 918.3 944.3 952.3 961.8 962.2 5690.3 5744.9 5793.8 5904.7 5914.5 396.5 403.9 403.9 413.4 419.8 3981.8 3983.2 4026.1 4032.8 4078.4 11363.4 11677.6 11744.8 11763.7 11767.6 11490.3 11490.5 11583.4 11594.6 11616.5 8336.3 8550.7 8601.3 8605.6 8688.3 5601.4 5694.3 5694.5 5707.3 5841.6 10233.7 10494.7 10525.1 10852.7 10864.1 10914.4 10919.7 10966.3 11150.1 11165.4 7325.8 8041.0 8155.1 8248.7 8282.5 9072.7 9182.1 9187.1 9198.0 9248.6 8095.4 8264.5 8308.3 8341.0 8375.5 7930.0 7993.3 8046.4 8046.7 8101.2 7238.3 7242.8 7261.0 7300.4 7354.9 5249.2 5282.3 5338.2 5342.6 5352.0 5149.9 5314.5 5330.8 5338.8 5344.6 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#4] prototype.html Cycles:180 Average:4895.53 Median:5507.63 stddev:1453.07 (26.4%) stddev-sans-first:1416.16 20:25:49 INFO - PROCESS | 7442 | Values: 329.4 338.5 344.2 344.3 347.9 5458.3 5618.7 5644.6 5658.7 5705.9 5622.9 5638.2 5677.7 5680.9 5699.8 4365.0 4415.7 4417.3 4419.7 4450.5 4075.8 4351.2 4354.2 4397.6 4417.8 4299.7 4303.7 4315.9 4319.8 4348.5 4360.3 4362.4 4369.9 4382.9 4397.4 3756.9 3790.0 3836.8 3840.8 3855.3 5390.1 5404.7 5415.5 5424.6 5434.6 4942.3 4950.0 4950.7 4964.2 4968.0 5539.5 5791.5 5800.4 5818.2 5824.3 4144.0 4146.8 4169.4 4170.8 4175.4 6050.2 6100.7 6112.9 6139.8 6152.8 4165.2 4202.9 4231.3 4293.9 4303.2 4215.5 4242.5 4262.6 4279.2 4300.0 4837.9 4878.8 4905.2 4919.4 4947.9 5750.7 5880.5 5905.4 5908.8 5939.9 1477.7 1477.9 1491.3 1496.4 1502.2 912.3 928.8 943.1 948.5 951.7 4941.1 5033.3 5058.3 5064.6 5122.6 5290.8 5327.4 5338.3 5339.9 5399.8 4919.3 4986.8 4988.7 5285.6 5733.7 3242.1 3248.5 3276.4 3279.3 3282.8 6054.2 6265.3 6283.3 6337.4 6356.4 6144.6 6171.8 6177.4 6196.4 6237.5 6277.5 6285.9 6317.8 6321.0 6327.4 5818.3 6047.3 6058.9 6062.8 6090.8 5880.7 6002.6 6004.2 6082.0 6107.7 6084.5 6288.6 6343.0 6346.5 6359.4 4184.5 4184.9 4198.2 4217.6 4220.0 6039.0 6045.8 6072.3 6075.6 6105.5 5693.9 5809.9 5890.5 5899.8 5917.2 5825.8 5841.7 5870.8 5880.5 5899.4 5475.8 5755.2 5756.8 5775.8 5779.3 5894.1 5903.6 5919.8 5933.6 5933.8 5738.7 5741.9 5794.0 5814.9 5817.7 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - PROCESS | 7442 | [#5] yui.html Cycles:180 Average:16608.78 Median:4482.08 stddev:20199.42 (450.7%) stddev-sans-first:20220.75 20:25:49 INFO - PROCESS | 7442 | Values: 699.4 710.7 799.0 851.9 866.4 14676.9 14898.3 15183.3 15211.4 15230.5 13846.2 14022.6 14124.2 14176.9 14187.9 685.1 834.6 852.5 855.8 858.3 849.7 851.0 855.6 855.7 856.7 880.0 880.9 881.7 883.1 883.4 877.8 881.0 881.3 882.7 883.3 630.5 635.4 637.9 638.6 638.8 12940.7 13083.0 13114.2 13132.7 13133.3 14490.0 14657.6 14697.2 14753.8 14885.1 11799.3 11835.1 11918.6 12117.0 12201.3 3861.4 3917.7 3923.5 3926.3 3961.5 57248.7 57498.0 57562.7 58038.7 58487.0 11368.4 11409.8 11458.1 11485.0 11653.3 20840.2 21076.9 21079.2 21123.8 21130.2 8250.5 8278.7 8322.2 8430.6 8581.7 4423.2 4541.0 4568.8 4583.1 4674.6 3427.8 3527.6 3541.9 3545.5 3560.1 656.7 663.7 679.4 720.7 723.9 731.8 768.4 769.9 770.0 802.6 10226.5 10318.1 10490.2 10490.9 10493.7 621.6 696.3 760.3 786.4 807.4 4902.5 4919.1 5031.9 5038.6 5071.8 73003.0 74617.3 74769.0 74899.0 76449.0 65890.4 66053.7 66129.3 66492.3 66870.0 61041.7 61187.1 61541.2 61549.4 61699.4 9458.7 9595.8 9612.8 9622.5 9694.7 39155.0 39388.4 39459.2 40339.6 40341.0 50526.2 52301.2 52807.5 53204.7 54654.0 11986.3 12276.9 12361.6 12658.9 12990.0 14359.1 14502.9 14854.4 15021.6 15526.6 12956.9 13330.5 13559.3 13661.9 13709.6 13631.5 13730.4 14181.0 14204.4 14679.7 14142.4 14206.6 14327.0 14507.0 14646.9 10422.6 10904.2 10988.7 11198.6 11376.4 10842.6 11045.3 11284.5 11458.2 11846.1 20:25:49 INFO - PROCESS | 7442 | -------- Summary: end -------- 20:25:49 INFO - PROCESS | 7442 | 20:25:49 INFO - TEST-INFO | 7442: exit 0 20:25:49 INFO - TEST-OK | dromaeo_css | took 1111434ms 20:25:49 INFO - TEST-START | kraken 20:25:49 INFO - operating with platform_type : linux_ 20:25:49 INFO - Initialising browser for kraken test... 20:25:49 INFO - TEST-INFO | started process 7680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8I82Mj/profile http://localhost:50952/getInfo.html) 20:25:54 INFO - PROCESS | 7680 | 20:25:54 INFO - PROCESS | 7680 | (process:7750): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:55 INFO - PROCESS | 7680 | __metrics Screen width/height:1600/1200 20:25:55 INFO - PROCESS | 7680 | colorDepth:24 20:25:55 INFO - PROCESS | 7680 | Browser inner width/height: 1024/697 20:25:55 INFO - PROCESS | 7680 | __metrics 20:25:55 ERROR - PROCESS | 7680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:25:56 INFO - TEST-INFO | 7680: exit 0 20:25:56 INFO - Browser initialized. 20:25:56 INFO - Running cycle 1/1 for kraken test... 20:25:56 INFO - TEST-INFO | started process 7801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8I82Mj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:58 INFO - PROCESS | 7801 | 20:25:58 INFO - PROCESS | 7801 | (process:7861): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:26:08 INFO - PROCESS | 7801 | RSS: Main: 163450880 20:26:08 INFO - PROCESS | 7801 | 20:26:11 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50952/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:11 INFO - PROCESS | 7801 | RSS: Main: 167981056 20:26:11 INFO - PROCESS | 7801 | 20:26:14 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50952/tests/kraken/driver.html?testName=audio-dft) 20:26:15 INFO - PROCESS | 7801 | RSS: Main: 167854080 20:26:15 INFO - PROCESS | 7801 | 20:26:18 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50952/tests/kraken/driver.html?testName=audio-fft) 20:26:18 INFO - PROCESS | 7801 | RSS: Main: 162340864 20:26:18 INFO - PROCESS | 7801 | 20:26:21 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50952/tests/kraken/driver.html?testName=audio-oscillator) 20:26:21 INFO - PROCESS | 7801 | RSS: Main: 162803712 20:26:21 INFO - PROCESS | 7801 | 20:26:24 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50952/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:24 INFO - PROCESS | 7801 | RSS: Main: 163405824 20:26:24 INFO - PROCESS | 7801 | 20:26:27 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50952/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:28 INFO - PROCESS | 7801 | RSS: Main: 163254272 20:26:28 INFO - PROCESS | 7801 | 20:26:31 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50952/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:32 INFO - PROCESS | 7801 | RSS: Main: 162025472 20:26:32 INFO - PROCESS | 7801 | 20:26:35 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50952/tests/kraken/driver.html?testName=json-parse-financial) 20:26:36 INFO - PROCESS | 7801 | RSS: Main: 163143680 20:26:36 INFO - PROCESS | 7801 | 20:26:37 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50952/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:38 INFO - PROCESS | 7801 | RSS: Main: 163409920 20:26:38 INFO - PROCESS | 7801 | 20:26:40 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:40 INFO - PROCESS | 7801 | RSS: Main: 163557376 20:26:40 INFO - PROCESS | 7801 | 20:26:43 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:43 INFO - PROCESS | 7801 | RSS: Main: 163196928 20:26:43 INFO - PROCESS | 7801 | 20:26:46 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:47 INFO - PROCESS | 7801 | RSS: Main: 163930112 20:26:47 INFO - PROCESS | 7801 | 20:26:49 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:50 INFO - PROCESS | 7801 | RSS: Main: 164241408 20:26:50 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | Cycle 1(1): loaded http://localhost:50952/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50952/tests/kraken/driver.html?testName=ai-astar) 20:26:52 INFO - PROCESS | 7801 | RSS: Main: 165715968 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | __start_tp_report 20:26:52 INFO - PROCESS | 7801 | _x_x_mozilla_page_load 20:26:52 INFO - PROCESS | 7801 | _x_x_mozilla_page_load_details 20:26:52 INFO - PROCESS | 7801 | |i|pagename|runs| 20:26:52 INFO - PROCESS | 7801 | |0;ai-astar;107;111;102;110;111;111;103;111;111;109 20:26:52 INFO - PROCESS | 7801 | |1;audio-beat-detection;152;127;150;212;127;159;159;128;191;127 20:26:52 INFO - PROCESS | 7801 | |2;audio-dft;164;169;164;163;164;167;170;164;163;165 20:26:52 INFO - PROCESS | 7801 | |3;audio-fft;75;75;75;166;75;75;76;74;164;75 20:26:52 INFO - PROCESS | 7801 | |4;audio-oscillator;92;92;181;92;91;92;158;92;91;149 20:26:52 INFO - PROCESS | 7801 | |5;imaging-gaussian-blur;118;120;117;118;118;118;118;118;117;118 20:26:52 INFO - PROCESS | 7801 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;145;146 20:26:52 INFO - PROCESS | 7801 | |7;imaging-desaturate;95;95;96;95;96;95;96;96;96;95 20:26:52 INFO - PROCESS | 7801 | |8;json-parse-financial;57;67;56;57;57;56;56;110;56;53 20:26:52 INFO - PROCESS | 7801 | |9;json-stringify-tinderbox;59;65;61;60;63;60;60;61;60;61 20:26:52 INFO - PROCESS | 7801 | |10;stanford-crypto-aes;78;78;83;80;79;79;78;83;79;84 20:26:52 INFO - PROCESS | 7801 | |11;stanford-crypto-ccm;128;125;131;119;119;122;120;128;191;132 20:26:52 INFO - PROCESS | 7801 | |12;stanford-crypto-pbkdf2;160;159;170;161;163;158;158;162;159;165 20:26:52 INFO - PROCESS | 7801 | |13;stanford-crypto-sha256-iterative;67;65;66;63;62;62;61;62;63;70 20:26:52 INFO - PROCESS | 7801 | __end_tp_report 20:26:52 INFO - PROCESS | 7801 | __start_cc_report 20:26:52 INFO - PROCESS | 7801 | _x_x_mozilla_cycle_collect,895 20:26:52 INFO - PROCESS | 7801 | __end_cc_report 20:26:52 INFO - PROCESS | 7801 | __startTimestamp1463455612338__endTimestamp 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | ------- Summary: start ------- 20:26:52 INFO - PROCESS | 7801 | Number of tests: 14 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:3.63 20:26:52 INFO - PROCESS | 7801 | Values: 107.0 111.0 102.0 110.0 111.0 111.0 103.0 111.0 111.0 109.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:155.50 stddev:29.17 (18.8%) stddev-sans-first:30.94 20:26:52 INFO - PROCESS | 7801 | Values: 152.0 127.0 150.0 212.0 127.0 159.0 159.0 128.0 191.0 127.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.50 (1.5%) stddev-sans-first:2.60 20:26:52 INFO - PROCESS | 7801 | Values: 164.0 169.0 164.0 163.0 164.0 167.0 170.0 164.0 163.0 165.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:37.95 (50.6%) stddev-sans-first:39.69 20:26:52 INFO - PROCESS | 7801 | Values: 75.0 75.0 75.0 166.0 75.0 75.0 76.0 74.0 164.0 75.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#4] audio-oscillator Cycles:10 Average:113.00 Median:92.00 stddev:35.15 (38.2%) stddev-sans-first:36.45 20:26:52 INFO - PROCESS | 7801 | Values: 92.0 92.0 181.0 92.0 91.0 92.0 158.0 92.0 91.0 149.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 20:26:52 INFO - PROCESS | 7801 | Values: 118.0 120.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 20:26:52 INFO - PROCESS | 7801 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:26:52 INFO - PROCESS | 7801 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:56.50 stddev:17.08 (30.2%) stddev-sans-first:18.00 20:26:52 INFO - PROCESS | 7801 | Values: 57.0 67.0 56.0 57.0 57.0 56.0 56.0 110.0 56.0 53.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:1.76 (2.9%) stddev-sans-first:1.72 20:26:52 INFO - PROCESS | 7801 | Values: 59.0 65.0 61.0 60.0 63.0 60.0 60.0 61.0 60.0 61.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.33 (2.9%) stddev-sans-first:2.35 20:26:52 INFO - PROCESS | 7801 | Values: 78.0 78.0 83.0 80.0 79.0 79.0 78.0 83.0 79.0 84.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:128.00 stddev:21.45 (16.8%) stddev-sans-first:22.72 20:26:52 INFO - PROCESS | 7801 | Values: 128.0 125.0 131.0 119.0 119.0 122.0 120.0 128.0 191.0 132.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:161.50 stddev:3.75 (2.3%) stddev-sans-first:3.94 20:26:52 INFO - PROCESS | 7801 | Values: 160.0 159.0 170.0 161.0 163.0 158.0 158.0 162.0 159.0 165.0 20:26:52 INFO - PROCESS | 7801 | 20:26:52 INFO - PROCESS | 7801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:2.85 (4.4%) stddev-sans-first:2.82 20:26:52 INFO - PROCESS | 7801 | Values: 67.0 65.0 66.0 63.0 62.0 62.0 61.0 62.0 63.0 70.0 20:26:52 INFO - PROCESS | 7801 | -------- Summary: end -------- 20:26:52 INFO - PROCESS | 7801 | 20:26:53 INFO - TEST-INFO | 7801: exit 0 20:26:53 INFO - TEST-OK | kraken | took 63489ms 20:26:53 INFO - SUITE-END | took 1174s 20:26:53 INFO - Completed test suite (00:19:35) 20:26:53 INFO - javascript benchmark 20:26:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.899289591337, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.5102759072342, 3182.5226216067585, 3186.4901615741487, 3201.80789152651, 3226.419244535984, 5320.334958130234, 5335.546478549323, 5339.199120131977, 5411.188321751739, 5477.5070243678065, 5353.5984801139975, 5361.329833770778, 5387.703676297802, 5410.026195284857, 5468.207109969052, 4876.049170411762, 4900.656954013202, 4991.276264941581, 5033.597312215014, 5081.949180508184, 663.8904534584167, 4965.627577931651, 5035.967626636549, 5072.0, 5106.821261255838, 4868.342773725537, 4873.390826146731, 4878.146324393217, 4882.121218180726, 4931.5315045070665, 4889.926651100236, 4890.095332363524, 4891.804327826882, 4912.508749125094, 4957.132501812169, 4892.266160075981, 4898.461169271377, 4910.607151427877, 4929.359183306147, 4972.279019542182, 5285.207218917155, 5308.203769434615, 5339.6262261641705, 5391.973040134774, 5419.729013549346, 5785.652860828363, 5794.072948328248, 5795.536357091422, 5814.389489103625, 5867.647941123546, 5883.0, 5894.17481552583, 5936.495397891184, 5957.791477298317, 5960.761569537213, 5495.725213739297, 5533.723313834333, 5545.473180047889, 5548.55611551079, 5555.472230138131, 5814.680192589363, 5943.257092863392, 6039.124326972652, 6079.422454866781, 6081.787137450168, 5639.802606908738, 5695.658260504383, 5706.343770466367, 5714.342850572238, 5724.79963201286, 5792.189093526909, 5836.970815145897, 5848.502877255481, 5849.883002340014, 5856.092305692625, 5490.6431081980345, 5690.800821971211, 5698.686572238484, 5728.427157284238, 5734.598578099493, 5549.528290095306, 5668.829935101953, 5679.346875109332, 5705.74324155414, 5885.352611212763, 4419.64642828573, 4431.911361772746, 4438.7114837535455, 4447.555244475527, 4476.820927162942, 3924.9215015699524, 3982.422548730418, 3985.4021896715726, 3993.780342081155, 4009.398590211433, 5548.889022219533, 5561.77752889888, 5601.915971260434, 5615.354234263031, 5630.5214056805635, 5961.642301461926, 5970.731317090741, 6004.0, 6007.879842403127, 6017.368176341509, 5527.419620939743, 5672.12082127271, 5682.403347648437, 5685.346185188673, 5688.800891968761, 4887.902241955141, 4888.071266459361, 4906.632002599819, 4951.0, 4959.925601115986, 6136.846578835565, 6185.597936134137, 6190.969045154746, 6194.163787888668, 6209.751609935643, 5744.195812586325, 5826.76692932278, 5987.311459182162, 5992.250968628921, 5996.220491336098, 5965.075413310944, 6088.965113858168, 6101.587207021918, 6142.447179753844, 6143.201383820254, 5700.942990570041, 5714.399988001366, 5743.0, 5752.511036561772, 5793.623414478046, 5715.799947001835, 5857.326407463196, 5904.439078287556, 5909.497692696169, 5920.555958303231, 5758.856028599151, 5768.2501274834, 5784.652920824764, 5784.884302314014, 5820.097884827858, 5751.798687045934, 5760.366359700513, 5763.6541807491685, 5775.797847075332, 5784.2769653793275, 5459.044667183306, 5569.387367389503, 5577.0797818359515, 5621.606487545996, 5665.66006039639, 5698.629589076697, 5771.884562308646, 5774.884502310014, 5780.710964451845, 5820.447057529528, 5684.772609095755, 5709.143628455765, 5726.455986681259, 5748.770049197985, 5762.884742305214], "value": 5356.121403290361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.6031079798133, 623.8471574464257, 660.3792435110993, 662.3409707341194, 675.2673349415882, 43754.12491750163, 44924.55075449245, 44956.32565511516, 48814.75592622032, 49033.99999999991, 46241.0, 47055.29417058747, 47059.294110588366, 47132.0, 47365.52634473654, 8657.350698697592, 8805.20753132218, 8824.338174636896, 8824.382293239476, 8829.249513791336, 8838.072002439747, 8899.37704360695, 8901.465912045265, 8901.599428025755, 8906.06486318937, 8937.150970657776, 8970.461772293684, 8973.192412682858, 9013.188813006827, 9028.187463128317, 8848.823023539557, 8897.68858089967, 8926.598303076376, 8935.151160639729, 8948.149925757076, 8741.25699315559, 8813.823723525558, 8880.73357799267, 8919.68781092665, 8937.329700272441, 42540.78729606363, 43006.78496607497, 43036.0, 43051.0, 43056.569434305566, 3465.913352166216, 3479.9652003479896, 3494.545709057806, 3611.205534782344, 3689.5572531296148, 32868.178295542566, 33123.171920701934, 33365.0, 33475.665243347496, 33478.330433391195, 4257.808398622038, 4261.2329780639475, 4282.464691913511, 4375.803088860977, 4390.802413891351, 339202.0, 339352.0, 340151.0, 341501.0, 342124.0, 36064.63935360613, 61847.6907615468, 62492.37507624865, 62784.37215627877, 62806.371936280964, 35409.0, 35513.75701850423, 35556.46665300023, 35588.822055889555, 35604.465933010506, 15862.127582982816, 16058.116803575682, 16059.116748578941, 16072.75890861638, 16098.275577599035, 12613.558525451564, 12714.046446516548, 12796.0, 12816.935915320364, 12858.228506289652, 8629.0, 8629.43908645936, 8679.6528138875, 8735.082816304324, 8748.825023499621, 3295.9011229663147, 3312.1222875937897, 3325.418051840918, 3341.131305860445, 3358.37869994047, 1074.3500182389541, 1137.7245508982037, 1150.045462266317, 1172.2263306217856, 1237.888590026902, 31437.842810785798, 31746.841265793522, 31769.764147426406, 31816.363672726417, 32227.194320142185, 1030.5465595138114, 1140.686311264409, 1148.8563929508812, 1174.8179032250016, 1177.375990724917, 17153.0, 17323.826761732475, 17342.739858902125, 17507.47477575675, 18664.44006679802, 366374.0, 532427.0, 532519.0, 536629.0, 537520.0, 62659.6867015662, 63938.0, 64101.0, 64583.0, 64618.67690661517, 1471.7130159618985, 1494.2006026775841, 1502.4516051641071, 1505.9849401506065, 1508.2684897824547, 33641.49537756887, 34095.14762130967, 34830.82584587061, 34958.475622866186, 35331.82334088313, 54925.72537137449, 55124.72437637786, 55372.0, 55776.0, 56111.71944140253, 494604.0, 495164.0, 495524.0, 496431.0, 497632.0, 45684.31473527966, 45812.77093614644, 46484.0, 47087.0, 47163.056738865715, 45298.0, 47464.7626761864, 49888.0, 50326.74836625793, 51295.74352128216, 41731.7913410431, 43076.56923430851, 43762.56237437585, 43840.561594384926, 44556.55443445524, 43153.626550538764, 43363.56636433595, 43583.0, 44335.55664443314, 44523.0, 42061.0, 42822.0, 43673.56326436695, 44170.77914610406, 44544.10911781811, 37495.25009499849, 37696.43455348227, 38748.49578820657, 39057.6094239054, 39126.2174756509, 29613.555796662637, 29660.851695741385, 29689.5546566806, 29862.70137298686, 30165.547516787705], "value": 19825.81201581852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.70830418706896, 418.17201940158486, 422.1746485620612, 425.7275343779979, 437.94744630644306, 17572.736408953875, 18426.262949482003, 18790.81209187906, 19158.233670653157, 19190.616187676238, 18254.17856196471, 18548.165332560035, 19210.615787684237, 19295.4211373659, 19387.224511019544, 5600.775968961237, 5862.853428664275, 5919.467247947684, 5942.940570594282, 5947.434993675594, 5640.323161220639, 5787.0, 5826.592138550282, 5848.356680765112, 5873.500752436048, 5823.06830907055, 5827.592068555203, 5831.562632802556, 5839.591228613998, 5874.177615133864, 5712.742926568314, 5723.255976723, 5842.5618078644275, 5845.152452894327, 5854.677992710399, 5176.55999240065, 5199.038177937094, 5224.190250511138, 5242.239875218072, 5257.579393648537, 19734.0, 20992.0, 21020.579588408298, 21702.348929532138, 21798.673019904712, 2210.303754317385, 2256.4246117240164, 2297.666838308436, 2317.6523521471913, 2388.7491813359693, 9756.560954757053, 9785.706428807147, 9844.95077524615, 10632.840507392395, 14835.332410041574, 1894.9621007579772, 1954.980450195494, 1994.2023190723683, 2023.3633681524623, 2054.5377290109755, 80071.59964200141, 83000.16999829985, 83813.16186838114, 84619.0, 86193.56903215506, 11218.66344009681, 11243.60647377338, 11247.718807029725, 11469.88530114705, 11471.254368466023, 15923.283452244445, 15970.680586388207, 15982.0, 15997.760033599505, 16037.278322475284, 7940.602969851484, 8119.837603247902, 8155.34757219421, 8167.63245653947, 8311.418200725891, 7583.658735356922, 7666.65500052499, 7706.922930770621, 7844.843103137905, 7916.445848790529, 4858.5384388483035, 4858.684185527929, 4886.413630364308, 4971.353724015927, 5007.749612519359, 1995.580928005135, 2068.637988352032, 2084.1871670048695, 2098.6809575419247, 2137.070374387147, 961.8845738511424, 995.2933417273672, 998.5706146357136, 1009.7929924365487, 1095.9752631289768, 18168.545786355447, 18589.628207435777, 18592.163352649164, 18714.1578628962, 18795.530111747317, 1053.4943227250963, 1075.6665433715573, 1087.6247694545368, 1088.357868857378, 1108.0913650806262, 10284.948575257076, 10591.470426478645, 10629.84055239172, 10773.138148948065, 10781.730456738487, 454367.0, 459703.0, 467920.0, 468270.0, 469727.0, 68181.0, 85397.0, 86728.0, 92141.53929230446, 95441.0, 1039.4698703661188, 1068.8396740488988, 1078.3691540448926, 1080.9243352965375, 1083.47992963378, 16765.1617419131, 17168.484945451655, 17171.399001035403, 17282.48152555375, 17360.479185624452, 40394.0, 40774.38838417367, 41048.79475602603, 42028.94927626834, 43457.565424345354, 58536.0, 59803.70098149481, 60392.0, 61075.389246108745, 61351.6932415335, 8536.914630853613, 8605.741827744927, 8809.735707928772, 8845.734627961172, 8861.158189971942, 9252.444853308823, 12734.426950787052, 13061.21632702041, 13298.135621184592, 13497.39261733244, 11630.476628551567, 11722.23805452677, 11879.940600296943, 11883.524659013543, 12066.698332541757, 11477.655670329903, 11493.94253028763, 11627.53489860396, 11632.407968000965, 11875.109366797698, 11850.940745296219, 12024.879751202376, 12032.157748957488, 12169.452374642986, 12637.0, 8666.480011199348, 8690.130986901511, 8742.781430464289, 8743.956280218557, 8882.555872206492, 8601.483910965362, 8638.524881131598, 8778.91221087781, 8788.472691638523, 8865.379423440298], "value": 9202.004797604464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.9147451152928, 1497.0344128037416, 1649.958751031224, 1884.7455593494874, 1896.7818700849407, 8142.145074767153, 8837.734867953955, 9032.09679032098, 9469.952650236748, 9511.334206605532, 9302.441853488779, 9322.207612352959, 9379.39033962792, 9380.906190938089, 9382.296327775428, 2294.827887908405, 2326.9650955235684, 2330.592146374386, 2331.0326214620914, 2334.5681049005902, 2292.3695983604475, 2322.7096612923383, 2360.87015214164, 2364.267077206063, 2364.9645255321184, 2271.8636881787147, 2284.097781376355, 2294.4263934016494, 2357.139644029934, 2362.8464149830206, 2253.256425379629, 2259.548090381922, 2265.716785401825, 2268.3761965459466, 2271.3526644906287, 2221.955560888773, 2235.273536100774, 2237.038073628339, 2237.284069097889, 2239.193890199527, 9082.40964337316, 9135.725928222164, 9144.451332920045, 9160.954195229047, 9194.12655797698, 5146.279520867081, 5201.661891977009, 5232.189010703347, 5247.816326428557, 5259.526642602184, 3196.568463257454, 3281.425750493654, 3339.8664053437833, 3357.2781851901714, 3370.5618269624792, 1092.180864351736, 1105.9612913547987, 1121.4224674292745, 1156.2368836567825, 1172.6892373521023, 12753.362331883369, 12770.106092573524, 12783.0, 12801.48794048237, 12802.039847011418, 4569.022999373026, 4611.953880461219, 4618.653600979873, 4620.2607582786595, 4647.256438969748, 10761.83857242142, 10824.512896919658, 10838.512266948006, 10875.07561857251, 10880.510377033053, 5247.790088396498, 5265.078611243017, 5396.865078372994, 5401.459854014567, 5408.5402740766685, 4213.47331583552, 4556.703814252063, 4731.148393289172, 4733.644976626698, 4955.2567114933045, 4136.0, 4145.647619952338, 4232.0, 4232.661387089025, 4244.278472659656, 1322.5172811923578, 1345.4618152738983, 1352.094096955023, 1352.905296629246, 1370.3422357268369, 918.3158546882615, 944.3436811416137, 952.2667545989549, 961.7595601099725, 962.2157941277836, 5690.260266165372, 5744.913826292609, 5793.768249270066, 5904.704764761831, 5914.497267732205, 396.5162501747863, 403.8970062634068, 403.94748682671064, 413.4294673350757, 419.7963987466077, 3981.785555405629, 3983.203359328146, 4026.1142548639255, 4032.778197199182, 4078.3882417636996, 11363.37501437429, 11677.649670509898, 11744.76510469803, 11763.705907352214, 11767.646970590897, 11490.253133546294, 11490.540378384938, 11583.420828958519, 11594.594189203337, 11616.535338586531, 8336.291415229653, 8550.700725474579, 8601.268892144113, 8605.569721513899, 8688.261497772633, 5601.355844077983, 5694.345150307768, 5694.515966142924, 5707.258056452634, 5841.620294680833, 10233.692989210336, 10494.737631559272, 10525.105366043972, 10852.67441976742, 10864.130869530261, 10914.399708016135, 10919.672409827717, 10966.287191332538, 11150.10799136051, 11165.441727913734, 7325.7802265932105, 8040.959795200986, 8155.143709910374, 8248.711295104642, 8282.544460054754, 9072.727818165466, 9182.127697868691, 9187.081291871027, 9198.0, 9248.583813728534, 8095.433319667803, 8264.545450000307, 8308.33533317321, 8341.040780310343, 8375.497470151811, 7929.960350198212, 7993.320567751573, 8046.356291496549, 8046.718364857202, 8101.189881011852, 7238.312360325761, 7242.818929526804, 7261.0, 7300.379467745089, 7354.852902941804, 5249.2126181073145, 5282.260483532232, 5338.172583249602, 5342.572594192533, 5352.0366334060245, 5149.922751158811, 5314.468553144655, 5330.813421530228, 5338.75975581092, 5344.5991550634635], "value": 4641.105141313198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.39671959619835, 338.50747162878014, 344.1911507956302, 344.29763282902877, 347.8625942752614, 5458.2904222451125, 5618.662880227189, 5644.633098848577, 5658.726786473047, 5705.942940570593, 5622.887542249153, 5638.154276858473, 5677.744501497432, 5680.886382272352, 5699.829005129843, 4364.956350436502, 4415.690901636886, 4417.27115026022, 4419.668524860632, 4450.485475706224, 4075.755454672714, 4351.195028919644, 4354.238008348526, 4397.626201772853, 4417.845375411861, 4299.656027517791, 4303.74177549348, 4315.8994456413575, 4319.805608747598, 4348.5216626171095, 4360.345948107793, 4362.367456718774, 4369.890752731176, 4382.8904277393, 4397.428334316518, 3756.948054544732, 3790.0, 3836.827342769582, 3840.827162777654, 3855.267499175148, 5390.059578551718, 5404.702741349224, 5415.539679127279, 5424.566034717213, 5434.565234781208, 4942.283368911523, 4949.975250123763, 4950.653454258203, 4964.205727083686, 4968.0, 5539.473749993744, 5791.536677065867, 5800.361960184377, 5818.21454103699, 5824.330202026778, 4143.97928010358, 4146.834126634931, 4169.353750168729, 4170.791460426966, 4175.352820312856, 6050.2437195350585, 6100.749346383981, 6112.908306375408, 6139.785107521216, 6152.753889844401, 4165.229432554987, 4202.8739137825305, 4231.30183519722, 4293.935590966138, 4303.225419424533, 4215.473065866767, 4242.469691288589, 4262.614650238685, 4279.239890270758, 4300.0, 4837.854864354075, 4878.82924097662, 4905.23968784839, 4919.385076865392, 4947.851564453073, 5750.712464376765, 5880.529557635379, 5905.43898329658, 5908.763649453974, 5939.851503712442, 1477.6848604741574, 1477.933492992818, 1491.313995562032, 1496.3864815425623, 1502.2413681091198, 912.309368191718, 928.7585227840675, 943.061653654618, 948.5162567090833, 951.6574033347989, 4941.135301322254, 5033.2701758245585, 5058.342415485963, 5064.620153488503, 5122.641415100908, 5290.804316208807, 5327.413984461706, 5338.252644629677, 5339.919901201485, 5399.757010934517, 4919.335889654851, 4986.800527978913, 4988.725620090857, 5285.63000589955, 5733.741981610838, 3242.0922141800334, 3248.4964830451318, 3276.361109583656, 3279.2785587170783, 3282.803031818051, 6054.243219597551, 6265.342139075331, 6283.277423096311, 6337.397947195009, 6356.396142366468, 6144.648177400964, 6171.783987560414, 6177.444030037228, 6196.411340922605, 6237.500999919996, 6277.52918531112, 6285.931391663428, 6317.799618072551, 6321.0, 6327.367263273728, 5818.31268932005, 6047.274327080779, 6058.878822423439, 6062.818115456544, 6090.847728806638, 5880.676562789087, 6002.609830361012, 6004.219451471281, 6081.969590152021, 6107.6640784757265, 6084.513238940785, 6288.585068359583, 6343.0, 6346.524010699124, 6359.427651511386, 4184.539700632867, 4184.895377615584, 4198.202341555095, 4217.578242175758, 4220.029393239511, 6039.037312873422, 6045.818625441244, 6072.271327440559, 6075.574709770273, 6105.45050945417, 5693.886122277614, 5809.9419005809405, 5890.468478195786, 5899.846556006941, 5917.1715959766525, 5825.75708352279, 5841.737121829443, 5870.765169393348, 5880.529557635465, 5899.380565040609, 5475.780968761205, 5755.1942728017275, 5756.827295181151, 5775.768969241183, 5779.2775903012125, 5894.11388355722, 5903.586748927705, 5919.763209471573, 5933.554983376178, 5933.762649493972, 5738.741756620879, 5741.885162296814, 5793.971030144991, 5814.94185058144, 5817.738201780845], "value": 4428.141058597339, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.4474365251451, 710.6730903784259, 799.0132186749368, 851.9361047921406, 866.3978534918232, 14676.926615366921, 14898.255087245621, 15183.316750746215, 15211.391544338214, 15230.466933657324, 13846.238456884892, 14022.649433764136, 14124.223167725771, 14176.858231417682, 14187.929060354709, 685.0819901332226, 834.6244190114443, 852.4842470305468, 855.84166929118, 858.2833334165948, 849.6601359456205, 850.9873250831522, 855.5807654249404, 855.670566831768, 856.7429771068654, 880.0451510111536, 880.8854848869638, 881.6649673124203, 883.1433509495779, 883.3816328569994, 877.7542288159326, 881.0132651430375, 881.3037700216821, 882.6513527156737, 883.266888482558, 630.4987534909758, 635.3582881289931, 637.8724255148989, 638.6232123047424, 638.8115505925763, 12940.676483087904, 13083.0, 13114.213147211103, 13132.737345253137, 13133.34333283332, 14490.0, 14657.633559161, 14697.191654459, 14753.77869331961, 14885.106893586311, 11799.292042477478, 11835.11236657254, 11918.642440726791, 12117.030637548974, 12201.267923924594, 3861.4400911867624, 3917.7061720371084, 3923.548791888912, 3926.312895243321, 3961.5444223914333, 57248.71375643095, 57498.0, 57562.71218643922, 58038.7098064507, 58487.0, 11368.374739389248, 11409.771804563863, 11458.140639451907, 11484.99012672779, 11653.30080195174, 20840.1663933444, 21076.894615526824, 21079.156833726785, 21123.78876211218, 21130.154793808382, 8250.54621995784, 8278.71024514139, 8322.20939010793, 8430.578471076544, 8581.699640512552, 4423.181711383404, 4540.977295113504, 4568.81724731007, 4583.083383323348, 4674.579287864109, 3427.7943323400677, 3527.5943266524164, 3541.8760343387858, 3545.468179773003, 3560.092176494977, 656.7307403964447, 663.7444583835259, 679.3715812873171, 720.6648908257686, 723.9493235473572, 731.7731503233908, 768.4198430185286, 769.9076110866732, 769.9576523291273, 802.626778547978, 10226.53980570876, 10318.122959548373, 10490.16078713701, 10490.947545262225, 10493.685189444328, 621.5711159300068, 696.2550071423528, 760.3202289905639, 786.3591173193829, 807.4428644235576, 4902.460729319772, 4919.1391506486225, 5031.899362012739, 5038.622103342264, 5071.7971281149075, 73003.0, 74617.25382746103, 74769.0, 74899.0, 76449.0, 65890.39931605867, 66053.669731652, 66129.33870661329, 66492.33507664861, 66869.99999999903, 61041.69479152664, 61187.08219376713, 61541.15376538711, 61549.384506155264, 61699.383006169366, 9458.668946586837, 9595.808083838423, 9612.807743845224, 9622.51887405641, 9694.709158725249, 39155.0, 39388.40917386299, 39459.2108157841, 40339.596604033584, 40341.0, 50526.24210636917, 52301.215481768566, 52807.47192528025, 53204.73397632987, 54654.0, 11986.340751258764, 12276.87723122793, 12361.567345142877, 12658.87341126577, 12990.0, 14359.138451692932, 14502.85497145015, 14854.405823766929, 15021.624459388602, 15526.61183470377, 12956.870431295567, 13330.466781328638, 13559.254241016444, 13661.931690341882, 13709.588712338646, 13631.522896698569, 13730.382132804247, 14181.0, 14204.431822726976, 14679.706405872037, 14142.363593638105, 14206.573802785933, 14327.0, 14507.0, 14646.853531464974, 10422.635207767995, 10904.182186335898, 10988.725281867697, 11198.552057917592, 11376.374299413612, 10842.566297348018, 11045.33727976324, 11284.492197851281, 11458.197926145423, 11846.11154163424], "value": 7206.171312806928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 102.0, 110.0, 111.0, 111.0, 103.0, 111.0, 111.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 150.0, 212.0, 127.0, 159.0, 159.0, 128.0, 191.0, 127.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 164.0, 163.0, 164.0, 167.0, 170.0, 164.0, 163.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 166.0, 75.0, 75.0, 76.0, 74.0, 164.0, 75.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 181.0, 92.0, 91.0, 92.0, 158.0, 92.0, 91.0, 149.0], "value": 113.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 67.0, 56.0, 57.0, 57.0, 56.0, 56.0, 110.0, 56.0, 53.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 61.0, 60.0, 63.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 83.0, 80.0, 79.0, 79.0, 78.0, 83.0, 79.0, 84.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 131.0, 119.0, 119.0, 122.0, 120.0, 128.0, 191.0, 132.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 170.0, 161.0, 163.0, 158.0, 158.0, 162.0, 159.0, 165.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 63.0, 62.0, 62.0, 61.0, 62.0, 63.0, 70.0], "value": 64.1, "unit": "score"}]}]} 20:26:53 INFO - Return code: 0 20:26:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:53 ERROR - # TBPL SUCCESS # 20:26:53 INFO - Running post-action listener: _resource_record_post_action 20:26:53 INFO - ##### 20:26:53 INFO - ##### Finished run-tests step (success) 20:26:53 INFO - ##### 20:26:53 INFO - Running post-run listener: _resource_record_post_run 20:26:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 535937024; Read time: 0; Write time: 985084 20:26:53 INFO - TinderboxPrint: CPU usage
13.5% 20:26:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:26:53 INFO - TinderboxPrint: I/O write bytes / time
535,937,024 / 985,084 20:26:53 INFO - TinderboxPrint: CPU idle
8,236.5 (86.5%) 20:26:53 INFO - TinderboxPrint: CPU user
1,217.0 (12.8%) 20:26:53 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:53 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 218923008; Read time: 0; Write time: 534948 20:26:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289628160; Read time: 0; Write time: 439904 20:26:54 INFO - Running post-run listener: _upload_blobber_files 20:26:54 INFO - Blob upload gear active. 20:26:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:54 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:26:54 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:26:54 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:26:54 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:59 INFO - (blobuploader) - INFO - Done attempting. 20:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:00 INFO - (blobuploader) - INFO - Done attempting. 20:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:01 INFO - (blobuploader) - INFO - Done attempting. 20:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:01 INFO - Return code: 0 20:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a1614e2046665d64f2acdbaf0b0e69613f95ad215085aaf49c8dbd13d809d3f6400513f25ad519d15159de7c066d30a0e82687d9399a91f1e85bdea6d76c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14857f5f8decdfa8e79fd935b699676591388e532eb306b9771b8be255fe26c0f964ca611e7f9a496329c94ab93f7d4ebfb44944621f485545adb69c6d4082b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3075d344775a9f6f274c8211cdc56f1dbab19df75bbe2afd656e054420575b7f1823fa26804fc8dfff9505cf17632770774900f3bd8a03ac170b9e0c802537bd"} 20:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:01 INFO - Contents: 20:27:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a1614e2046665d64f2acdbaf0b0e69613f95ad215085aaf49c8dbd13d809d3f6400513f25ad519d15159de7c066d30a0e82687d9399a91f1e85bdea6d76c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14857f5f8decdfa8e79fd935b699676591388e532eb306b9771b8be255fe26c0f964ca611e7f9a496329c94ab93f7d4ebfb44944621f485545adb69c6d4082b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3075d344775a9f6f274c8211cdc56f1dbab19df75bbe2afd656e054420575b7f1823fa26804fc8dfff9505cf17632770774900f3bd8a03ac170b9e0c802537bd"} 20:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:01 INFO - Copying logs to upload dir... 20:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.168451 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-16 20:27:00.731289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:27:00.734978) ========= 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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a1614e2046665d64f2acdbaf0b0e69613f95ad215085aaf49c8dbd13d809d3f6400513f25ad519d15159de7c066d30a0e82687d9399a91f1e85bdea6d76c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14857f5f8decdfa8e79fd935b699676591388e532eb306b9771b8be255fe26c0f964ca611e7f9a496329c94ab93f7d4ebfb44944621f485545adb69c6d4082b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3075d344775a9f6f274c8211cdc56f1dbab19df75bbe2afd656e054420575b7f1823fa26804fc8dfff9505cf17632770774900f3bd8a03ac170b9e0c802537bd"} build_url:https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/Y3HsucFLTr26WQZZFgJcEg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a1614e2046665d64f2acdbaf0b0e69613f95ad215085aaf49c8dbd13d809d3f6400513f25ad519d15159de7c066d30a0e82687d9399a91f1e85bdea6d76c30e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14857f5f8decdfa8e79fd935b699676591388e532eb306b9771b8be255fe26c0f964ca611e7f9a496329c94ab93f7d4ebfb44944621f485545adb69c6d4082b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3075d344775a9f6f274c8211cdc56f1dbab19df75bbe2afd656e054420575b7f1823fa26804fc8dfff9505cf17632770774900f3bd8a03ac170b9e0c802537bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:27:00.768713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:27:00.769610) ========= 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=33d5923976266a1c518c4bf7000001ab-1463453716.187495-1200260542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:27:00.851676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:27:00.852045) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:27:00.852370) ========= ========= Total master_lag: 0.18 =========