builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1463454977.8 results: success (0) buildid: 20160516173016 builduid: 1557819d61294a6b8fc8022ab87cecc4 revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:17.804298) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:17.804735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:17.805048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:17.839558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:17.839936) ========= 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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 20:16:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-05-16 20:16:18 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.027296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.027640) ========= 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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018092 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.078178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.078606) ========= 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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 20:16:19,075 truncating revision to first 12 chars 2016-05-16 20:16:19,075 Setting DEBUG logging. 2016-05-16 20:16:19,075 attempt 1/10 2016-05-16 20:16:19,075 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:16:19,505 unpacking tar archive at: fx-team-cf83a5943afc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.823209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.824029) ========= script_repo_revision: cf83a5943afc01c163b8fbe438e332a31f08701a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.825101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.825833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 20:16:18.879632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-16 20:16:18.880005) ========= /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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:19 INFO - MultiFileLogger online at 20160516 20:16:19 in /builds/slave/test 20:16:19 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:16:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:19 INFO - {'append_to_log': False, 20:16:19 INFO - 'base_work_dir': '/builds/slave/test', 20:16:19 INFO - 'blob_upload_branch': 'Fx-Team', 20:16:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:19 INFO - 'branch': 'Fx-Team', 20:16:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:19 INFO - 'config_files': ('talos/linux_config.py',), 20:16:19 INFO - 'default_actions': ('clobber', 20:16:19 INFO - 'read-buildbot-config', 20:16:19 INFO - 'download-and-extract', 20:16:19 INFO - 'populate-webroot', 20:16:19 INFO - 'create-virtualenv', 20:16:19 INFO - 'install', 20:16:19 INFO - 'run-tests'), 20:16:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:19 INFO - 'download_minidump_stackwalk': True, 20:16:19 INFO - 'download_symbols': 'ondemand', 20:16:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:19 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:19 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:19 INFO - 'installer_path': 'installer.exe', 20:16:19 INFO - 'log_level': 'info', 20:16:19 INFO - 'log_name': 'talos', 20:16:19 INFO - 'log_to_console': True, 20:16:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:19 INFO - 'opt_config_files': (), 20:16:19 INFO - 'pip_index': False, 20:16:19 INFO - 'sps_profile': False, 20:16:19 INFO - 'sps_profile_interval': 0, 20:16:19 INFO - 'suite': 'dromaeojs-e10s', 20:16:19 INFO - 'system_bits': '32', 20:16:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:19 INFO - 'title': 'talos-linux64-ix-056', 20:16:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:19 INFO - 'use_talos_json': True, 20:16:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:19 INFO - 'work_dir': 'build'} 20:16:19 INFO - ##### 20:16:19 INFO - ##### Running clobber step. 20:16:19 INFO - ##### 20:16:19 INFO - Running pre-action listener: _resource_record_pre_action 20:16:19 INFO - Running main action method: clobber 20:16:19 INFO - rmtree: /builds/slave/test/build 20:16:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:20 INFO - Running post-action listener: _resource_record_post_action 20:16:20 INFO - ##### 20:16:20 INFO - ##### Finished clobber step (success) 20:16:20 INFO - ##### 20:16:20 INFO - ##### 20:16:20 INFO - ##### Running read-buildbot-config step. 20:16:20 INFO - ##### 20:16:20 INFO - Running pre-action listener: _resource_record_pre_action 20:16:20 INFO - Running main action method: read_buildbot_config 20:16:20 INFO - Using buildbot properties: 20:16:20 INFO - { 20:16:20 INFO - "project": "", 20:16:20 INFO - "product": "firefox", 20:16:20 INFO - "script_repo_revision": "production", 20:16:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:16:20 INFO - "repository": "", 20:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:16:20 INFO - "buildid": "20160516173016", 20:16:20 INFO - "pgo_build": "True", 20:16:20 INFO - "basedir": "/builds/slave/test", 20:16:20 INFO - "buildnumber": 336, 20:16:20 INFO - "slavename": "talos-linux64-ix-056", 20:16:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:16:20 INFO - "platform": "ubuntu64_hw", 20:16:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:16:20 INFO - "branch": "fx-team", 20:16:20 INFO - "repo_path": "integration/fx-team", 20:16:20 INFO - "revision": "cf83a5943afc01c163b8fbe438e332a31f08701a", 20:16:20 INFO - "stage_platform": "linux64-pgo", 20:16:20 INFO - "builduid": "1557819d61294a6b8fc8022ab87cecc4", 20:16:20 INFO - "slavebuilddir": "test" 20:16:20 INFO - } 20:16:20 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:16:20 INFO - Running post-action listener: _resource_record_post_action 20:16:20 INFO - ##### 20:16:20 INFO - ##### Finished read-buildbot-config step (success) 20:16:20 INFO - ##### 20:16:20 INFO - ##### 20:16:20 INFO - ##### Running download-and-extract step. 20:16:20 INFO - ##### 20:16:20 INFO - Running pre-action listener: _resource_record_pre_action 20:16:20 INFO - Running main action method: download_and_extract 20:16:20 INFO - mkdir: /builds/slave/test/build/tests 20:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:20 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:16:20 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:16:20 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:16:20 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:16:20 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:16:24 INFO - Downloaded 1361 bytes. 20:16:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:16:24 INFO - Using the following test package requirements: 20:16:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:16:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'jsshell-linux-x86_64.zip'], 20:16:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:16:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:16:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:24 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:16:24 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:16:24 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:16:24 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:16:24 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:16:25 INFO - Downloaded 24023206 bytes. 20:16:25 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:16:25 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:16:27 INFO - Return code: 0 20:16: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:16: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:16: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:16: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:16: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:16: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:16: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:16:30 INFO - Downloaded 24023206 bytes. 20:16:30 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:16:30 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:16:31 INFO - Return code: 0 20:16: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:16: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:16: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:16: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:16: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:16: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:16:32 INFO - Downloaded 10840194 bytes. 20:16: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:16: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:16:32 INFO - Return code: 0 20:16: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:16: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:16: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:16: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:16: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:16: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:16:34 INFO - Downloaded 58427509 bytes. 20:16: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:16:34 INFO - mkdir: /builds/slave/test/properties 20:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:34 INFO - Contents: 20:16: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:16:35 INFO - Running post-action listener: _resource_record_post_action 20:16:35 INFO - Running post-action listener: set_extra_try_arguments 20:16:35 INFO - ##### 20:16:35 INFO - ##### Finished download-and-extract step (success) 20:16:35 INFO - ##### 20:16:35 INFO - ##### 20:16:35 INFO - ##### Running populate-webroot step. 20:16:35 INFO - ##### 20:16:35 INFO - Running pre-action listener: _resource_record_pre_action 20:16:35 INFO - Running main action method: populate_webroot 20:16:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:35 INFO - '--tppagecycles', 20:16:35 INFO - '7'], 20:16:35 INFO - 'tests': ['tsvgm']}}, 20:16:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['damp', 'tps']}, 20:16:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'tests': ['damp', 'tps']}, 20:16:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['dromaeo_dom']}, 20:16:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['a11yr', 20:16:35 INFO - 'ts_paint', 20:16:35 INFO - 'tpaint', 20:16:35 INFO - 'sessionrestore', 20:16:35 INFO - 'sessionrestore_no_auto_restore', 20:16:35 INFO - 'tabpaint']}, 20:16:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['tsvgx', 20:16:35 INFO - 'tsvgr_opacity', 20:16:35 INFO - 'tart', 20:16:35 INFO - 'tscrollx', 20:16:35 INFO - 'cart']}, 20:16:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:35 INFO - 'tsvgr_opacity', 20:16:35 INFO - 'tart', 20:16:35 INFO - 'tscrollx', 20:16:35 INFO - 'cart']}, 20:16:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'talos_options': ['--disable-e10s'], 20:16:35 INFO - 'tests': ['tp5o']}, 20:16:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'tests': ['tp5o']}, 20:16:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'talos_options': ['--disable-e10s', 20:16:35 INFO - '--xperf_path', 20:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:35 INFO - 'tests': ['tp5n']}, 20:16:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:35 INFO - 'talos_options': ['--xperf_path', 20:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:35 INFO - 'tests': ['tp5n']}}, 20:16:35 INFO - 'talos.zip': {'path': '', 20:16:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:35 INFO - Running post-action listener: _resource_record_post_action 20:16:35 INFO - ##### 20:16:35 INFO - ##### Finished populate-webroot step (success) 20:16:35 INFO - ##### 20:16:35 INFO - ##### 20:16:35 INFO - ##### Running create-virtualenv step. 20:16:35 INFO - ##### 20:16:35 INFO - Running pre-action listener: _resource_record_pre_action 20:16:35 INFO - Running main action method: create_virtualenv 20:16:35 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:35 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:16:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:35 INFO - Using real prefix '/usr' 20:16:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:35 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:37 INFO - Installing pip.................done. 20:16:37 INFO - Return code: 0 20:16:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16: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:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16: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:16: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:16:37 INFO - Using env: {'DISPLAY': ':0', 20:16:37 INFO - 'HOME': '/home/cltbld', 20:16:37 INFO - 'LANG': 'en_US.UTF-8', 20:16:37 INFO - 'LANGUAGE': 'en_US:en', 20:16:37 INFO - 'LOGNAME': 'cltbld', 20:16:37 INFO - 'MAIL': '/var/mail/cltbld', 20:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:37 INFO - 'MOZ_NO_REMOTE': '1', 20:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:37 INFO - 'NO_EM_RESTART': '1', 20:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:37 INFO - 'PWD': '/builds/slave/test', 20:16:37 INFO - 'SHELL': '/bin/bash', 20:16:37 INFO - 'SHLVL': '1', 20:16:37 INFO - 'TERM': 'linux', 20:16:37 INFO - 'TMOUT': '86400', 20:16:37 INFO - 'USER': 'cltbld', 20:16:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:37 INFO - '_': '/tools/buildbot/bin/python'} 20:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16: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:16:37 INFO - Cleaning up... 20:16:37 INFO - Return code: 0 20:16:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16: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:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16: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:16: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:16:37 INFO - Using env: {'DISPLAY': ':0', 20:16:37 INFO - 'HOME': '/home/cltbld', 20:16:37 INFO - 'LANG': 'en_US.UTF-8', 20:16:37 INFO - 'LANGUAGE': 'en_US:en', 20:16:37 INFO - 'LOGNAME': 'cltbld', 20:16:37 INFO - 'MAIL': '/var/mail/cltbld', 20:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:37 INFO - 'MOZ_NO_REMOTE': '1', 20:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:37 INFO - 'NO_EM_RESTART': '1', 20:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:37 INFO - 'PWD': '/builds/slave/test', 20:16:37 INFO - 'SHELL': '/bin/bash', 20:16:37 INFO - 'SHLVL': '1', 20:16:37 INFO - 'TERM': 'linux', 20:16:37 INFO - 'TMOUT': '86400', 20:16:37 INFO - 'USER': 'cltbld', 20:16:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:37 INFO - '_': '/tools/buildbot/bin/python'} 20:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:38 INFO - Downloading/unpacking psutil>=3.1.1 20:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:40 INFO - Installing collected packages: psutil 20:16:40 INFO - Running setup.py install for psutil 20:16:40 INFO - building 'psutil._psutil_linux' extension 20:16:40 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:16:40 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:16:40 INFO - building 'psutil._psutil_posix' extension 20:16:40 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:16:40 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:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:40 INFO - Successfully installed psutil 20:16:40 INFO - Cleaning up... 20:16:40 INFO - Return code: 0 20:16:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16:40 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:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:40 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:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:40 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:40 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:16:40 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:16:40 INFO - Using env: {'DISPLAY': ':0', 20:16:40 INFO - 'HOME': '/home/cltbld', 20:16:40 INFO - 'LANG': 'en_US.UTF-8', 20:16:40 INFO - 'LANGUAGE': 'en_US:en', 20:16:40 INFO - 'LOGNAME': 'cltbld', 20:16:40 INFO - 'MAIL': '/var/mail/cltbld', 20:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:40 INFO - 'MOZ_NO_REMOTE': '1', 20:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:40 INFO - 'NO_EM_RESTART': '1', 20:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:40 INFO - 'PWD': '/builds/slave/test', 20:16:40 INFO - 'SHELL': '/bin/bash', 20:16:40 INFO - 'SHLVL': '1', 20:16:40 INFO - 'TERM': 'linux', 20:16:40 INFO - 'TMOUT': '86400', 20:16:40 INFO - 'USER': 'cltbld', 20:16:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:40 INFO - '_': '/tools/buildbot/bin/python'} 20:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:42 INFO - Installing collected packages: mozsystemmonitor 20:16:42 INFO - Running setup.py install for mozsystemmonitor 20:16:42 INFO - Successfully installed mozsystemmonitor 20:16:42 INFO - Cleaning up... 20:16:43 INFO - Return code: 0 20:16:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16: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:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16: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:16: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:16:43 INFO - Using env: {'DISPLAY': ':0', 20:16:43 INFO - 'HOME': '/home/cltbld', 20:16:43 INFO - 'LANG': 'en_US.UTF-8', 20:16:43 INFO - 'LANGUAGE': 'en_US:en', 20:16:43 INFO - 'LOGNAME': 'cltbld', 20:16:43 INFO - 'MAIL': '/var/mail/cltbld', 20:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:43 INFO - 'MOZ_NO_REMOTE': '1', 20:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:43 INFO - 'NO_EM_RESTART': '1', 20:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:43 INFO - 'PWD': '/builds/slave/test', 20:16:43 INFO - 'SHELL': '/bin/bash', 20:16:43 INFO - 'SHLVL': '1', 20:16:43 INFO - 'TERM': 'linux', 20:16:43 INFO - 'TMOUT': '86400', 20:16:43 INFO - 'USER': 'cltbld', 20:16:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:43 INFO - '_': '/tools/buildbot/bin/python'} 20:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:45 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16: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:16: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:16: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:16: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:16: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:16: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:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16: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:16: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:16: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:16: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:16: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:16: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:16:45 INFO - Downloading docopt-0.6.1.tar.gz 20:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:45 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:45 INFO - Running setup.py install for blobuploader 20:16:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:46 INFO - Running setup.py install for requests 20:16:46 INFO - Running setup.py install for docopt 20:16:46 INFO - Successfully installed blobuploader requests docopt 20:16:46 INFO - Cleaning up... 20:16:46 INFO - Return code: 0 20:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:46 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:46 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:16:46 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:16:46 INFO - Using env: {'DISPLAY': ':0', 20:16:46 INFO - 'HOME': '/home/cltbld', 20:16:46 INFO - 'LANG': 'en_US.UTF-8', 20:16:46 INFO - 'LANGUAGE': 'en_US:en', 20:16:46 INFO - 'LOGNAME': 'cltbld', 20:16:46 INFO - 'MAIL': '/var/mail/cltbld', 20:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:46 INFO - 'MOZ_NO_REMOTE': '1', 20:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:46 INFO - 'NO_EM_RESTART': '1', 20:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:46 INFO - 'PWD': '/builds/slave/test', 20:16:46 INFO - 'SHELL': '/bin/bash', 20:16:46 INFO - 'SHLVL': '1', 20:16:46 INFO - 'TERM': 'linux', 20:16:46 INFO - 'TMOUT': '86400', 20:16:46 INFO - 'USER': 'cltbld', 20:16:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:46 INFO - '_': '/tools/buildbot/bin/python'} 20:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:46 INFO - Running setup.py (path:/tmp/pip-7MreGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:46 INFO - Running setup.py (path:/tmp/pip-OsEgyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:46 INFO - Running setup.py (path:/tmp/pip-mPU1Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:47 INFO - Running setup.py (path:/tmp/pip-8rlBNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:47 INFO - Running setup.py (path:/tmp/pip-78evSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:47 INFO - Running setup.py (path:/tmp/pip-x9yFIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:47 INFO - Running setup.py (path:/tmp/pip-6bCLK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:47 INFO - Running setup.py (path:/tmp/pip-X8Hxly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:47 INFO - Running setup.py (path:/tmp/pip-9HN5y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:47 INFO - Running setup.py (path:/tmp/pip-xd1xyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:47 INFO - Running setup.py (path:/tmp/pip-XzmwOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:47 INFO - Running setup.py (path:/tmp/pip-YAraTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:47 INFO - Running setup.py (path:/tmp/pip-7SFmUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:47 INFO - Running setup.py (path:/tmp/pip-YO_i7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:47 INFO - Running setup.py (path:/tmp/pip-FzakEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:47 INFO - Running setup.py (path:/tmp/pip-d_6YP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:47 INFO - Running setup.py (path:/tmp/pip-4J7ycu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:48 INFO - Running setup.py install for manifestparser 20:16:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Running setup.py install for mozcrash 20:16:48 INFO - Running setup.py install for mozdebug 20:16:48 INFO - Running setup.py install for mozdevice 20:16:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Running setup.py install for mozfile 20:16:48 INFO - Running setup.py install for mozhttpd 20:16:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Running setup.py install for mozinfo 20:16:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Running setup.py install for mozInstall 20:16:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:48 INFO - Running setup.py install for mozleak 20:16:48 INFO - Running setup.py install for mozlog 20:16:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Running setup.py install for moznetwork 20:16:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Running setup.py install for mozprocess 20:16:49 INFO - Running setup.py install for mozprofile 20:16:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Running setup.py install for mozrunner 20:16:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Running setup.py install for mozscreenshot 20:16:49 INFO - Running setup.py install for moztest 20:16:49 INFO - Running setup.py install for mozversion 20:16:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:49 INFO - Cleaning up... 20:16:49 INFO - Return code: 0 20:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:49 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:49 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:16:49 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:16:49 INFO - Using env: {'DISPLAY': ':0', 20:16:49 INFO - 'HOME': '/home/cltbld', 20:16:49 INFO - 'LANG': 'en_US.UTF-8', 20:16:49 INFO - 'LANGUAGE': 'en_US:en', 20:16:49 INFO - 'LOGNAME': 'cltbld', 20:16:49 INFO - 'MAIL': '/var/mail/cltbld', 20:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:49 INFO - 'MOZ_NO_REMOTE': '1', 20:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:49 INFO - 'NO_EM_RESTART': '1', 20:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:49 INFO - 'PWD': '/builds/slave/test', 20:16:49 INFO - 'SHELL': '/bin/bash', 20:16:49 INFO - 'SHLVL': '1', 20:16:49 INFO - 'TERM': 'linux', 20:16:49 INFO - 'TMOUT': '86400', 20:16:49 INFO - 'USER': 'cltbld', 20:16:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:49 INFO - '_': '/tools/buildbot/bin/python'} 20:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:50 INFO - Running setup.py (path:/tmp/pip-1vB0Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16: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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:50 INFO - Running setup.py (path:/tmp/pip-oZL8XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16: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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:50 INFO - Running setup.py (path:/tmp/pip-uGgWQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16: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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:50 INFO - Running setup.py (path:/tmp/pip-_uhTN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:50 INFO - Running setup.py (path:/tmp/pip-syXDYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:50 INFO - Running setup.py (path:/tmp/pip-ozZHsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:50 INFO - Running setup.py (path:/tmp/pip-MQvWJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:50 INFO - Running setup.py (path:/tmp/pip-7obxQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:50 INFO - Running setup.py (path:/tmp/pip-fuktiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:50 INFO - Running setup.py (path:/tmp/pip-oV06xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:50 INFO - Running setup.py (path:/tmp/pip-TKbJb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:50 INFO - Running setup.py (path:/tmp/pip-Fk7nwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:50 INFO - Running setup.py (path:/tmp/pip-VR1Y_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:50 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:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:50 INFO - Running setup.py (path:/tmp/pip-llNdWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16: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:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:51 INFO - Running setup.py (path:/tmp/pip-1TK1iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16: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:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:51 INFO - Running setup.py (path:/tmp/pip-XaDSWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16: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:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:51 INFO - Running setup.py (path:/tmp/pip-1RB4Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16: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:16: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:16: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:16: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:16: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:16: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:16:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:53 INFO - Downloading blessings-1.6.tar.gz 20:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:53 INFO - Installing collected packages: blessings 20:16:53 INFO - Running setup.py install for blessings 20:16:53 INFO - Successfully installed blessings 20:16:53 INFO - Cleaning up... 20:16:53 INFO - Return code: 0 20:16:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:53 INFO - Reading from file tmpfile_stdout 20:16:53 INFO - Current package versions: 20:16:53 INFO - argparse == 1.2.1 20:16:53 INFO - blessings == 1.6 20:16:53 INFO - blobuploader == 1.2.4 20:16:53 INFO - docopt == 0.6.1 20:16:53 INFO - manifestparser == 1.1 20:16:53 INFO - mozInstall == 1.12 20:16:53 INFO - mozcrash == 0.17 20:16:53 INFO - mozdebug == 0.1 20:16:53 INFO - mozdevice == 0.48 20:16:53 INFO - mozfile == 1.2 20:16:53 INFO - mozhttpd == 0.7 20:16:53 INFO - mozinfo == 0.9 20:16:53 INFO - mozleak == 0.1 20:16:53 INFO - mozlog == 3.2 20:16:53 INFO - moznetwork == 0.27 20:16:53 INFO - mozprocess == 0.22 20:16:53 INFO - mozprofile == 0.28 20:16:53 INFO - mozrunner == 6.11 20:16:53 INFO - mozscreenshot == 0.1 20:16:53 INFO - mozsystemmonitor == 0.3 20:16:53 INFO - moztest == 0.7 20:16:53 INFO - mozversion == 1.4 20:16:53 INFO - psutil == 3.1.1 20:16:53 INFO - requests == 1.2.3 20:16:53 INFO - wsgiref == 0.1.2 20:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:53 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:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:53 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:16:53 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:16:53 INFO - Using env: {'DISPLAY': ':0', 20:16:53 INFO - 'HOME': '/home/cltbld', 20:16:53 INFO - 'LANG': 'en_US.UTF-8', 20:16:53 INFO - 'LANGUAGE': 'en_US:en', 20:16:53 INFO - 'LOGNAME': 'cltbld', 20:16:53 INFO - 'MAIL': '/var/mail/cltbld', 20:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:53 INFO - 'MOZ_NO_REMOTE': '1', 20:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:53 INFO - 'NO_EM_RESTART': '1', 20:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:53 INFO - 'PWD': '/builds/slave/test', 20:16:53 INFO - 'SHELL': '/bin/bash', 20:16:53 INFO - 'SHLVL': '1', 20:16:53 INFO - 'TERM': 'linux', 20:16:53 INFO - 'TMOUT': '86400', 20:16:53 INFO - 'USER': 'cltbld', 20:16:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:53 INFO - '_': '/tools/buildbot/bin/python'} 20:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 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:16:53 INFO - Cleaning up... 20:16:53 INFO - Return code: 0 20:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:53 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:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:53 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:53 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:16:53 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:16:53 INFO - Using env: {'DISPLAY': ':0', 20:16:53 INFO - 'HOME': '/home/cltbld', 20:16:53 INFO - 'LANG': 'en_US.UTF-8', 20:16:53 INFO - 'LANGUAGE': 'en_US:en', 20:16:53 INFO - 'LOGNAME': 'cltbld', 20:16:53 INFO - 'MAIL': '/var/mail/cltbld', 20:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:53 INFO - 'MOZ_NO_REMOTE': '1', 20:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:53 INFO - 'NO_EM_RESTART': '1', 20:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:53 INFO - 'PWD': '/builds/slave/test', 20:16:53 INFO - 'SHELL': '/bin/bash', 20:16:53 INFO - 'SHLVL': '1', 20:16:53 INFO - 'TERM': 'linux', 20:16:53 INFO - 'TMOUT': '86400', 20:16:53 INFO - 'USER': 'cltbld', 20:16:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:53 INFO - '_': '/tools/buildbot/bin/python'} 20:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:54 INFO - Downloading/unpacking jsonschema 20:16: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:16: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:16: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:16: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:16: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:16: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:16:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:55 INFO - Downloading/unpacking functools32 (from jsonschema) 20:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:56 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:56 INFO - warning: no files found matching '*.txt' 20:16:56 INFO - no previously-included directories found matching 'build' 20:16:56 INFO - no previously-included directories found matching 'dist' 20:16:56 INFO - no previously-included directories found matching '.git*' 20:16:56 INFO - Installing collected packages: jsonschema, functools32 20:16:56 INFO - Running setup.py install for functools32 20:16:56 INFO - warning: no files found matching '*.txt' 20:16:56 INFO - no previously-included directories found matching 'build' 20:16:56 INFO - no previously-included directories found matching 'dist' 20:16:56 INFO - no previously-included directories found matching '.git*' 20:16:56 INFO - Successfully installed jsonschema functools32 20:16:56 INFO - Cleaning up... 20:16:56 INFO - Return code: 0 20:16:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:16:56 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:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:56 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:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:56 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 0x7f1f86eb5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, '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': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', '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:16:56 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:16:56 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:16:56 INFO - Using env: {'DISPLAY': ':0', 20:16:56 INFO - 'HOME': '/home/cltbld', 20:16:56 INFO - 'LANG': 'en_US.UTF-8', 20:16:56 INFO - 'LANGUAGE': 'en_US:en', 20:16:56 INFO - 'LOGNAME': 'cltbld', 20:16:56 INFO - 'MAIL': '/var/mail/cltbld', 20:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:56 INFO - 'MOZ_NO_REMOTE': '1', 20:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:56 INFO - 'NO_EM_RESTART': '1', 20:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:56 INFO - 'PWD': '/builds/slave/test', 20:16:56 INFO - 'SHELL': '/bin/bash', 20:16:56 INFO - 'SHLVL': '1', 20:16:56 INFO - 'TERM': 'linux', 20:16:56 INFO - 'TMOUT': '86400', 20:16:56 INFO - 'USER': 'cltbld', 20:16:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:56 INFO - '_': '/tools/buildbot/bin/python'} 20:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:56 INFO - Downloading/unpacking flake8 20:16: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:16: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:16: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:16: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:16: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:16: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:16:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:16:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:16:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:58 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:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:59 INFO - no previously-included directories found matching 'docs/_build' 20:16:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:16:59 INFO - Running setup.py install for pep8 20:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:16:59 INFO - no previously-included directories found matching 'docs/_build' 20:16:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:16:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:16:59 INFO - Cleaning up... 20:16:59 INFO - Return code: 0 20:16:59 INFO - Running post-action listener: _resource_record_post_action 20:16:59 INFO - Running post-action listener: _start_resource_monitoring 20:16:59 INFO - Starting resource monitoring. 20:16:59 INFO - ##### 20:16:59 INFO - ##### Finished create-virtualenv step (success) 20:16:59 INFO - ##### 20:16:59 INFO - ##### 20:16:59 INFO - ##### Running install step. 20:16:59 INFO - ##### 20:16:59 INFO - Running pre-action listener: _resource_record_pre_action 20:16:59 INFO - Running main action method: install 20:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:59 INFO - Reading from file tmpfile_stdout 20:16:59 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:59 INFO - Reading from file tmpfile_stdout 20:16:59 INFO - Output received: 20:16:59 INFO - Usage: mozinstall [options] installer 20:16:59 INFO - Options: 20:16:59 INFO - -h, --help show this help message and exit 20:16:59 INFO - -d DEST, --destination=DEST 20:16:59 INFO - Directory to install application into. [default: 20:16:59 INFO - "/builds/slave/test"] 20:16:59 INFO - --app=APP Application being installed. [default: firefox] 20:16:59 INFO - mkdir: /builds/slave/test/build/application 20:16:59 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:16:59 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:17:16 INFO - Reading from file tmpfile_stdout 20:17:16 INFO - Output received: 20:17:16 INFO - /builds/slave/test/build/application/firefox/firefox 20:17:16 INFO - Running post-action listener: _resource_record_post_action 20:17:16 INFO - ##### 20:17:16 INFO - ##### Finished install step (success) 20:17:16 INFO - ##### 20:17:16 INFO - ##### 20:17:16 INFO - ##### Running run-tests step. 20:17:16 INFO - ##### 20:17:16 INFO - Running pre-action listener: _resource_record_pre_action 20:17:16 INFO - Running main action method: run_tests 20:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:16 INFO - Python 2.7.3 20:17:16 INFO - Return code: 0 20:17:16 INFO - grabbing minidump binary from tooltool 20:17:16 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:17:16 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 0x149e9c0>, '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 0x149f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:16 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:17:16 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:17:16 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:17:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:16 INFO - Return code: 0 20:17:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:17:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:17:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:17:17 INFO - Return code: 0 20:17:17 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-056', '--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:17:17 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-056 --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:17:17 INFO - Using env: {'DISPLAY': ':0', 20:17:17 INFO - 'HOME': '/home/cltbld', 20:17:17 INFO - 'LANG': 'en_US.UTF-8', 20:17:17 INFO - 'LANGUAGE': 'en_US:en', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MAIL': '/var/mail/cltbld', 20:17:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SHLVL': '1', 20:17:17 INFO - 'TERM': 'linux', 20:17:17 INFO - 'TMOUT': '86400', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - '_': '/tools/buildbot/bin/python'} 20:17:17 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-056', '--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:17:17 INFO - mozversion application_buildid: 20160516173016 20:17:17 INFO - mozversion application_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:17:17 INFO - mozversion application_display_name: Nightly 20:17:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:17 INFO - mozversion application_name: Firefox 20:17:17 INFO - mozversion application_remotingname: firefox 20:17:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:17:17 INFO - mozversion application_vendor: Mozilla 20:17:17 INFO - mozversion application_version: 49.0a1 20:17:17 INFO - mozversion platform_buildid: 20160516173016 20:17:17 INFO - mozversion platform_changeset: cf83a5943afc01c163b8fbe438e332a31f08701a 20:17:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:17:17 INFO - mozversion platform_version: 49.0a1 20:17:17 INFO - using testdate: 1463455037 20:17:17 INFO - actual date: 1463455037 20:17:17 INFO - starting webserver on 'localhost:34374' 20:17:17 INFO - SUITE-START | Running 2 tests 20:17:17 INFO - TEST-START | dromaeo_css 20:17:17 INFO - operating with platform_type : linux_ 20:17:17 INFO - Initialising browser for dromaeo_css test... 20:17:17 INFO - TEST-INFO | started process 7620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxku1td/profile http://localhost:34374/getInfo.html) 20:17:21 INFO - PROCESS | 7620 | 20:17:21 INFO - PROCESS | 7620 | (process:7689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:22 INFO - PROCESS | 7620 | __metrics Screen width/height:1600/1200 20:17:22 INFO - PROCESS | 7620 | colorDepth:24 20:17:22 INFO - PROCESS | 7620 | Browser inner width/height: 1024/697 20:17:22 INFO - PROCESS | 7620 | __metrics 20:17:23 ERROR - PROCESS | 7620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:17:23 INFO - TEST-INFO | 7620: exit 0 20:17:23 INFO - Browser initialized. 20:17:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:23 INFO - TEST-INFO | started process 7740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxku1td/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:25 INFO - PROCESS | 7740 | 20:17:25 INFO - PROCESS | 7740 | (process:7803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:35 INFO - PROCESS | 7740 | RSS: Main: 163287040 20:17:35 INFO - PROCESS | 7740 | 20:18:25 INFO - PROCESS | 7740 | 1463455105381 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:20:33 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34374/tests/dromaeo/cssquery-ext.html) 20:20:34 INFO - PROCESS | 7740 | RSS: Main: 166842368 20:20:34 INFO - PROCESS | 7740 | 20:23:36 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-ext.html (next: http://localhost:34374/tests/dromaeo/cssquery-jquery.html) 20:23:37 INFO - PROCESS | 7740 | RSS: Main: 166354944 20:23:37 INFO - PROCESS | 7740 | 20:26:39 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34374/tests/dromaeo/cssquery-mootools.html) 20:26:39 INFO - PROCESS | 7740 | RSS: Main: 167403520 20:26:39 INFO - PROCESS | 7740 | 20:29:41 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34374/tests/dromaeo/cssquery-prototype.html) 20:29:42 INFO - PROCESS | 7740 | RSS: Main: 164892672 20:29:42 INFO - PROCESS | 7740 | 20:32:44 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34374/tests/dromaeo/cssquery-yui.html) 20:32:45 INFO - PROCESS | 7740 | RSS: Main: 165855232 20:32:45 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | Cycle 1(1): loaded http://localhost:34374/tests/dromaeo/cssquery-yui.html (next: http://localhost:34374/tests/dromaeo/cssquery-dojo.html) 20:35:47 INFO - PROCESS | 7740 | RSS: Main: 168210432 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | __start_tp_report 20:35:47 INFO - PROCESS | 7740 | _x_x_mozilla_page_load 20:35:47 INFO - PROCESS | 7740 | _x_x_mozilla_page_load_details 20:35:47 INFO - PROCESS | 7740 | |i|pagename|runs| 20:35:47 INFO - PROCESS | 7740 | |0;dojo.html;3131.966451071147;3177.2692280775404;3188.05952244088;3218.4367735646256;3221.0980925340914;5396.460353964601;5446.836594902149;5467.097928841741;5474.890502189954;5482.506574408302;5276.7889284428575;5301.204819277111;5322.467753224676;5340.732963351837;5374.865628359293;4850.902981940368;4877.756112194394;4924.778384972667;5009.724465154415;5057.468965758598;4864.100141473821;4968;5121.641485096045;5123.026624941268;5155.9484405155845;4880.1947678632805;4911.975440122812;4965.131102057126;4980.228064649985;4992.126377883874;4943.1596628573225;4969.0807200668;4976.651634385595;4988.326575912278;5015.523525265094;4931.7040977541465;4937.654364194508;4951.232558953368;4978.701277923336;5002.2246551784165;5120.334356533664;5199.6360254782185;5247.895042099175;5277.208418737182;5349.839504814861;5691.7723291068305;5738.569607279471;5742.28221472316;5761.222234998263;5774.797882074149;5704.600677952545;5798.217240672498;5811.157382179603;5819.563532735019;5839.591228613998;5365.03429382711;5399.217113518557;5442.102053161224;5452;5470.343558772933;5895.970520147372;5953.3451320354725;5963.105534169909;5965.075413310944;5969.791057312973;5491.36849262332;5659.886802263932;5708.343540492897;5713.971430142823;5719.056355701263;5645.181448689917;5663.971680141655;5704.11586204139;5733.197352370671;5740.368559458456;5582.86042848932;5598.1322894951345;5603.635763675348;5806.680632565165;5843.328017277982;5717.742701578439;5789.102689083199;5838.12428135783;5848.883022339614;5886.293644762656;4264.381664658607;4354.586314300136;4355.5208927018;4398.856297362709;4422.601965823092;3917.314469967744;3960.7029472789654;3961.148353104039;3976.562578116405;4004.3192657248337;5357.571394288448;5501.862453438696;5538.556915446755;5563.443655634485;5572.693501857437;5810.6513609183585;5858.648481091148;5861.765529378862;5874.206982057453;5908.261467316585;5540.529055030287;5552.583556233299;5565.916511252334;5567.832965011056;5583.078791999355;4729.574338309569;4795.6163506919365;4861.270809378621;4886.926696099561;4931.334269873593;5947.405259474104;5982.551308651781;5988.281406231193;6000.60996035265;6034.969825150846;5763.999999999916;5793.91309130355;5809.331926828469;5819.621724587888;5820.126980952891;5793.565482588739;5970.9701451492465;5993.670348130895;6004.819855404345;6018.428249316308;5723.656580605177;5730.885382292414;5734;5746.367899530965;5781.421857814353;5785.971070144622;5787.56593255516;5813.3895940925595;5831.1836342912875;5860;5397.541208997279;5608.130739735348;5627.88744225105;5648.802291919763;5689.943100569107;5534.944650553604;5621.747021383966;5627.240322556402;5691.943080569141;5714.542836572981;5433.076377015837;5433.940381625545;5485.957668043059;5505.889882202414;5568.832935011957;5648.830535083954;5701.059325211294;5715.971420142872;5716.942830571641;5734.111212762028;5383.515483606494;5408.918216356666;5450.700211488248;5459.781608735606;5499.972500137474 20:35:47 INFO - PROCESS | 7740 | |1;ext.html;598.1028457314029;647.5920170292715;648.9026646003099;664.3058004385417;666.819958611175;39169.216615667705;42823.35764963528;42910.57089429105;42965;42976.140477190515;38597.80701096498;38714.41928371077;38794.8060259699;38901.610983890154;38982.8050859746;8651.480911145336;8835.734927952171;8854.645814167425;8860.8670869937;8883.555822208897;8667.263282620985;8678.826423471526;8728.170823771763;8743.737687869374;8754.956225218864;8767.605457754416;8815.426997245191;8825.867611985825;8840.204381605654;8848.955755221215;8672.60973256205;8692.174243446863;8778.736637900873;8797.29621630268;8811.95594022029;8619.6983105591;8626.482411055356;8637.093105223923;8656.480611163288;8736.432131911406;34870.30259394823;35488.645113548795;35661.46507802359;35794.64205357939;35813;3754.6433088856515;4101.374921003016;4136.462259906223;4182.519010313822;4255.212785634668;32372.676273237437;32774.34451310984;32774.852880149316;33032.50451243233;33269.83365083183;4207.91584168318;4225.556316586775;4230.111676547928;4235.49174099107;4320.481542214923;327541;327863;328103;328847;332141.3392933044;35440;56639.71680141573;57106.428935710945;57181;57236;36358;37944.24111517809;37984.62015379866;38054;38063.42904856429;16003.359865605245;16170.353185872433;16192.433264835674;16212.189390530426;16233;12172.634820955385;12242.510299587917;12248.387580620933;12256.387180640932;12317.50729970809;8655.350848686374;8692.174243446863;8694.956525217334;8744.300455963508;8773.780655483537;3316.35331110436;3328.334333133383;3336.4828451590042;3361.61341445732;3384.6784555467684;1100.2793170473353;1103.564092183583;1109.8168802147716;1191.7616476704693;1218.8963938065187;28659.28351791222;29219;29485.85257073701;29611.851940740158;29662;1120.8710998235144;1217.6347095871204;1281.9102662813514;1317.1438564932678;1325.204877073748;15173.317200725995;15262;15539.611509712347;15584.610384740245;16159.272832722556;503238;506151;506647;506901;510039;59458.70270648619;59505.40494595085;59668.70165649144;59862.40137598568;59908.70045649831;1378.531299358203;1404.662880908595;1413.886889048894;1420.7158568286384;1429.9571012869424;29829.403411932075;29960.700392996663;30206.84896575591;30546.694533055273;31234.03276688711;51425.7428712854;51709.482905170466;51792.482075180276;51941.22088168605;52145.478545214064;412549;415915;417396;417605;418650;28252.43495130045;28334.85832570824;28655.42689146247;28860.278493037003;28903.5664465029;47616.52383476259;47650.285245720646;47810.28284575804;47978.28032579444;48330;40048.39927401033;40808.38787418132;41547.7922610385;41730;41760;40096.39855402113;40383;40588;40915;41670;40691.59308406878;41268.79365603153;41466.37800432936;41650.58349416588;41817;30854;33904.83047584746;34404.655953440146;34430.48354274638;34872.47691284582;28789.284182600466;29139.834406623497;29303.413931721672;29316.7068329314;29482.852585737794 20:35:47 INFO - PROCESS | 7740 | |2;jquery.html;415.7734034950951;420.76437195170706;421.51736261980034;425.17516018923277;431.24747315933683;17571.56071098223;18904.338348157817;19000.809991900078;19004.239830406783;19955.301564445246;16929.322827086933;17044.147792610383;19517.316893908715;19519.414417567496;19612.215511379527;5156.896862062757;5166.61250406221;5354.116570765819;5360.517553420192;5397.541208997221;5275.788968441258;5278.076336641092;5313.548348390392;5328.227407025979;5349.331333583302;5300.575953923696;5356.517913387795;5656.321241451032;5663.0655941769555;5747.080467125261;5518.475744804257;5659.60382773206;5710.514606258473;5886.028805247129;5897.4102589741115;5694.658320500742;5705.54355651551;5720.370759216483;5720.742566584514;5747.3103227612955;13803.723925521534;14115;23032.51291400796;23308.417289567726;23495;2291.5875142474347;2296.196331284054;2377.5126099149634;2410.5781488239663;2414.0464516515876;10416.375017498898;10448.373097614092;10486.056254937092;10552.103071238955;10615.52230149645;1906.65680177568;1927.951801204967;1936.4674714453497;1963.077353643785;2049.108637742587;76669;78094.82857757196;79487.60256198682;80968;81179.18820811775;10835.620753273597;11177.832332514856;11323.660290191307;11515.53937842477;11530.039893218172;16238.594035148979;16388;16389.180540972902;16413.42553010663;16444.260008299654;8434.915650843535;8556;8602.440841345293;8604.784880377916;8810.295176385875;8281;8295.62669679866;8303.418760686814;8454.704085356983;8512.659493620185;4792.736399497991;4867.1969125093965;4986.426560945465;5025.673331233458;5036.496350365008;2040.7245021921851;2063.164418410546;2075.8546901716736;2081.573277478113;2151.451379898116;936.5551363102608;1016.5273147986074;1036.8341065429495;1037.870266216723;1133.5522468624847;18686.813131868777;19060.80939190618;19449.90275048616;19693.621446498608;19826.1078251479;1037.2739082642029;1054.4516851237313;1073.983890241647;1079.8704155501391;1094.3324572011068;10563.577456901792;11011.339319640847;11124.165687573464;11126.61056863006;11148.777024459465;458218;464897;475094;504814.475927618;506409;88507.55746221228;91568;92751.53624231835;93011.0698893016;93715.53142234382;1052.3633201912885;1064.3560645809173;1101.427257825942;1128.9040431563244;1130.9151813614012;17177.914110429367;17229.655406891543;17356.566085847953;17492;17596.73604895953;40055.799721002375;42758.93102672334;42887.78556107199;42954.140917180855;45584.77207613941;53778;54012.729936350064;55731.72134139465;58328.416715832296;61551.384486154566;6828.760993365208;9750.561224744763;12429.75140497203;13191.538296159588;13691;8905.62606254694;14182.290885455892;14728.705425891209;14902.478413255483;14958.177300248592;12628;13152.408141633841;13211.735765284448;13253.271070091238;13325.267110309027;7253.854922901618;10958.726031849268;12726.490940362282;12849.678758031125;13343.466261349437;12880.742385152056;13288.269145197108;13488;13505.594832155051;13901.860981390057;13633.795493067413;13651.863481365059;13664.65838354049;13683.726325473634;13715.862841371458;13158.342082895626;13378.93310533441;13402.195868247936;13491.595252142451;13569.253691046692 20:35:47 INFO - PROCESS | 7740 | |3;mootools.html;1551.464744663091;1567.4357231396696;1783.3579911231955;1862.7299041638955;1896.8672192946499;8435.24082832545;9027.774305642362;9031.954840225799;9637.518124093793;9670.274729395298;9106.590203440845;9426.151646351827;9485.430874147556;9487.098725621056;9497.572609232584;2354.5526349993534;2376.251480783548;2381.5832229359794;2382.059086660768;2397.9280621581293;2346.650675861378;2366.7633236676365;2368.52629474105;2395.0419832067137;2406.169871394366;2368;2368.2303251443263;2380.3097101840444;2387.212219967407;2406.254061241012;2217.1131547381015;2234.4190510467315;2238.183063181927;2260.7852254035924;2271.250487339182;2317.73346065203;2331.25399872041;2336.4742932839977;2347.084636991575;2369.822263330257;9160.267178625694;9306.627734890664;9333.253339732873;9366.20387267083;9377.437353758796;5053.873653158664;5263.31576895005;5310.150375939831;5324.307839980777;5345.224942383372;3334.533165356828;3371.2751758371824;3388.4747864081105;3407.6081250656243;3422.3326451342;1080.7244152741;1095.4413249242864;1101.983470247947;1102.73534351755;1108.833674948756;13413.731725365536;13420.463181472729;13454.798178027337;13510.459581616822;13544.322783860767;4637.443506779208;4654.441467023911;4740.620750339965;4775.904481910342;4860.586850117779;10823;10853.077488413415;10864.511097000654;10869.891301087046;10871.075958543612;5448.42791506894;5477.7261136943;5488.067028605146;5491.505764481136;5493.258410114663;4357.172137293904;4815.109204797123;4883.853484395403;4902.803887844446;5068.6451948363265;4093.4018213851223;4103.630673239363;4113.938290925638;4156.43888075112;4172.624463798273;1303.4069498378215;1329.7872340425486;1343.596920923719;1354.5800801751489;1360.7414591227634;852.7612268564811;965.0446058402131;966.6036924860773;1015.441507171053;1021.5096753558333;6053.303870054912;6062.818115456544;6137.9079313810325;6155.784547540815;6202.627842329474;421.7869975662271;428.7213311347649;428.83143434141715;430.38025243649673;437.656439694838;4116.4648595682365;4167.562405947392;4182.560831112689;4217.7891105444605;4299.634531064895;11174.888251117385;11306.773864522664;11496.712582185344;11544.249623774427;11547.133964952662;11138.220324577363;11266.211365204357;11268.09855211581;11377.37424441647;11382.487788049391;8225.506469611842;8414.495130292202;8425.357055374143;8470.364722645827;8482.61828217744;5860.765569377178;6035.698215089315;6139.84650383744;6147.66187859672;6254.718537665907;10639;10670.83993740079;10787.137029037815;10850.891491084989;10897.782044359226;10318.380897146195;10696.62561810333;10706.89293107059;11123.054540363835;11185.608503702331;8909;8992.86510702353;9166.17504424605;9173.35786494939;9180.127887850644;9036.412633178823;9099.408538444979;9146.405483643543;9149.5882685278;9194.49430281341;8268.173182681683;8268.37987150954;8268.462549934235;8282.378821588285;8364.581770911553;7955.960220198862;7992.5204487730925;8039;8141.552214628252;8143.574874396838;7117.822054448473;7120.394766444703;7133.53762478701;7146.178189508273;7183.820404489929;5180.766865490987;5239.24031015493;5273.7363131842485;5415.4313797050745;5461;5206.713630750345;5235.738213089407;5260.684358938476;5297.894042119059;5335.67985920846 20:35:47 INFO - PROCESS | 7740 | |4;prototype.html;318.1505380633706;325.6987286759748;328.26141182339734;329.2673800793235;329.5633285896187;5609.320403596251;5633.774649014034;5661.8584535386635;5675.375708672048;5724.370319264877;5562.803997140614;5595.580331475146;5607.243022192003;5611.7474713637885;5625.537360286325;4328.805203765823;4346.630536404409;4367.781610919457;4369.759663218521;4382.452193475816;4143.482064741907;4389.231884420214;4389.231884420214;4399.406080179183;4408.515063343029;4294.959894050332;4306.224879521685;4310.633596144332;4323.524412314643;4342.435483387171;4347.739135651871;4349.630281426083;4351.477822661285;4362.956370436286;4376;3744;3785;3834.3673293906472;3841.1741475582885;3848.5574158971795;5422.891542169174;5425.267588875491;5432.456754324576;5456.181572764078;5461.453854614547;4978.502149785028;4992.051510213084;5016.774245158977;5021.924671129936;5057.140286151326;5735.4551317624755;5829.912551311733;5831.300243970708;5842.685395785914;5972.552058595623;4152.5432202457705;4159.459270294872;4179.2895207814745;4191.497020357577;4203.07532342884;5762.308522977228;5975.551833612496;6066.939330606681;6089.421504957022;6130.957737184689;4234.0896707207485;4235.661147108224;4246.957530424656;4254.127903779718;4256.659467242614;4300.849470268526;4303.849365272263;4327.37253098299;4331.761753103609;4343.522212556616;4882.389701287339;4925.876853078702;4945.653804233669;4952.47998960104;4955.306257124005;5865.706714664249;5868.501177399883;5898.616589921641;5910;5918.585699001029;1437.4681367893736;1462.2688655672164;1476.8554370363054;1476.9556913292404;1479.7422191137448;909.4361495872602;932.860070989357;941.3739862991034;943.7216021273604;959.8992105828927;4943.678660887031;5015.673981191211;5028.522290382408;5051.924221136685;5083.7203953782155;5295.629305948623;5318.016167009116;5377.946220537745;5387.218853266333;5421.241026256327;4876.634252431082;4943;4975.850724478271;5020.949790502122;5107.8723031923755;2834.957475637867;2887.740103390705;2898.6086878271162;2915.5918171456015;2931.3844092740337;5635.408282130399;5643.5767317451355;5683.26117604717;5708.828735137952;5718.799052199001;5335.412325022361;5407.351117865881;5435;5497.972510137423;5585.218069470277;5609.158626206102;5663.971680141655;5673.858153546194;5686.402927692616;5701.344345400249;5271.65734227274;5358.678479291255;5459.590530710292;5484.8354549363585;5707.486326230493;6001.879962400641;6046.848828779316;6059.424549617043;6063.242094738158;6073;6225.723726635938;6320.293520749464;6359.777407790705;6368.649724265025;6391.744330226739;4385.583369579885;4437;4448.977755111204;4464.843730469418;4478.484974228006;5994.970025149846;6037.683056614542;6119.418655227746;6151.846203844761;6226.034964580497;5938.346781853907;5940.851478713067;5941.970290148522;5965.433283838029;5979.581429300081;5914.467697907209;5936.28764548257;5944.494717949023;5961.821145365646;6046.334903160561;5495.203195536705;5833.941660583339;5839.970800145972;5841.824745257649;5865.149553314831;5915.822525324247;6011.519078473624;6027.758889644365;6028.457438830526;6035.9094613579955;5678.403767604342;5778.017736984639;5817.272840894888;5900.852478688067;5903.881922361443 20:35:47 INFO - PROCESS | 7740 | |5;yui.html;817.3747083481138;831.7962099285676;851.6593362654937;853.4239388412819;889.3552174673358;14592.051516651423;15548.378064877406;15776.684466310668;15833;15876.841231587681;11201.66395008149;14644.26778661068;14707.11757294563;14716.632084197874;14732;820.5404973215019;854.786303424144;857.0615176381851;859.9355048371366;860.2257967828941;826.0912995704707;833.5748768128268;838.4466252273501;840.5923127283294;841.4951029382382;875.3041332140931;875.9605817738217;876.9342299327576;877.5831480046959;879.617366445595;863.5552690364467;870.5560164316181;871.7951281448854;872.7120050383359;873.9563021848882;639.0510092512615;639.4149353341687;639.6194264412667;640.2029473305764;641.3137942401632;14373.712525749426;14373.78439323411;14394.280285985658;14416.062955907832;14437.06159099655;13644.590662280147;13656.453741850413;13940.442382304696;14159.079659822079;14245.928770356082;11897.583584574584;12190.146689731722;12243.08176886737;12318.445669944784;12390.938045309806;3901.7854018028997;3916.980415097935;3928.2339943710986;3931.6264954829244;4003.9399409008597;60387.69806150985;60676.39323606752;61447;61593;62204.68897655528;11176.66470005885;11213.719657008476;11236.494357753922;11623.12826538013;11736.76526469483;19905.303314383927;19912.402627921187;20001.899990499955;20062.398128056182;20127.899360503103;8514.659413623385;8708.390412671051;8720;9079.68221112258;9111.316651251183;4969.155243608595;4985.675931064469;5028.270900719448;5084.3898732152375;5212.713300768418;3309.652486488932;3429.4684323929832;3431;3432.708219801345;3443.776154549946;669.270495160268;669.521292276025;674.430106559956;680.3332733920687;681.2336121862904;710.9680064397114;728.2426276672202;729.6169511006764;729.8476022824951;759.7530802489213;9943.204543636492;10128.746781330377;10180.796384072277;10249.231307651957;10359.741006474898;745.4401268834237;766.6246259613808;767.6046835879526;774.9961250193826;780.8750599903988;4724.173269677793;4730.124926888537;4927.137750893579;4937.185364414903;4959.355283813081;69696.30303696898;70401;70440;70822.2917770826;71546;63831.36168638347;64007.67996160083;64123.67938160279;64690.35309646937;66089.33910660927;56376.43623563712;56589.434105658416;57233.42766572281;57417.712911436014;58168.4183158163;9197.908020919705;9719.222462203148;9936.489751189318;10060.798784024424;10197.643082492077;36485.635143649284;36711.08222294464;36722.63277367192;36778.26443471062;37082.25772692397;48449.757751212426;48907.26639100487;49143.26285105655;49451.752741236065;50100;12660.974244120896;12723.23660580368;12859.871401285867;12870.292133932724;12929.159604625669;14193.432262709788;14353.64115897111;14357.497487587885;14671.559853203995;15085.396584136512;13904.443822247402;13943.860561394256;14191.503297384543;14281.357338919566;14884.181370024753;14079.507217247346;14813.407463701331;14943.252837357872;14965.625859353604;15091.698166036398;12650;12873.291968941423;13335;13384.330783460593;13401.597952061064;10748.838767418338;11031.827950555386;11084.667459975892;11192.888071119185;11535.884641153816;10563.577456901945;10922.124341286628;10980.286281392004;10983.231173817756;11014.284071535325 20:35:47 INFO - PROCESS | 7740 | __end_tp_report 20:35:47 INFO - PROCESS | 7740 | __start_cc_report 20:35:47 INFO - PROCESS | 7740 | _x_x_mozilla_cycle_collect,337 20:35:47 INFO - PROCESS | 7740 | __end_cc_report 20:35:47 INFO - PROCESS | 7740 | __startTimestamp1463456147769__endTimestamp 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | ------- Summary: start ------- 20:35:47 INFO - PROCESS | 7740 | Number of tests: 6 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#0] dojo.html Cycles:165 Average:5367.09 Median:5563.44 stddev:602.63 (10.8%) stddev-sans-first:578.40 20:35:47 INFO - PROCESS | 7740 | Values: 3132.0 3177.3 3188.1 3218.4 3221.1 5396.5 5446.8 5467.1 5474.9 5482.5 5276.8 5301.2 5322.5 5340.7 5374.9 4850.9 4877.8 4924.8 5009.7 5057.5 4864.1 4968.0 5121.6 5123.0 5155.9 4880.2 4912.0 4965.1 4980.2 4992.1 4943.2 4969.1 4976.7 4988.3 5015.5 4931.7 4937.7 4951.2 4978.7 5002.2 5120.3 5199.6 5247.9 5277.2 5349.8 5691.8 5738.6 5742.3 5761.2 5774.8 5704.6 5798.2 5811.2 5819.6 5839.6 5365.0 5399.2 5442.1 5452.0 5470.3 5896.0 5953.3 5963.1 5965.1 5969.8 5491.4 5659.9 5708.3 5714.0 5719.1 5645.2 5664.0 5704.1 5733.2 5740.4 5582.9 5598.1 5603.6 5806.7 5843.3 5717.7 5789.1 5838.1 5848.9 5886.3 4264.4 4354.6 4355.5 4398.9 4422.6 3917.3 3960.7 3961.1 3976.6 4004.3 5357.6 5501.9 5538.6 5563.4 5572.7 5810.7 5858.6 5861.8 5874.2 5908.3 5540.5 5552.6 5565.9 5567.8 5583.1 4729.6 4795.6 4861.3 4886.9 4931.3 5947.4 5982.6 5988.3 6000.6 6035.0 5764.0 5793.9 5809.3 5819.6 5820.1 5793.6 5971.0 5993.7 6004.8 6018.4 5723.7 5730.9 5734.0 5746.4 5781.4 5786.0 5787.6 5813.4 5831.2 5860.0 5397.5 5608.1 5627.9 5648.8 5689.9 5534.9 5621.7 5627.2 5691.9 5714.5 5433.1 5433.9 5486.0 5505.9 5568.8 5648.8 5701.1 5716.0 5716.9 5734.1 5383.5 5408.9 5450.7 5459.8 5500.0 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#1] ext.html Cycles:180 Average:56612.22 Median:40485.50 stddev:112378.52 (277.6%) stddev-sans-first:112615.08 20:35:47 INFO - PROCESS | 7740 | Values: 598.1 647.6 648.9 664.3 666.8 39169.2 42823.4 42910.6 42965.0 42976.1 38597.8 38714.4 38794.8 38901.6 38982.8 8651.5 8835.7 8854.6 8860.9 8883.6 8667.3 8678.8 8728.2 8743.7 8755.0 8767.6 8815.4 8825.9 8840.2 8849.0 8672.6 8692.2 8778.7 8797.3 8812.0 8619.7 8626.5 8637.1 8656.5 8736.4 34870.3 35488.6 35661.5 35794.6 35813.0 3754.6 4101.4 4136.5 4182.5 4255.2 32372.7 32774.3 32774.9 33032.5 33269.8 4207.9 4225.6 4230.1 4235.5 4320.5 327541.0 327863.0 328103.0 328847.0 332141.3 35440.0 56639.7 57106.4 57181.0 57236.0 36358.0 37944.2 37984.6 38054.0 38063.4 16003.4 16170.4 16192.4 16212.2 16233.0 12172.6 12242.5 12248.4 12256.4 12317.5 8655.4 8692.2 8695.0 8744.3 8773.8 3316.4 3328.3 3336.5 3361.6 3384.7 1100.3 1103.6 1109.8 1191.8 1218.9 28659.3 29219.0 29485.9 29611.9 29662.0 1120.9 1217.6 1281.9 1317.1 1325.2 15173.3 15262.0 15539.6 15584.6 16159.3 503238.0 506151.0 506647.0 506901.0 510039.0 59458.7 59505.4 59668.7 59862.4 59908.7 1378.5 1404.7 1413.9 1420.7 1430.0 29829.4 29960.7 30206.8 30546.7 31234.0 51425.7 51709.5 51792.5 51941.2 52145.5 412549.0 415915.0 417396.0 417605.0 418650.0 28252.4 28334.9 28655.4 28860.3 28903.6 47616.5 47650.3 47810.3 47978.3 48330.0 40048.4 40808.4 41547.8 41730.0 41760.0 40096.4 40383.0 40588.0 40915.0 41670.0 40691.6 41268.8 41466.4 41650.6 41817.0 30854.0 33904.8 34404.7 34430.5 34872.5 28789.3 29139.8 29303.4 29316.7 29482.9 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#2] jquery.html Cycles:180 Average:29019.20 Median:10998.01 stddev:79457.46 (722.5%) stddev-sans-first:79651.33 20:35:47 INFO - PROCESS | 7740 | Values: 415.8 420.8 421.5 425.2 431.2 17571.6 18904.3 19000.8 19004.2 19955.3 16929.3 17044.1 19517.3 19519.4 19612.2 5156.9 5166.6 5354.1 5360.5 5397.5 5275.8 5278.1 5313.5 5328.2 5349.3 5300.6 5356.5 5656.3 5663.1 5747.1 5518.5 5659.6 5710.5 5886.0 5897.4 5694.7 5705.5 5720.4 5720.7 5747.3 13803.7 14115.0 23032.5 23308.4 23495.0 2291.6 2296.2 2377.5 2410.6 2414.0 10416.4 10448.4 10486.1 10552.1 10615.5 1906.7 1928.0 1936.5 1963.1 2049.1 76669.0 78094.8 79487.6 80968.0 81179.2 10835.6 11177.8 11323.7 11515.5 11530.0 16238.6 16388.0 16389.2 16413.4 16444.3 8434.9 8556.0 8602.4 8604.8 8810.3 8281.0 8295.6 8303.4 8454.7 8512.7 4792.7 4867.2 4986.4 5025.7 5036.5 2040.7 2063.2 2075.9 2081.6 2151.5 936.6 1016.5 1036.8 1037.9 1133.6 18686.8 19060.8 19449.9 19693.6 19826.1 1037.3 1054.5 1074.0 1079.9 1094.3 10563.6 11011.3 11124.2 11126.6 11148.8 458218.0 464897.0 475094.0 504814.5 506409.0 88507.6 91568.0 92751.5 93011.1 93715.5 1052.4 1064.4 1101.4 1128.9 1130.9 17177.9 17229.7 17356.6 17492.0 17596.7 40055.8 42758.9 42887.8 42954.1 45584.8 53778.0 54012.7 55731.7 58328.4 61551.4 6828.8 9750.6 12429.8 13191.5 13691.0 8905.6 14182.3 14728.7 14902.5 14958.2 12628.0 13152.4 13211.7 13253.3 13325.3 7253.9 10958.7 12726.5 12849.7 13343.5 12880.7 13288.3 13488.0 13505.6 13901.9 13633.8 13651.9 13664.7 13683.7 13715.9 13158.3 13378.9 13402.2 13491.6 13569.3 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#3] mootools.html Cycles:180 Average:6073.15 Median:2393.78 stddev:3572.18 (149.2%) stddev-sans-first:3566.04 20:35:47 INFO - PROCESS | 7740 | Values: 1551.5 1567.4 1783.4 1862.7 1896.9 8435.2 9027.8 9032.0 9637.5 9670.3 9106.6 9426.2 9485.4 9487.1 9497.6 2354.6 2376.3 2381.6 2382.1 2397.9 2346.7 2366.8 2368.5 2395.0 2406.2 2368.0 2368.2 2380.3 2387.2 2406.3 2217.1 2234.4 2238.2 2260.8 2271.3 2317.7 2331.3 2336.5 2347.1 2369.8 9160.3 9306.6 9333.3 9366.2 9377.4 5053.9 5263.3 5310.2 5324.3 5345.2 3334.5 3371.3 3388.5 3407.6 3422.3 1080.7 1095.4 1102.0 1102.7 1108.8 13413.7 13420.5 13454.8 13510.5 13544.3 4637.4 4654.4 4740.6 4775.9 4860.6 10823.0 10853.1 10864.5 10869.9 10871.1 5448.4 5477.7 5488.1 5491.5 5493.3 4357.2 4815.1 4883.9 4902.8 5068.6 4093.4 4103.6 4113.9 4156.4 4172.6 1303.4 1329.8 1343.6 1354.6 1360.7 852.8 965.0 966.6 1015.4 1021.5 6053.3 6062.8 6137.9 6155.8 6202.6 421.8 428.7 428.8 430.4 437.7 4116.5 4167.6 4182.6 4217.8 4299.6 11174.9 11306.8 11496.7 11544.2 11547.1 11138.2 11266.2 11268.1 11377.4 11382.5 8225.5 8414.5 8425.4 8470.4 8482.6 5860.8 6035.7 6139.8 6147.7 6254.7 10639.0 10670.8 10787.1 10850.9 10897.8 10318.4 10696.6 10706.9 11123.1 11185.6 8909.0 8992.9 9166.2 9173.4 9180.1 9036.4 9099.4 9146.4 9149.6 9194.5 8268.2 8268.4 8268.5 8282.4 8364.6 7956.0 7992.5 8039.0 8141.6 8143.6 7117.8 7120.4 7133.5 7146.2 7183.8 5180.8 5239.2 5273.7 5415.4 5461.0 5206.7 5235.7 5260.7 5297.9 5335.7 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#4] prototype.html Cycles:180 Average:4833.51 Median:5428.86 stddev:1425.19 (26.3%) stddev-sans-first:1388.30 20:35:47 INFO - PROCESS | 7740 | Values: 318.2 325.7 328.3 329.3 329.6 5609.3 5633.8 5661.9 5675.4 5724.4 5562.8 5595.6 5607.2 5611.7 5625.5 4328.8 4346.6 4367.8 4369.8 4382.5 4143.5 4389.2 4389.2 4399.4 4408.5 4295.0 4306.2 4310.6 4323.5 4342.4 4347.7 4349.6 4351.5 4363.0 4376.0 3744.0 3785.0 3834.4 3841.2 3848.6 5422.9 5425.3 5432.5 5456.2 5461.5 4978.5 4992.1 5016.8 5021.9 5057.1 5735.5 5829.9 5831.3 5842.7 5972.6 4152.5 4159.5 4179.3 4191.5 4203.1 5762.3 5975.6 6066.9 6089.4 6131.0 4234.1 4235.7 4247.0 4254.1 4256.7 4300.8 4303.8 4327.4 4331.8 4343.5 4882.4 4925.9 4945.7 4952.5 4955.3 5865.7 5868.5 5898.6 5910.0 5918.6 1437.5 1462.3 1476.9 1477.0 1479.7 909.4 932.9 941.4 943.7 959.9 4943.7 5015.7 5028.5 5051.9 5083.7 5295.6 5318.0 5377.9 5387.2 5421.2 4876.6 4943.0 4975.9 5020.9 5107.9 2835.0 2887.7 2898.6 2915.6 2931.4 5635.4 5643.6 5683.3 5708.8 5718.8 5335.4 5407.4 5435.0 5498.0 5585.2 5609.2 5664.0 5673.9 5686.4 5701.3 5271.7 5358.7 5459.6 5484.8 5707.5 6001.9 6046.8 6059.4 6063.2 6073.0 6225.7 6320.3 6359.8 6368.6 6391.7 4385.6 4437.0 4449.0 4464.8 4478.5 5995.0 6037.7 6119.4 6151.8 6226.0 5938.3 5940.9 5942.0 5965.4 5979.6 5914.5 5936.3 5944.5 5961.8 6046.3 5495.2 5833.9 5840.0 5841.8 5865.1 5915.8 6011.5 6027.8 6028.5 6035.9 5678.4 5778.0 5817.3 5900.9 5903.9 20:35:47 INFO - PROCESS | 7740 | 20:35:47 INFO - PROCESS | 7740 | [#5] yui.html Cycles:180 Average:16268.14 Median:4364.06 stddev:19423.95 (445.1%) stddev-sans-first:19443.78 20:35:47 INFO - PROCESS | 7740 | Values: 817.4 831.8 851.7 853.4 889.4 14592.1 15548.4 15776.7 15833.0 15876.8 11201.7 14644.3 14707.1 14716.6 14732.0 820.5 854.8 857.1 859.9 860.2 826.1 833.6 838.4 840.6 841.5 875.3 876.0 876.9 877.6 879.6 863.6 870.6 871.8 872.7 874.0 639.1 639.4 639.6 640.2 641.3 14373.7 14373.8 14394.3 14416.1 14437.1 13644.6 13656.5 13940.4 14159.1 14245.9 11897.6 12190.1 12243.1 12318.4 12390.9 3901.8 3917.0 3928.2 3931.6 4003.9 60387.7 60676.4 61447.0 61593.0 62204.7 11176.7 11213.7 11236.5 11623.1 11736.8 19905.3 19912.4 20001.9 20062.4 20127.9 8514.7 8708.4 8720.0 9079.7 9111.3 4969.2 4985.7 5028.3 5084.4 5212.7 3309.7 3429.5 3431.0 3432.7 3443.8 669.3 669.5 674.4 680.3 681.2 711.0 728.2 729.6 729.8 759.8 9943.2 10128.7 10180.8 10249.2 10359.7 745.4 766.6 767.6 775.0 780.9 4724.2 4730.1 4927.1 4937.2 4959.4 69696.3 70401.0 70440.0 70822.3 71546.0 63831.4 64007.7 64123.7 64690.4 66089.3 56376.4 56589.4 57233.4 57417.7 58168.4 9197.9 9719.2 9936.5 10060.8 10197.6 36485.6 36711.1 36722.6 36778.3 37082.3 48449.8 48907.3 49143.3 49451.8 50100.0 12661.0 12723.2 12859.9 12870.3 12929.2 14193.4 14353.6 14357.5 14671.6 15085.4 13904.4 13943.9 14191.5 14281.4 14884.2 14079.5 14813.4 14943.3 14965.6 15091.7 12650.0 12873.3 13335.0 13384.3 13401.6 10748.8 11031.8 11084.7 11192.9 11535.9 10563.6 10922.1 10980.3 10983.2 11014.3 20:35:47 INFO - PROCESS | 7740 | -------- Summary: end -------- 20:35:47 INFO - PROCESS | 7740 | 20:35:48 INFO - TEST-INFO | 7740: exit 0 20:35:48 INFO - TEST-OK | dromaeo_css | took 1110856ms 20:35:48 INFO - TEST-START | kraken 20:35:48 INFO - operating with platform_type : linux_ 20:35:48 INFO - Initialising browser for kraken test... 20:35:48 INFO - TEST-INFO | started process 7976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnn1pG/profile http://localhost:34374/getInfo.html) 20:35:52 INFO - PROCESS | 7976 | 20:35:52 INFO - PROCESS | 7976 | (process:8048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:35:53 INFO - PROCESS | 7976 | __metrics Screen width/height:1600/1200 20:35:53 INFO - PROCESS | 7976 | colorDepth:24 20:35:53 INFO - PROCESS | 7976 | Browser inner width/height: 1024/697 20:35:53 INFO - PROCESS | 7976 | __metrics 20:35:53 ERROR - PROCESS | 7976 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:35:54 INFO - TEST-INFO | 7976: exit 0 20:35:54 INFO - Browser initialized. 20:35:54 INFO - Running cycle 1/1 for kraken test... 20:35:54 INFO - TEST-INFO | started process 8099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnn1pG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:56 INFO - PROCESS | 8099 | 20:35:56 INFO - PROCESS | 8099 | (process:8160): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:36:06 INFO - PROCESS | 8099 | RSS: Main: 163590144 20:36:06 INFO - PROCESS | 8099 | 20:36:09 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:10 INFO - PROCESS | 8099 | RSS: Main: 168067072 20:36:10 INFO - PROCESS | 8099 | 20:36:12 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-dft) 20:36:13 INFO - PROCESS | 8099 | RSS: Main: 168615936 20:36:13 INFO - PROCESS | 8099 | 20:36:16 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-fft) 20:36:17 INFO - PROCESS | 8099 | RSS: Main: 163078144 20:36:17 INFO - PROCESS | 8099 | 20:36:19 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34374/tests/kraken/driver.html?testName=audio-oscillator) 20:36:19 INFO - PROCESS | 8099 | RSS: Main: 163147776 20:36:19 INFO - PROCESS | 8099 | 20:36:22 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:22 INFO - PROCESS | 8099 | RSS: Main: 164007936 20:36:22 INFO - PROCESS | 8099 | 20:36:25 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:26 INFO - PROCESS | 8099 | RSS: Main: 164139008 20:36:26 INFO - PROCESS | 8099 | 20:36:29 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34374/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:30 INFO - PROCESS | 8099 | RSS: Main: 162942976 20:36:30 INFO - PROCESS | 8099 | 20:36:33 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34374/tests/kraken/driver.html?testName=json-parse-financial) 20:36:34 INFO - PROCESS | 8099 | RSS: Main: 163491840 20:36:34 INFO - PROCESS | 8099 | 20:36:35 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:36 INFO - PROCESS | 8099 | RSS: Main: 163516416 20:36:36 INFO - PROCESS | 8099 | 20:36:38 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:38 INFO - PROCESS | 8099 | RSS: Main: 163696640 20:36:38 INFO - PROCESS | 8099 | 20:36:40 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:41 INFO - PROCESS | 8099 | RSS: Main: 164192256 20:36:41 INFO - PROCESS | 8099 | 20:36:44 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:44 INFO - PROCESS | 8099 | RSS: Main: 164323328 20:36:44 INFO - PROCESS | 8099 | 20:36:47 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:48 INFO - PROCESS | 8099 | RSS: Main: 164675584 20:36:48 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | Cycle 1(1): loaded http://localhost:34374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34374/tests/kraken/driver.html?testName=ai-astar) 20:36:50 INFO - PROCESS | 8099 | RSS: Main: 165707776 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | __start_tp_report 20:36:50 INFO - PROCESS | 8099 | _x_x_mozilla_page_load 20:36:50 INFO - PROCESS | 8099 | _x_x_mozilla_page_load_details 20:36:50 INFO - PROCESS | 8099 | |i|pagename|runs| 20:36:50 INFO - PROCESS | 8099 | |0;ai-astar;110;112;102;111;109;112;106;110;113;111 20:36:50 INFO - PROCESS | 8099 | |1;audio-beat-detection;154;127;160;221;131;157;161;131;194;126 20:36:50 INFO - PROCESS | 8099 | |2;audio-dft;167;166;163;165;165;177;168;167;166;162 20:36:50 INFO - PROCESS | 8099 | |3;audio-fft;75;77;76;160;74;77;76;76;180;76 20:36:50 INFO - PROCESS | 8099 | |4;audio-oscillator;93;92;184;93;92;93;137;93;93;157 20:36:50 INFO - PROCESS | 8099 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;117;118;120 20:36:50 INFO - PROCESS | 8099 | |6;imaging-darkroom;148;148;148;147;149;146;146;149;147;147 20:36:50 INFO - PROCESS | 8099 | |7;imaging-desaturate;96;96;95;95;96;95;94;96;96;95 20:36:50 INFO - PROCESS | 8099 | |8;json-parse-financial;58;60;57;56;57;57;61;108;55;54 20:36:50 INFO - PROCESS | 8099 | |9;json-stringify-tinderbox;60;61;60;61;60;60;64;60;61;61 20:36:50 INFO - PROCESS | 8099 | |10;stanford-crypto-aes;82;82;79;85;80;83;84;81;86;80 20:36:50 INFO - PROCESS | 8099 | |11;stanford-crypto-ccm;134;129;132;131;120;132;121;120;194;132 20:36:50 INFO - PROCESS | 8099 | |12;stanford-crypto-pbkdf2;163;163;170;162;174;160;167;161;162;162 20:36:50 INFO - PROCESS | 8099 | |13;stanford-crypto-sha256-iterative;63;65;64;63;65;64;64;65;63;65 20:36:50 INFO - PROCESS | 8099 | __end_tp_report 20:36:50 INFO - PROCESS | 8099 | __start_cc_report 20:36:50 INFO - PROCESS | 8099 | _x_x_mozilla_cycle_collect,833 20:36:50 INFO - PROCESS | 8099 | __end_cc_report 20:36:50 INFO - PROCESS | 8099 | __startTimestamp1463456210317__endTimestamp 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | ------- Summary: start ------- 20:36:50 INFO - PROCESS | 8099 | Number of tests: 14 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 20:36:50 INFO - PROCESS | 8099 | Values: 110.0 112.0 102.0 111.0 109.0 112.0 106.0 110.0 113.0 111.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:158.50 stddev:31.10 (19.6%) stddev-sans-first:32.98 20:36:50 INFO - PROCESS | 8099 | Values: 154.0 127.0 160.0 221.0 131.0 157.0 161.0 131.0 194.0 126.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.50 stddev:4.09 (2.5%) stddev-sans-first:4.33 20:36:50 INFO - PROCESS | 8099 | Values: 167.0 166.0 163.0 165.0 165.0 177.0 168.0 167.0 166.0 162.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.98 (52.6%) stddev-sans-first:41.76 20:36:50 INFO - PROCESS | 8099 | Values: 75.0 77.0 76.0 160.0 74.0 77.0 76.0 76.0 180.0 76.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#4] audio-oscillator Cycles:10 Average:112.70 Median:93.00 stddev:34.05 (36.6%) stddev-sans-first:35.36 20:36:50 INFO - PROCESS | 8099 | Values: 93.0 92.0 184.0 93.0 92.0 93.0 137.0 93.0 93.0 157.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 20:36:50 INFO - PROCESS | 8099 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 120.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 20:36:50 INFO - PROCESS | 8099 | Values: 148.0 148.0 148.0 147.0 149.0 146.0 146.0 149.0 147.0 147.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:36:50 INFO - PROCESS | 8099 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 94.0 96.0 96.0 95.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:57.00 stddev:16.19 (28.4%) stddev-sans-first:17.10 20:36:50 INFO - PROCESS | 8099 | Values: 58.0 60.0 57.0 56.0 57.0 57.0 61.0 108.0 55.0 54.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:1.23 (2.0%) stddev-sans-first:1.27 20:36:50 INFO - PROCESS | 8099 | Values: 60.0 61.0 60.0 61.0 60.0 60.0 64.0 60.0 61.0 61.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:2.30 (2.8%) stddev-sans-first:2.44 20:36:50 INFO - PROCESS | 8099 | Values: 82.0 82.0 79.0 85.0 80.0 83.0 84.0 81.0 86.0 80.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:132.00 stddev:21.61 (16.4%) stddev-sans-first:22.92 20:36:50 INFO - PROCESS | 8099 | Values: 134.0 129.0 132.0 131.0 120.0 132.0 121.0 120.0 194.0 132.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:163.00 stddev:4.50 (2.8%) stddev-sans-first:4.75 20:36:50 INFO - PROCESS | 8099 | Values: 163.0 163.0 170.0 162.0 174.0 160.0 167.0 161.0 162.0 162.0 20:36:50 INFO - PROCESS | 8099 | 20:36:50 INFO - PROCESS | 8099 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.83 20:36:50 INFO - PROCESS | 8099 | Values: 63.0 65.0 64.0 63.0 65.0 64.0 64.0 65.0 63.0 65.0 20:36:50 INFO - PROCESS | 8099 | -------- Summary: end -------- 20:36:50 INFO - PROCESS | 8099 | 20:36:51 INFO - TEST-INFO | 8099: exit 0 20:36:51 INFO - TEST-OK | kraken | took 62747ms 20:36:51 INFO - SUITE-END | took 1173s 20:36:51 INFO - Completed test suite (00:19:33) 20:36:51 INFO - javascript benchmark 20:36:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.755604498085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.966451071147, 3177.2692280775404, 3188.05952244088, 3218.4367735646256, 3221.0980925340914, 5396.460353964601, 5446.836594902149, 5467.097928841741, 5474.890502189954, 5482.506574408302, 5276.7889284428575, 5301.204819277111, 5322.467753224676, 5340.732963351837, 5374.865628359293, 4850.902981940368, 4877.756112194394, 4924.778384972667, 5009.724465154415, 5057.468965758598, 4864.100141473821, 4968.0, 5121.641485096045, 5123.026624941268, 5155.9484405155845, 4880.1947678632805, 4911.975440122812, 4965.131102057126, 4980.228064649985, 4992.126377883874, 4943.1596628573225, 4969.0807200668, 4976.651634385595, 4988.326575912278, 5015.523525265094, 4931.7040977541465, 4937.654364194508, 4951.232558953368, 4978.701277923336, 5002.2246551784165, 5120.334356533664, 5199.6360254782185, 5247.895042099175, 5277.208418737182, 5349.839504814861, 5691.7723291068305, 5738.569607279471, 5742.28221472316, 5761.222234998263, 5774.797882074149, 5704.600677952545, 5798.217240672498, 5811.157382179603, 5819.563532735019, 5839.591228613998, 5365.03429382711, 5399.217113518557, 5442.102053161224, 5452.0, 5470.343558772933, 5895.970520147372, 5953.3451320354725, 5963.105534169909, 5965.075413310944, 5969.791057312973, 5491.36849262332, 5659.886802263932, 5708.343540492897, 5713.971430142823, 5719.056355701263, 5645.181448689917, 5663.971680141655, 5704.11586204139, 5733.197352370671, 5740.368559458456, 5582.86042848932, 5598.1322894951345, 5603.635763675348, 5806.680632565165, 5843.328017277982, 5717.742701578439, 5789.102689083199, 5838.12428135783, 5848.883022339614, 5886.293644762656, 4264.381664658607, 4354.586314300136, 4355.5208927018, 4398.856297362709, 4422.601965823092, 3917.314469967744, 3960.7029472789654, 3961.148353104039, 3976.562578116405, 4004.3192657248337, 5357.571394288448, 5501.862453438696, 5538.556915446755, 5563.443655634485, 5572.693501857437, 5810.6513609183585, 5858.648481091148, 5861.765529378862, 5874.206982057453, 5908.261467316585, 5540.529055030287, 5552.583556233299, 5565.916511252334, 5567.832965011056, 5583.078791999355, 4729.574338309569, 4795.6163506919365, 4861.270809378621, 4886.926696099561, 4931.334269873593, 5947.405259474104, 5982.551308651781, 5988.281406231193, 6000.60996035265, 6034.969825150846, 5763.999999999916, 5793.91309130355, 5809.331926828469, 5819.621724587888, 5820.126980952891, 5793.565482588739, 5970.9701451492465, 5993.670348130895, 6004.819855404345, 6018.428249316308, 5723.656580605177, 5730.885382292414, 5734.0, 5746.367899530965, 5781.421857814353, 5785.971070144622, 5787.56593255516, 5813.3895940925595, 5831.1836342912875, 5860.0, 5397.541208997279, 5608.130739735348, 5627.88744225105, 5648.802291919763, 5689.943100569107, 5534.944650553604, 5621.747021383966, 5627.240322556402, 5691.943080569141, 5714.542836572981, 5433.076377015837, 5433.940381625545, 5485.957668043059, 5505.889882202414, 5568.832935011957, 5648.830535083954, 5701.059325211294, 5715.971420142872, 5716.942830571641, 5734.111212762028, 5383.515483606494, 5408.918216356666, 5450.700211488248, 5459.781608735606, 5499.972500137474], "value": 5327.293480350396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1028457314029, 647.5920170292715, 648.9026646003099, 664.3058004385417, 666.819958611175, 39169.216615667705, 42823.35764963528, 42910.57089429105, 42965.0, 42976.140477190515, 38597.80701096498, 38714.41928371077, 38794.8060259699, 38901.610983890154, 38982.8050859746, 8651.480911145336, 8835.734927952171, 8854.645814167425, 8860.8670869937, 8883.555822208897, 8667.263282620985, 8678.826423471526, 8728.170823771763, 8743.737687869374, 8754.956225218864, 8767.605457754416, 8815.426997245191, 8825.867611985825, 8840.204381605654, 8848.955755221215, 8672.60973256205, 8692.174243446863, 8778.736637900873, 8797.29621630268, 8811.95594022029, 8619.6983105591, 8626.482411055356, 8637.093105223923, 8656.480611163288, 8736.432131911406, 34870.30259394823, 35488.645113548795, 35661.46507802359, 35794.64205357939, 35813.0, 3754.6433088856515, 4101.374921003016, 4136.462259906223, 4182.519010313822, 4255.212785634668, 32372.676273237437, 32774.34451310984, 32774.852880149316, 33032.50451243233, 33269.83365083183, 4207.91584168318, 4225.556316586775, 4230.111676547928, 4235.49174099107, 4320.481542214923, 327541.0, 327863.0, 328103.0, 328847.0, 332141.3392933044, 35440.0, 56639.71680141573, 57106.428935710945, 57181.0, 57236.0, 36358.0, 37944.24111517809, 37984.62015379866, 38054.0, 38063.42904856429, 16003.359865605245, 16170.353185872433, 16192.433264835674, 16212.189390530426, 16233.0, 12172.634820955385, 12242.510299587917, 12248.387580620933, 12256.387180640932, 12317.50729970809, 8655.350848686374, 8692.174243446863, 8694.956525217334, 8744.300455963508, 8773.780655483537, 3316.35331110436, 3328.334333133383, 3336.4828451590042, 3361.61341445732, 3384.6784555467684, 1100.2793170473353, 1103.564092183583, 1109.8168802147716, 1191.7616476704693, 1218.8963938065187, 28659.28351791222, 29219.0, 29485.85257073701, 29611.851940740158, 29662.0, 1120.8710998235144, 1217.6347095871204, 1281.9102662813514, 1317.1438564932678, 1325.204877073748, 15173.317200725995, 15262.0, 15539.611509712347, 15584.610384740245, 16159.272832722556, 503238.0, 506151.0, 506647.0, 506901.0, 510039.0, 59458.70270648619, 59505.40494595085, 59668.70165649144, 59862.40137598568, 59908.70045649831, 1378.531299358203, 1404.662880908595, 1413.886889048894, 1420.7158568286384, 1429.9571012869424, 29829.403411932075, 29960.700392996663, 30206.84896575591, 30546.694533055273, 31234.03276688711, 51425.7428712854, 51709.482905170466, 51792.482075180276, 51941.22088168605, 52145.478545214064, 412549.0, 415915.0, 417396.0, 417605.0, 418650.0, 28252.43495130045, 28334.85832570824, 28655.42689146247, 28860.278493037003, 28903.5664465029, 47616.52383476259, 47650.285245720646, 47810.28284575804, 47978.28032579444, 48330.0, 40048.39927401033, 40808.38787418132, 41547.7922610385, 41730.0, 41760.0, 40096.39855402113, 40383.0, 40588.0, 40915.0, 41670.0, 40691.59308406878, 41268.79365603153, 41466.37800432936, 41650.58349416588, 41817.0, 30854.0, 33904.83047584746, 34404.655953440146, 34430.48354274638, 34872.47691284582, 28789.284182600466, 29139.834406623497, 29303.413931721672, 29316.7068329314, 29482.852585737794], "value": 18776.31523033456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.7734034950951, 420.76437195170706, 421.51736261980034, 425.17516018923277, 431.24747315933683, 17571.56071098223, 18904.338348157817, 19000.809991900078, 19004.239830406783, 19955.301564445246, 16929.322827086933, 17044.147792610383, 19517.316893908715, 19519.414417567496, 19612.215511379527, 5156.896862062757, 5166.61250406221, 5354.116570765819, 5360.517553420192, 5397.541208997221, 5275.788968441258, 5278.076336641092, 5313.548348390392, 5328.227407025979, 5349.331333583302, 5300.575953923696, 5356.517913387795, 5656.321241451032, 5663.0655941769555, 5747.080467125261, 5518.475744804257, 5659.60382773206, 5710.514606258473, 5886.028805247129, 5897.4102589741115, 5694.658320500742, 5705.54355651551, 5720.370759216483, 5720.742566584514, 5747.3103227612955, 13803.723925521534, 14115.0, 23032.51291400796, 23308.417289567726, 23495.0, 2291.5875142474347, 2296.196331284054, 2377.5126099149634, 2410.5781488239663, 2414.0464516515876, 10416.375017498898, 10448.373097614092, 10486.056254937092, 10552.103071238955, 10615.52230149645, 1906.65680177568, 1927.951801204967, 1936.4674714453497, 1963.077353643785, 2049.108637742587, 76669.0, 78094.82857757196, 79487.60256198682, 80968.0, 81179.18820811775, 10835.620753273597, 11177.832332514856, 11323.660290191307, 11515.53937842477, 11530.039893218172, 16238.594035148979, 16388.0, 16389.180540972902, 16413.42553010663, 16444.260008299654, 8434.915650843535, 8556.0, 8602.440841345293, 8604.784880377916, 8810.295176385875, 8281.0, 8295.62669679866, 8303.418760686814, 8454.704085356983, 8512.659493620185, 4792.736399497991, 4867.1969125093965, 4986.426560945465, 5025.673331233458, 5036.496350365008, 2040.7245021921851, 2063.164418410546, 2075.8546901716736, 2081.573277478113, 2151.451379898116, 936.5551363102608, 1016.5273147986074, 1036.8341065429495, 1037.870266216723, 1133.5522468624847, 18686.813131868777, 19060.80939190618, 19449.90275048616, 19693.621446498608, 19826.1078251479, 1037.2739082642029, 1054.4516851237313, 1073.983890241647, 1079.8704155501391, 1094.3324572011068, 10563.577456901792, 11011.339319640847, 11124.165687573464, 11126.61056863006, 11148.777024459465, 458218.0, 464897.0, 475094.0, 504814.475927618, 506409.0, 88507.55746221228, 91568.0, 92751.53624231835, 93011.0698893016, 93715.53142234382, 1052.3633201912885, 1064.3560645809173, 1101.427257825942, 1128.9040431563244, 1130.9151813614012, 17177.914110429367, 17229.655406891543, 17356.566085847953, 17492.0, 17596.73604895953, 40055.799721002375, 42758.93102672334, 42887.78556107199, 42954.140917180855, 45584.77207613941, 53778.0, 54012.729936350064, 55731.72134139465, 58328.416715832296, 61551.384486154566, 6828.760993365208, 9750.561224744763, 12429.75140497203, 13191.538296159588, 13691.0, 8905.62606254694, 14182.290885455892, 14728.705425891209, 14902.478413255483, 14958.177300248592, 12628.0, 13152.408141633841, 13211.735765284448, 13253.271070091238, 13325.267110309027, 7253.854922901618, 10958.726031849268, 12726.490940362282, 12849.678758031125, 13343.466261349437, 12880.742385152056, 13288.269145197108, 13488.0, 13505.594832155051, 13901.860981390057, 13633.795493067413, 13651.863481365059, 13664.65838354049, 13683.726325473634, 13715.862841371458, 13158.342082895626, 13378.93310533441, 13402.195868247936, 13491.595252142451, 13569.253691046692], "value": 9573.940578328926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.464744663091, 1567.4357231396696, 1783.3579911231955, 1862.7299041638955, 1896.8672192946499, 8435.24082832545, 9027.774305642362, 9031.954840225799, 9637.518124093793, 9670.274729395298, 9106.590203440845, 9426.151646351827, 9485.430874147556, 9487.098725621056, 9497.572609232584, 2354.5526349993534, 2376.251480783548, 2381.5832229359794, 2382.059086660768, 2397.9280621581293, 2346.650675861378, 2366.7633236676365, 2368.52629474105, 2395.0419832067137, 2406.169871394366, 2368.0, 2368.2303251443263, 2380.3097101840444, 2387.212219967407, 2406.254061241012, 2217.1131547381015, 2234.4190510467315, 2238.183063181927, 2260.7852254035924, 2271.250487339182, 2317.73346065203, 2331.25399872041, 2336.4742932839977, 2347.084636991575, 2369.822263330257, 9160.267178625694, 9306.627734890664, 9333.253339732873, 9366.20387267083, 9377.437353758796, 5053.873653158664, 5263.31576895005, 5310.150375939831, 5324.307839980777, 5345.224942383372, 3334.533165356828, 3371.2751758371824, 3388.4747864081105, 3407.6081250656243, 3422.3326451342, 1080.7244152741, 1095.4413249242864, 1101.983470247947, 1102.73534351755, 1108.833674948756, 13413.731725365536, 13420.463181472729, 13454.798178027337, 13510.459581616822, 13544.322783860767, 4637.443506779208, 4654.441467023911, 4740.620750339965, 4775.904481910342, 4860.586850117779, 10823.0, 10853.077488413415, 10864.511097000654, 10869.891301087046, 10871.075958543612, 5448.42791506894, 5477.7261136943, 5488.067028605146, 5491.505764481136, 5493.258410114663, 4357.172137293904, 4815.109204797123, 4883.853484395403, 4902.803887844446, 5068.6451948363265, 4093.4018213851223, 4103.630673239363, 4113.938290925638, 4156.43888075112, 4172.624463798273, 1303.4069498378215, 1329.7872340425486, 1343.596920923719, 1354.5800801751489, 1360.7414591227634, 852.7612268564811, 965.0446058402131, 966.6036924860773, 1015.441507171053, 1021.5096753558333, 6053.303870054912, 6062.818115456544, 6137.9079313810325, 6155.784547540815, 6202.627842329474, 421.7869975662271, 428.7213311347649, 428.83143434141715, 430.38025243649673, 437.656439694838, 4116.4648595682365, 4167.562405947392, 4182.560831112689, 4217.7891105444605, 4299.634531064895, 11174.888251117385, 11306.773864522664, 11496.712582185344, 11544.249623774427, 11547.133964952662, 11138.220324577363, 11266.211365204357, 11268.09855211581, 11377.37424441647, 11382.487788049391, 8225.506469611842, 8414.495130292202, 8425.357055374143, 8470.364722645827, 8482.61828217744, 5860.765569377178, 6035.698215089315, 6139.84650383744, 6147.66187859672, 6254.718537665907, 10639.0, 10670.83993740079, 10787.137029037815, 10850.891491084989, 10897.782044359226, 10318.380897146195, 10696.62561810333, 10706.89293107059, 11123.054540363835, 11185.608503702331, 8909.0, 8992.86510702353, 9166.17504424605, 9173.35786494939, 9180.127887850644, 9036.412633178823, 9099.408538444979, 9146.405483643543, 9149.5882685278, 9194.49430281341, 8268.173182681683, 8268.37987150954, 8268.462549934235, 8282.378821588285, 8364.581770911553, 7955.960220198862, 7992.5204487730925, 8039.0, 8141.552214628252, 8143.574874396838, 7117.822054448473, 7120.394766444703, 7133.53762478701, 7146.178189508273, 7183.820404489929, 5180.766865490987, 5239.24031015493, 5273.7363131842485, 5415.4313797050745, 5461.0, 5206.713630750345, 5235.738213089407, 5260.684358938476, 5297.894042119059, 5335.67985920846], "value": 4714.495825612588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.1505380633706, 325.6987286759748, 328.26141182339734, 329.2673800793235, 329.5633285896187, 5609.320403596251, 5633.774649014034, 5661.8584535386635, 5675.375708672048, 5724.370319264877, 5562.803997140614, 5595.580331475146, 5607.243022192003, 5611.7474713637885, 5625.537360286325, 4328.805203765823, 4346.630536404409, 4367.781610919457, 4369.759663218521, 4382.452193475816, 4143.482064741907, 4389.231884420214, 4389.231884420214, 4399.406080179183, 4408.515063343029, 4294.959894050332, 4306.224879521685, 4310.633596144332, 4323.524412314643, 4342.435483387171, 4347.739135651871, 4349.630281426083, 4351.477822661285, 4362.956370436286, 4376.0, 3744.0, 3785.0, 3834.3673293906472, 3841.1741475582885, 3848.5574158971795, 5422.891542169174, 5425.267588875491, 5432.456754324576, 5456.181572764078, 5461.453854614547, 4978.502149785028, 4992.051510213084, 5016.774245158977, 5021.924671129936, 5057.140286151326, 5735.4551317624755, 5829.912551311733, 5831.300243970708, 5842.685395785914, 5972.552058595623, 4152.5432202457705, 4159.459270294872, 4179.2895207814745, 4191.497020357577, 4203.07532342884, 5762.308522977228, 5975.551833612496, 6066.939330606681, 6089.421504957022, 6130.957737184689, 4234.0896707207485, 4235.661147108224, 4246.957530424656, 4254.127903779718, 4256.659467242614, 4300.849470268526, 4303.849365272263, 4327.37253098299, 4331.761753103609, 4343.522212556616, 4882.389701287339, 4925.876853078702, 4945.653804233669, 4952.47998960104, 4955.306257124005, 5865.706714664249, 5868.501177399883, 5898.616589921641, 5910.0, 5918.585699001029, 1437.4681367893736, 1462.2688655672164, 1476.8554370363054, 1476.9556913292404, 1479.7422191137448, 909.4361495872602, 932.860070989357, 941.3739862991034, 943.7216021273604, 959.8992105828927, 4943.678660887031, 5015.673981191211, 5028.522290382408, 5051.924221136685, 5083.7203953782155, 5295.629305948623, 5318.016167009116, 5377.946220537745, 5387.218853266333, 5421.241026256327, 4876.634252431082, 4943.0, 4975.850724478271, 5020.949790502122, 5107.8723031923755, 2834.957475637867, 2887.740103390705, 2898.6086878271162, 2915.5918171456015, 2931.3844092740337, 5635.408282130399, 5643.5767317451355, 5683.26117604717, 5708.828735137952, 5718.799052199001, 5335.412325022361, 5407.351117865881, 5435.0, 5497.972510137423, 5585.218069470277, 5609.158626206102, 5663.971680141655, 5673.858153546194, 5686.402927692616, 5701.344345400249, 5271.65734227274, 5358.678479291255, 5459.590530710292, 5484.8354549363585, 5707.486326230493, 6001.879962400641, 6046.848828779316, 6059.424549617043, 6063.242094738158, 6073.0, 6225.723726635938, 6320.293520749464, 6359.777407790705, 6368.649724265025, 6391.744330226739, 4385.583369579885, 4437.0, 4448.977755111204, 4464.843730469418, 4478.484974228006, 5994.970025149846, 6037.683056614542, 6119.418655227746, 6151.846203844761, 6226.034964580497, 5938.346781853907, 5940.851478713067, 5941.970290148522, 5965.433283838029, 5979.581429300081, 5914.467697907209, 5936.28764548257, 5944.494717949023, 5961.821145365646, 6046.334903160561, 5495.203195536705, 5833.941660583339, 5839.970800145972, 5841.824745257649, 5865.149553314831, 5915.822525324247, 6011.519078473624, 6027.758889644365, 6028.457438830526, 6035.9094613579955, 5678.403767604342, 5778.017736984639, 5817.272840894888, 5900.852478688067, 5903.881922361443], "value": 4370.00345045614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.3747083481138, 831.7962099285676, 851.6593362654937, 853.4239388412819, 889.3552174673358, 14592.051516651423, 15548.378064877406, 15776.684466310668, 15833.0, 15876.841231587681, 11201.66395008149, 14644.26778661068, 14707.11757294563, 14716.632084197874, 14732.0, 820.5404973215019, 854.786303424144, 857.0615176381851, 859.9355048371366, 860.2257967828941, 826.0912995704707, 833.5748768128268, 838.4466252273501, 840.5923127283294, 841.4951029382382, 875.3041332140931, 875.9605817738217, 876.9342299327576, 877.5831480046959, 879.617366445595, 863.5552690364467, 870.5560164316181, 871.7951281448854, 872.7120050383359, 873.9563021848882, 639.0510092512615, 639.4149353341687, 639.6194264412667, 640.2029473305764, 641.3137942401632, 14373.712525749426, 14373.78439323411, 14394.280285985658, 14416.062955907832, 14437.06159099655, 13644.590662280147, 13656.453741850413, 13940.442382304696, 14159.079659822079, 14245.928770356082, 11897.583584574584, 12190.146689731722, 12243.08176886737, 12318.445669944784, 12390.938045309806, 3901.7854018028997, 3916.980415097935, 3928.2339943710986, 3931.6264954829244, 4003.9399409008597, 60387.69806150985, 60676.39323606752, 61447.0, 61593.0, 62204.68897655528, 11176.66470005885, 11213.719657008476, 11236.494357753922, 11623.12826538013, 11736.76526469483, 19905.303314383927, 19912.402627921187, 20001.899990499955, 20062.398128056182, 20127.899360503103, 8514.659413623385, 8708.390412671051, 8720.0, 9079.68221112258, 9111.316651251183, 4969.155243608595, 4985.675931064469, 5028.270900719448, 5084.3898732152375, 5212.713300768418, 3309.652486488932, 3429.4684323929832, 3431.0, 3432.708219801345, 3443.776154549946, 669.270495160268, 669.521292276025, 674.430106559956, 680.3332733920687, 681.2336121862904, 710.9680064397114, 728.2426276672202, 729.6169511006764, 729.8476022824951, 759.7530802489213, 9943.204543636492, 10128.746781330377, 10180.796384072277, 10249.231307651957, 10359.741006474898, 745.4401268834237, 766.6246259613808, 767.6046835879526, 774.9961250193826, 780.8750599903988, 4724.173269677793, 4730.124926888537, 4927.137750893579, 4937.185364414903, 4959.355283813081, 69696.30303696898, 70401.0, 70440.0, 70822.2917770826, 71546.0, 63831.36168638347, 64007.67996160083, 64123.67938160279, 64690.35309646937, 66089.33910660927, 56376.43623563712, 56589.434105658416, 57233.42766572281, 57417.712911436014, 58168.4183158163, 9197.908020919705, 9719.222462203148, 9936.489751189318, 10060.798784024424, 10197.643082492077, 36485.635143649284, 36711.08222294464, 36722.63277367192, 36778.26443471062, 37082.25772692397, 48449.757751212426, 48907.26639100487, 49143.26285105655, 49451.752741236065, 50100.0, 12660.974244120896, 12723.23660580368, 12859.871401285867, 12870.292133932724, 12929.159604625669, 14193.432262709788, 14353.64115897111, 14357.497487587885, 14671.559853203995, 15085.396584136512, 13904.443822247402, 13943.860561394256, 14191.503297384543, 14281.357338919566, 14884.181370024753, 14079.507217247346, 14813.407463701331, 14943.252837357872, 14965.625859353604, 15091.698166036398, 12650.0, 12873.291968941423, 13335.0, 13384.330783460593, 13401.597952061064, 10748.838767418338, 11031.827950555386, 11084.667459975892, 11192.888071119185, 11535.884641153816, 10563.577456901945, 10922.124341286628, 10980.286281392004, 10983.231173817756, 11014.284071535325], "value": 7195.34590391153, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 102.0, 111.0, 109.0, 112.0, 106.0, 110.0, 113.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 160.0, 221.0, 131.0, 157.0, 161.0, 131.0, 194.0, 126.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 163.0, 165.0, 165.0, 177.0, 168.0, 167.0, 166.0, 162.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 160.0, 74.0, 77.0, 76.0, 76.0, 180.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 184.0, 93.0, 92.0, 93.0, 137.0, 93.0, 93.0, 157.0], "value": 112.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 146.0, 146.0, 149.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 57.0, 56.0, 57.0, 57.0, 61.0, 108.0, 55.0, 54.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 64.0, 60.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 85.0, 80.0, 83.0, 84.0, 81.0, 86.0, 80.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 132.0, 131.0, 120.0, 132.0, 121.0, 120.0, 194.0, 132.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 170.0, 162.0, 174.0, 160.0, 167.0, 161.0, 162.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 65.0, 64.0, 64.0, 65.0, 63.0, 65.0], "value": 64.1, "unit": "score"}]}]} 20:36:51 INFO - Return code: 0 20:36:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:36:51 ERROR - # TBPL SUCCESS # 20:36:51 INFO - Running post-action listener: _resource_record_post_action 20:36:51 INFO - ##### 20:36:51 INFO - ##### Finished run-tests step (success) 20:36:51 INFO - ##### 20:36:51 INFO - Running post-run listener: _resource_record_post_run 20:36:51 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535638016; Read time: 12; Write time: 670692 20:36:51 INFO - TinderboxPrint: CPU usage
13.5% 20:36:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:36:51 INFO - TinderboxPrint: I/O write bytes / time
535,638,016 / 670,692 20:36:51 INFO - TinderboxPrint: CPU idle
8,227.2 (86.5%) 20:36:51 INFO - TinderboxPrint: CPU user
1,223.8 (12.9%) 20:36:51 INFO - TinderboxPrint: Swap in / out
0 / 0 20:36:51 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 246349824; Read time: 0; Write time: 402464 20:36:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289157120; Read time: 12; Write time: 268228 20:36:52 INFO - Running post-run listener: _upload_blobber_files 20:36:52 INFO - Blob upload gear active. 20:36:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:36:52 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:53 INFO - (blobuploader) - INFO - Done attempting. 20:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:36:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:57 INFO - (blobuploader) - INFO - Done attempting. 20:36:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:36:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:36:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:58 INFO - (blobuploader) - INFO - Done attempting. 20:36:58 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:58 INFO - Return code: 0 20:36:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d6018e9366cc895d675a5845efe586aef4c9560d0c740e758a74754a97e20950cd034fc2444a4e7ad5828f65d9b82636fa50c31a50cdb2ae3c87e7746fb3c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af32bd8788fd2ff14a493e8c418cd6616b5ae995a7af014b8e91ee95925f81d1341b9824a07228556d440781ed07121d61e8728a62c2d1dcaa274f775ab9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b3410f88dfcdb5fe516355c14da1c7e9602b9d78986c6200437dd8c04ce8aa3b67c7ce30a82a3806888be36ca940f20f25de79c1a122ebbea9665d4c8d16e76"} 20:36:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:58 INFO - Contents: 20:36:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d6018e9366cc895d675a5845efe586aef4c9560d0c740e758a74754a97e20950cd034fc2444a4e7ad5828f65d9b82636fa50c31a50cdb2ae3c87e7746fb3c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af32bd8788fd2ff14a493e8c418cd6616b5ae995a7af014b8e91ee95925f81d1341b9824a07228556d440781ed07121d61e8728a62c2d1dcaa274f775ab9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b3410f88dfcdb5fe516355c14da1c7e9602b9d78986c6200437dd8c04ce8aa3b67c7ce30a82a3806888be36ca940f20f25de79c1a122ebbea9665d4c8d16e76"} 20:36:58 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:58 INFO - Copying logs to upload dir... 20:36:58 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.500911 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-16 20:36:57.377852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:57.383947) ========= 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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 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/5d6018e9366cc895d675a5845efe586aef4c9560d0c740e758a74754a97e20950cd034fc2444a4e7ad5828f65d9b82636fa50c31a50cdb2ae3c87e7746fb3c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af32bd8788fd2ff14a493e8c418cd6616b5ae995a7af014b8e91ee95925f81d1341b9824a07228556d440781ed07121d61e8728a62c2d1dcaa274f775ab9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b3410f88dfcdb5fe516355c14da1c7e9602b9d78986c6200437dd8c04ce8aa3b67c7ce30a82a3806888be36ca940f20f25de79c1a122ebbea9665d4c8d16e76"} 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.011368 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/5d6018e9366cc895d675a5845efe586aef4c9560d0c740e758a74754a97e20950cd034fc2444a4e7ad5828f65d9b82636fa50c31a50cdb2ae3c87e7746fb3c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af32bd8788fd2ff14a493e8c418cd6616b5ae995a7af014b8e91ee95925f81d1341b9824a07228556d440781ed07121d61e8728a62c2d1dcaa274f775ab9cb67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b3410f88dfcdb5fe516355c14da1c7e9602b9d78986c6200437dd8c04ce8aa3b67c7ce30a82a3806888be36ca940f20f25de79c1a122ebbea9665d4c8d16e76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:57.408363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:57.408715) ========= 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=52faae308a556c440401f8e5000001e8-1463454417.797800-1048272163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 20:36:57.494203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:36:57.494696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 20:36:57.495069) ========= ========= Total master_lag: 0.16 =========