builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1464211539.13 results: success (0) buildid: 20160525113021 builduid: 71acaa56e095493996782e24abd460c4 revision: 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.127791) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.128324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.128667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.144775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.145214) ========= 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=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 14:25:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-25 14:25:39 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.233802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.234117) ========= 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=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017869 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.284946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.285577) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 --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 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 --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=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 14:25:39,521 truncating revision to first 12 chars 2016-05-25 14:25:39,521 Setting DEBUG logging. 2016-05-25 14:25:39,521 attempt 1/10 2016-05-25 14:25:39,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b972fe5e8e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 14:25:39,822 unpacking tar archive at: fx-team-7b972fe5e8e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.924512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.924873) ========= script_repo_revision: 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.925330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.925636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:25:39.936123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 14:25:39.936743) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:25:40 INFO - MultiFileLogger online at 20160525 14:25:40 in /builds/slave/test 14:25:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:25:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:25:40 INFO - {'append_to_log': False, 14:25:40 INFO - 'base_work_dir': '/builds/slave/test', 14:25:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:25:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:25:40 INFO - 'branch': 'Fx-Team', 14:25:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:25:40 INFO - 'config_files': ('talos/linux_config.py',), 14:25:40 INFO - 'default_actions': ('clobber', 14:25:40 INFO - 'read-buildbot-config', 14:25:40 INFO - 'download-and-extract', 14:25:40 INFO - 'populate-webroot', 14:25:40 INFO - 'create-virtualenv', 14:25:40 INFO - 'install', 14:25:40 INFO - 'run-tests'), 14:25:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:25:40 INFO - 'download_minidump_stackwalk': True, 14:25:40 INFO - 'download_symbols': 'ondemand', 14:25:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:25:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:25:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:25:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:25:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:25:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:25:40 INFO - 'installer_path': 'installer.exe', 14:25:40 INFO - 'log_level': 'info', 14:25:40 INFO - 'log_name': 'talos', 14:25:40 INFO - 'log_to_console': True, 14:25:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:25:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:25:40 INFO - 'opt_config_files': (), 14:25:40 INFO - 'pip_index': False, 14:25:40 INFO - 'sps_profile': False, 14:25:40 INFO - 'sps_profile_interval': 0, 14:25:40 INFO - 'suite': 'dromaeojs', 14:25:40 INFO - 'system_bits': '32', 14:25:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:25:40 INFO - 'title': 'talos-linux64-ix-018', 14:25:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:25:40 INFO - 'use_talos_json': True, 14:25:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:25:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:25:40 INFO - 'work_dir': 'build'} 14:25:40 INFO - ##### 14:25:40 INFO - ##### Running clobber step. 14:25:40 INFO - ##### 14:25:40 INFO - Running pre-action listener: _resource_record_pre_action 14:25:40 INFO - Running main action method: clobber 14:25:40 INFO - rmtree: /builds/slave/test/build 14:25:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:25:40 INFO - Running post-action listener: _resource_record_post_action 14:25:40 INFO - ##### 14:25:40 INFO - ##### Finished clobber step (success) 14:25:40 INFO - ##### 14:25:40 INFO - ##### 14:25:40 INFO - ##### Running read-buildbot-config step. 14:25:40 INFO - ##### 14:25:40 INFO - Running pre-action listener: _resource_record_pre_action 14:25:40 INFO - Running main action method: read_buildbot_config 14:25:40 INFO - Using buildbot properties: 14:25:40 INFO - { 14:25:40 INFO - "project": "", 14:25:40 INFO - "product": "firefox", 14:25:40 INFO - "script_repo_revision": "production", 14:25:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:25:40 INFO - "repository": "", 14:25:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:25:40 INFO - "buildid": "20160525113021", 14:25:40 INFO - "pgo_build": "True", 14:25:40 INFO - "basedir": "/builds/slave/test", 14:25:40 INFO - "buildnumber": 714, 14:25:40 INFO - "slavename": "talos-linux64-ix-018", 14:25:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:25:40 INFO - "platform": "ubuntu64_hw", 14:25:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:25:40 INFO - "branch": "fx-team", 14:25:40 INFO - "repo_path": "integration/fx-team", 14:25:40 INFO - "revision": "7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370", 14:25:40 INFO - "stage_platform": "linux64-pgo", 14:25:40 INFO - "builduid": "71acaa56e095493996782e24abd460c4", 14:25:40 INFO - "slavebuilddir": "test" 14:25:40 INFO - } 14:25:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:25:40 INFO - Running post-action listener: _resource_record_post_action 14:25:40 INFO - ##### 14:25:40 INFO - ##### Finished read-buildbot-config step (success) 14:25:40 INFO - ##### 14:25:40 INFO - ##### 14:25:40 INFO - ##### Running download-and-extract step. 14:25:40 INFO - ##### 14:25:40 INFO - Running pre-action listener: _resource_record_pre_action 14:25:40 INFO - Running main action method: download_and_extract 14:25:40 INFO - mkdir: /builds/slave/test/build/tests 14:25: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')]} 14:25:40 INFO - https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:41 INFO - Downloaded 1361 bytes. 14:25:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:25:41 INFO - Using the following test package requirements: 14:25:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:25:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:25:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:25:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'jsshell-linux-x86_64.zip'], 14:25:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:25:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:25:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:25:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:25:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:25:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:25:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:25:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:41 INFO - https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:25:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:25:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:25:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:42 INFO - Downloaded 24421009 bytes. 14:25:42 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'] 14:25:42 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 14:25:43 INFO - Return code: 0 14:25:43 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 14:25: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')]} 14:25:43 INFO - https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:45 INFO - Downloaded 24421009 bytes. 14:25:45 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'] 14:25:45 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 14:25:47 INFO - Return code: 0 14:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:47 INFO - https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:25:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:25:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:25:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:48 INFO - Downloaded 10834034 bytes. 14:25:48 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'] 14:25:48 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 14:25:48 INFO - Return code: 0 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:48 INFO - https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:25:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:25:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:25:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NrEsC-o6S4O3m6rRfS5fpA/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 14:25:49 INFO - Downloaded 58662184 bytes. 14:25:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:25:49 INFO - mkdir: /builds/slave/test/properties 14:25:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:25:49 INFO - Writing to file /builds/slave/test/properties/build_url 14:25:49 INFO - Contents: 14:25:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:25:50 INFO - Running post-action listener: _resource_record_post_action 14:25:50 INFO - Running post-action listener: set_extra_try_arguments 14:25:50 INFO - ##### 14:25:50 INFO - ##### Finished download-and-extract step (success) 14:25:50 INFO - ##### 14:25:50 INFO - ##### 14:25:50 INFO - ##### Running populate-webroot step. 14:25:50 INFO - ##### 14:25:50 INFO - Running pre-action listener: _resource_record_pre_action 14:25:50 INFO - Running main action method: populate_webroot 14:25:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:25:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:25:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:25:50 INFO - '--tppagecycles', 14:25:50 INFO - '7'], 14:25:50 INFO - 'tests': ['tsvgm']}}, 14:25:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:25:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:25:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:25:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:25:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['damp', 'tps']}, 14:25:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'tests': ['damp', 'tps']}, 14:25:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['dromaeo_dom']}, 14:25:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:25:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['a11yr', 14:25:50 INFO - 'ts_paint', 14:25:50 INFO - 'tpaint', 14:25:50 INFO - 'sessionrestore', 14:25:50 INFO - 'sessionrestore_no_auto_restore', 14:25:50 INFO - 'tabpaint']}, 14:25:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['tsvgx', 14:25:50 INFO - 'tsvgr_opacity', 14:25:50 INFO - 'tart', 14:25:50 INFO - 'tscrollx', 14:25:50 INFO - 'cart']}, 14:25:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:25:50 INFO - 'tsvgr_opacity', 14:25:50 INFO - 'tart', 14:25:50 INFO - 'tscrollx', 14:25:50 INFO - 'cart']}, 14:25:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'talos_options': ['--disable-e10s'], 14:25:50 INFO - 'tests': ['tp5o']}, 14:25:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'tests': ['tp5o']}, 14:25:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'talos_options': ['--disable-e10s', 14:25:50 INFO - '--xperf_path', 14:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:50 INFO - 'tests': ['tp5n']}, 14:25:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:50 INFO - 'talos_options': ['--xperf_path', 14:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:50 INFO - 'tests': ['tp5n']}}, 14:25:50 INFO - 'talos.zip': {'path': '', 14:25:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:25:50 INFO - Running post-action listener: _resource_record_post_action 14:25:50 INFO - ##### 14:25:50 INFO - ##### Finished populate-webroot step (success) 14:25:50 INFO - ##### 14:25:50 INFO - ##### 14:25:50 INFO - ##### Running create-virtualenv step. 14:25:50 INFO - ##### 14:25:50 INFO - Running pre-action listener: _resource_record_pre_action 14:25:50 INFO - Running main action method: create_virtualenv 14:25:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:25:50 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 14:25:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:25:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:25:50 INFO - Using real prefix '/usr' 14:25:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:25:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:25:53 INFO - Installing pip.................done. 14:25:53 INFO - Return code: 0 14:25:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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')]} 14:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:25: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', 'pip>=1.5'] in /builds/slave/test/build 14:25: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 pip>=1.5 14:25:53 INFO - Using env: {'DISPLAY': ':0', 14:25:53 INFO - 'HOME': '/home/cltbld', 14:25:53 INFO - 'LANG': 'en_US.UTF-8', 14:25:53 INFO - 'LANGUAGE': 'en_US:en', 14:25:53 INFO - 'LOGNAME': 'cltbld', 14:25:53 INFO - 'MAIL': '/var/mail/cltbld', 14:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:53 INFO - 'MOZ_NO_REMOTE': '1', 14:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:53 INFO - 'NO_EM_RESTART': '1', 14:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:53 INFO - 'PWD': '/builds/slave/test', 14:25:53 INFO - 'SHELL': '/bin/bash', 14:25:53 INFO - 'SHLVL': '1', 14:25:53 INFO - 'TERM': 'linux', 14:25:53 INFO - 'TMOUT': '86400', 14:25:53 INFO - 'USER': 'cltbld', 14:25:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:53 INFO - '_': '/tools/buildbot/bin/python'} 14:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:53 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 14:25:53 INFO - Cleaning up... 14:25:53 INFO - Return code: 0 14:25:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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')]} 14:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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', '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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:25: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 psutil>=3.1.1 14:25:53 INFO - Using env: {'DISPLAY': ':0', 14:25:53 INFO - 'HOME': '/home/cltbld', 14:25:53 INFO - 'LANG': 'en_US.UTF-8', 14:25:53 INFO - 'LANGUAGE': 'en_US:en', 14:25:53 INFO - 'LOGNAME': 'cltbld', 14:25:53 INFO - 'MAIL': '/var/mail/cltbld', 14:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:53 INFO - 'MOZ_NO_REMOTE': '1', 14:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:53 INFO - 'NO_EM_RESTART': '1', 14:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:53 INFO - 'PWD': '/builds/slave/test', 14:25:53 INFO - 'SHELL': '/bin/bash', 14:25:53 INFO - 'SHLVL': '1', 14:25:53 INFO - 'TERM': 'linux', 14:25:53 INFO - 'TMOUT': '86400', 14:25:53 INFO - 'USER': 'cltbld', 14:25:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:53 INFO - '_': '/tools/buildbot/bin/python'} 14:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:53 INFO - Downloading/unpacking psutil>=3.1.1 14:25:53 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 14:25:53 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 14:25:53 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 14:25:53 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 14:25:53 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 14:25:53 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 14:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:25:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:55 INFO - Installing collected packages: psutil 14:25:55 INFO - Running setup.py install for psutil 14:25:55 INFO - building 'psutil._psutil_linux' extension 14:25:55 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 14:25:56 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 14:25:56 INFO - building 'psutil._psutil_posix' extension 14:25:56 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 14:25:56 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 14:25:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:56 INFO - Successfully installed psutil 14:25:56 INFO - Cleaning up... 14:25:56 INFO - Return code: 0 14:25:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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')]} 14:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:25: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 mozsystemmonitor==0.3 14:25:56 INFO - Using env: {'DISPLAY': ':0', 14:25:56 INFO - 'HOME': '/home/cltbld', 14:25:56 INFO - 'LANG': 'en_US.UTF-8', 14:25:56 INFO - 'LANGUAGE': 'en_US:en', 14:25:56 INFO - 'LOGNAME': 'cltbld', 14:25:56 INFO - 'MAIL': '/var/mail/cltbld', 14:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:56 INFO - 'MOZ_NO_REMOTE': '1', 14:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:56 INFO - 'NO_EM_RESTART': '1', 14:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:56 INFO - 'PWD': '/builds/slave/test', 14:25:56 INFO - 'SHELL': '/bin/bash', 14:25:56 INFO - 'SHLVL': '1', 14:25:56 INFO - 'TERM': 'linux', 14:25:56 INFO - 'TMOUT': '86400', 14:25:56 INFO - 'USER': 'cltbld', 14:25:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:56 INFO - '_': '/tools/buildbot/bin/python'} 14:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:25:58 INFO - Installing collected packages: mozsystemmonitor 14:25:58 INFO - Running setup.py install for mozsystemmonitor 14:25:58 INFO - Successfully installed mozsystemmonitor 14:25:58 INFO - Cleaning up... 14:25:58 INFO - Return code: 0 14:25:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:58 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:25:58 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 14:25:58 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 14:25:58 INFO - Using env: {'DISPLAY': ':0', 14:25:58 INFO - 'HOME': '/home/cltbld', 14:25:58 INFO - 'LANG': 'en_US.UTF-8', 14:25:58 INFO - 'LANGUAGE': 'en_US:en', 14:25:58 INFO - 'LOGNAME': 'cltbld', 14:25:58 INFO - 'MAIL': '/var/mail/cltbld', 14:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:58 INFO - 'MOZ_NO_REMOTE': '1', 14:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:58 INFO - 'NO_EM_RESTART': '1', 14:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:58 INFO - 'PWD': '/builds/slave/test', 14:25:58 INFO - 'SHELL': '/bin/bash', 14:25:58 INFO - 'SHLVL': '1', 14:25:58 INFO - 'TERM': 'linux', 14:25:58 INFO - 'TMOUT': '86400', 14:25:58 INFO - 'USER': 'cltbld', 14:25:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:58 INFO - '_': '/tools/buildbot/bin/python'} 14:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:58 INFO - Downloading/unpacking blobuploader==1.2.4 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:25: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 14:26:00 INFO - Downloading blobuploader-1.2.4.tar.gz 14:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:26:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:26:00 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 14:26:00 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 14:26:00 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 14:26:00 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 14:26:00 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 14:26:00 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 14:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:26:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:26:01 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 14:26:01 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 14:26:01 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 14:26:01 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 14:26:01 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 14:26:01 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 14:26:01 INFO - Downloading docopt-0.6.1.tar.gz 14:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:26:01 INFO - Installing collected packages: blobuploader, requests, docopt 14:26:01 INFO - Running setup.py install for blobuploader 14:26:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:26:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:26:01 INFO - Running setup.py install for requests 14:26:01 INFO - Running setup.py install for docopt 14:26:02 INFO - Successfully installed blobuploader requests docopt 14:26:02 INFO - Cleaning up... 14:26:02 INFO - Return code: 0 14:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:02 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')]} 14:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:02 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')]} 14:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:02 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:26:02 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 14:26:02 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 14:26:02 INFO - Using env: {'DISPLAY': ':0', 14:26:02 INFO - 'HOME': '/home/cltbld', 14:26:02 INFO - 'LANG': 'en_US.UTF-8', 14:26:02 INFO - 'LANGUAGE': 'en_US:en', 14:26:02 INFO - 'LOGNAME': 'cltbld', 14:26:02 INFO - 'MAIL': '/var/mail/cltbld', 14:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:02 INFO - 'MOZ_NO_REMOTE': '1', 14:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:02 INFO - 'NO_EM_RESTART': '1', 14:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:02 INFO - 'PWD': '/builds/slave/test', 14:26:02 INFO - 'SHELL': '/bin/bash', 14:26:02 INFO - 'SHLVL': '1', 14:26:02 INFO - 'TERM': 'linux', 14:26:02 INFO - 'TMOUT': '86400', 14:26:02 INFO - 'USER': 'cltbld', 14:26:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:02 INFO - '_': '/tools/buildbot/bin/python'} 14:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:02 INFO - Running setup.py (path:/tmp/pip-fbZz4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:02 INFO - Running setup.py (path:/tmp/pip-v2IFKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:02 INFO - Running setup.py (path:/tmp/pip-Y3P2hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:02 INFO - Running setup.py (path:/tmp/pip-Ulp00R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:02 INFO - Running setup.py (path:/tmp/pip-AcuiVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:02 INFO - Running setup.py (path:/tmp/pip-13QjqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:02 INFO - Running setup.py (path:/tmp/pip-cY8gg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:02 INFO - Running setup.py (path:/tmp/pip-ylW6wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:02 INFO - Running setup.py (path:/tmp/pip-JQ6yrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:02 INFO - Running setup.py (path:/tmp/pip-4NZ1Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:03 INFO - Running setup.py (path:/tmp/pip-plbPoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:03 INFO - Running setup.py (path:/tmp/pip-lP1x3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:03 INFO - Running setup.py (path:/tmp/pip-swSmnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:03 INFO - Running setup.py (path:/tmp/pip-PWCelB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:03 INFO - Running setup.py (path:/tmp/pip-NMLWOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:03 INFO - Running setup.py (path:/tmp/pip-eJTkep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:03 INFO - Running setup.py (path:/tmp/pip-MMB4Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:26:03 INFO - Running setup.py install for manifestparser 14:26:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:26:03 INFO - Running setup.py install for mozcrash 14:26:03 INFO - Running setup.py install for mozdebug 14:26:03 INFO - Running setup.py install for mozdevice 14:26:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:26:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:26:03 INFO - Running setup.py install for mozfile 14:26:04 INFO - Running setup.py install for mozhttpd 14:26:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozinfo 14:26:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozInstall 14:26:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozleak 14:26:04 INFO - Running setup.py install for mozlog 14:26:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for moznetwork 14:26:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozprocess 14:26:04 INFO - Running setup.py install for mozprofile 14:26:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozrunner 14:26:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:26:04 INFO - Running setup.py install for mozscreenshot 14:26:05 INFO - Running setup.py install for moztest 14:26:05 INFO - Running setup.py install for mozversion 14:26:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:26:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:26:05 INFO - Cleaning up... 14:26:05 INFO - Return code: 0 14:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:05 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')]} 14:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:05 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')]} 14:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:05 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:26:05 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 14:26:05 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 14:26:05 INFO - Using env: {'DISPLAY': ':0', 14:26:05 INFO - 'HOME': '/home/cltbld', 14:26:05 INFO - 'LANG': 'en_US.UTF-8', 14:26:05 INFO - 'LANGUAGE': 'en_US:en', 14:26:05 INFO - 'LOGNAME': 'cltbld', 14:26:05 INFO - 'MAIL': '/var/mail/cltbld', 14:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:05 INFO - 'MOZ_NO_REMOTE': '1', 14:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:05 INFO - 'NO_EM_RESTART': '1', 14:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:05 INFO - 'PWD': '/builds/slave/test', 14:26:05 INFO - 'SHELL': '/bin/bash', 14:26:05 INFO - 'SHLVL': '1', 14:26:05 INFO - 'TERM': 'linux', 14:26:05 INFO - 'TMOUT': '86400', 14:26:05 INFO - 'USER': 'cltbld', 14:26:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:05 INFO - '_': '/tools/buildbot/bin/python'} 14:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:05 INFO - Running setup.py (path:/tmp/pip-fRbgFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:05 INFO - Running setup.py (path:/tmp/pip-gZYrDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:05 INFO - Running setup.py (path:/tmp/pip-x9JkEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:05 INFO - Running setup.py (path:/tmp/pip-yulqly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:05 INFO - Running setup.py (path:/tmp/pip-5TBgF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:05 INFO - Running setup.py (path:/tmp/pip-1gooVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:05 INFO - Running setup.py (path:/tmp/pip-7o1YiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:05 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)) 14:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:05 INFO - Running setup.py (path:/tmp/pip-bU_yas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:06 INFO - Running setup.py (path:/tmp/pip-lrglDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:06 INFO - Running setup.py (path:/tmp/pip-8hfLSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:06 INFO - Running setup.py (path:/tmp/pip-sxEuyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:06 INFO - Running setup.py (path:/tmp/pip-aSjmNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:06 INFO - Running setup.py (path:/tmp/pip-DgkQZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:06 INFO - Running setup.py (path:/tmp/pip-2Z_tlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:06 INFO - Running setup.py (path:/tmp/pip-n_7nmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:06 INFO - Running setup.py (path:/tmp/pip-66Fufo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:06 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)) 14:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:06 INFO - Running setup.py (path:/tmp/pip-SpNWqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:06 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)) 14:26:06 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)) 14:26:06 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)) 14:26:06 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)) 14:26:06 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)) 14:26:06 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)) 14:26:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:08 INFO - Downloading blessings-1.6.tar.gz 14:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:26:08 INFO - Installing collected packages: blessings 14:26:08 INFO - Running setup.py install for blessings 14:26:08 INFO - Successfully installed blessings 14:26:08 INFO - Cleaning up... 14:26:08 INFO - Return code: 0 14:26:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:26:09 INFO - Reading from file tmpfile_stdout 14:26:09 INFO - Current package versions: 14:26:09 INFO - argparse == 1.2.1 14:26:09 INFO - blessings == 1.6 14:26:09 INFO - blobuploader == 1.2.4 14:26:09 INFO - docopt == 0.6.1 14:26:09 INFO - manifestparser == 1.1 14:26:09 INFO - mozInstall == 1.12 14:26:09 INFO - mozcrash == 0.17 14:26:09 INFO - mozdebug == 0.1 14:26:09 INFO - mozdevice == 0.48 14:26:09 INFO - mozfile == 1.2 14:26:09 INFO - mozhttpd == 0.7 14:26:09 INFO - mozinfo == 0.9 14:26:09 INFO - mozleak == 0.1 14:26:09 INFO - mozlog == 3.2 14:26:09 INFO - moznetwork == 0.27 14:26:09 INFO - mozprocess == 0.22 14:26:09 INFO - mozprofile == 0.28 14:26:09 INFO - mozrunner == 6.11 14:26:09 INFO - mozscreenshot == 0.1 14:26:09 INFO - mozsystemmonitor == 0.3 14:26:09 INFO - moztest == 0.7 14:26:09 INFO - mozversion == 1.4 14:26:09 INFO - psutil == 3.1.1 14:26:09 INFO - requests == 1.2.3 14:26:09 INFO - wsgiref == 0.1.2 14:26:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:09 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')]} 14:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:09 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')]} 14:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:09 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:26:09 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 14:26:09 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 14:26:09 INFO - Using env: {'DISPLAY': ':0', 14:26:09 INFO - 'HOME': '/home/cltbld', 14:26:09 INFO - 'LANG': 'en_US.UTF-8', 14:26:09 INFO - 'LANGUAGE': 'en_US:en', 14:26:09 INFO - 'LOGNAME': 'cltbld', 14:26:09 INFO - 'MAIL': '/var/mail/cltbld', 14:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:09 INFO - 'MOZ_NO_REMOTE': '1', 14:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:09 INFO - 'NO_EM_RESTART': '1', 14:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:09 INFO - 'PWD': '/builds/slave/test', 14:26:09 INFO - 'SHELL': '/bin/bash', 14:26:09 INFO - 'SHLVL': '1', 14:26:09 INFO - 'TERM': 'linux', 14:26:09 INFO - 'TMOUT': '86400', 14:26:09 INFO - 'USER': 'cltbld', 14:26:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:09 INFO - '_': '/tools/buildbot/bin/python'} 14:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 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)) 14:26:09 INFO - Cleaning up... 14:26:09 INFO - Return code: 0 14:26:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:26:09 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')]} 14:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:09 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')]} 14:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:09 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:26:09 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 14:26:09 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 14:26:09 INFO - Using env: {'DISPLAY': ':0', 14:26:09 INFO - 'HOME': '/home/cltbld', 14:26:09 INFO - 'LANG': 'en_US.UTF-8', 14:26:09 INFO - 'LANGUAGE': 'en_US:en', 14:26:09 INFO - 'LOGNAME': 'cltbld', 14:26:09 INFO - 'MAIL': '/var/mail/cltbld', 14:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:09 INFO - 'MOZ_NO_REMOTE': '1', 14:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:09 INFO - 'NO_EM_RESTART': '1', 14:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:09 INFO - 'PWD': '/builds/slave/test', 14:26:09 INFO - 'SHELL': '/bin/bash', 14:26:09 INFO - 'SHLVL': '1', 14:26:09 INFO - 'TERM': 'linux', 14:26:09 INFO - 'TMOUT': '86400', 14:26:09 INFO - 'USER': 'cltbld', 14:26:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:09 INFO - '_': '/tools/buildbot/bin/python'} 14:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:09 INFO - Downloading/unpacking jsonschema 14:26:09 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 14:26:09 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 14:26:09 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 14:26:09 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 14:26:09 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 14:26:09 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 14:26:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:26:11 INFO - Downloading/unpacking functools32 (from jsonschema) 14:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:11 INFO - Downloading functools32-3.2.3-2.tar.gz 14:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:26:11 INFO - warning: no files found matching '*.txt' 14:26:11 INFO - no previously-included directories found matching 'build' 14:26:11 INFO - no previously-included directories found matching 'dist' 14:26:11 INFO - no previously-included directories found matching '.git*' 14:26:11 INFO - Installing collected packages: jsonschema, functools32 14:26:11 INFO - Running setup.py install for functools32 14:26:11 INFO - warning: no files found matching '*.txt' 14:26:11 INFO - no previously-included directories found matching 'build' 14:26:11 INFO - no previously-included directories found matching 'dist' 14:26:11 INFO - no previously-included directories found matching '.git*' 14:26:11 INFO - Successfully installed jsonschema functools32 14:26:11 INFO - Cleaning up... 14:26:11 INFO - Return code: 0 14:26:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:26:11 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')]} 14:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:11 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')]} 14:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:11 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 0x7fe1a812cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdda770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, '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': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', '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 14:26:11 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 14:26:11 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 14:26:11 INFO - Using env: {'DISPLAY': ':0', 14:26:11 INFO - 'HOME': '/home/cltbld', 14:26:11 INFO - 'LANG': 'en_US.UTF-8', 14:26:11 INFO - 'LANGUAGE': 'en_US:en', 14:26:11 INFO - 'LOGNAME': 'cltbld', 14:26:11 INFO - 'MAIL': '/var/mail/cltbld', 14:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:11 INFO - 'MOZ_NO_REMOTE': '1', 14:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:11 INFO - 'NO_EM_RESTART': '1', 14:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:11 INFO - 'PWD': '/builds/slave/test', 14:26:11 INFO - 'SHELL': '/bin/bash', 14:26:11 INFO - 'SHLVL': '1', 14:26:11 INFO - 'TERM': 'linux', 14:26:11 INFO - 'TMOUT': '86400', 14:26:11 INFO - 'USER': 'cltbld', 14:26:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:11 INFO - '_': '/tools/buildbot/bin/python'} 14:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:12 INFO - Downloading/unpacking flake8 14:26:12 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 14:26:12 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 14:26:12 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 14:26:12 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 14:26:12 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 14:26:12 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 14:26:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:26:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:13 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 14:26:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:26:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 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 14:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:26:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:26:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:26:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:26:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:26:14 INFO - no previously-included directories found matching 'docs/_build' 14:26:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:26:14 INFO - Running setup.py install for pep8 14:26:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:26:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:26:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:26:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:26:14 INFO - no previously-included directories found matching 'docs/_build' 14:26:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:26:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:26:14 INFO - Cleaning up... 14:26:14 INFO - Return code: 0 14:26:14 INFO - Running post-action listener: _resource_record_post_action 14:26:14 INFO - Running post-action listener: _start_resource_monitoring 14:26:14 INFO - Starting resource monitoring. 14:26:14 INFO - ##### 14:26:14 INFO - ##### Finished create-virtualenv step (success) 14:26:14 INFO - ##### 14:26:14 INFO - ##### 14:26:14 INFO - ##### Running install step. 14:26:14 INFO - ##### 14:26:14 INFO - Running pre-action listener: _resource_record_pre_action 14:26:14 INFO - Running main action method: install 14:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:26:15 INFO - Reading from file tmpfile_stdout 14:26:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:26:15 INFO - Reading from file tmpfile_stdout 14:26:15 INFO - Output received: 14:26:15 INFO - Usage: mozinstall [options] installer 14:26:15 INFO - Options: 14:26:15 INFO - -h, --help show this help message and exit 14:26:15 INFO - -d DEST, --destination=DEST 14:26:15 INFO - Directory to install application into. [default: 14:26:15 INFO - "/builds/slave/test"] 14:26:15 INFO - --app=APP Application being installed. [default: firefox] 14:26:15 INFO - mkdir: /builds/slave/test/build/application 14:26:15 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'] 14:26:15 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 14:26:31 INFO - Reading from file tmpfile_stdout 14:26:31 INFO - Output received: 14:26:31 INFO - /builds/slave/test/build/application/firefox/firefox 14:26:31 INFO - Running post-action listener: _resource_record_post_action 14:26:31 INFO - ##### 14:26:31 INFO - ##### Finished install step (success) 14:26:31 INFO - ##### 14:26:31 INFO - ##### 14:26:31 INFO - ##### Running run-tests step. 14:26:31 INFO - ##### 14:26:31 INFO - Running pre-action listener: _resource_record_pre_action 14:26:31 INFO - Running main action method: run_tests 14:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:26:31 INFO - Python 2.7.3 14:26:31 INFO - Return code: 0 14:26:31 INFO - grabbing minidump binary from tooltool 14:26: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')]} 14:26:31 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 0xe699c0>, '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 0xe6a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe6ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:26:31 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 14:26:31 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 14:26:31 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 14:26:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:26:31 INFO - Return code: 0 14:26:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:26:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:26:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:26:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:26:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:26:32 INFO - Return code: 0 14:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:26:32 INFO - Using env: {'DISPLAY': ':0', 14:26:32 INFO - 'HOME': '/home/cltbld', 14:26:32 INFO - 'LANG': 'en_US.UTF-8', 14:26:32 INFO - 'LANGUAGE': 'en_US:en', 14:26:32 INFO - 'LOGNAME': 'cltbld', 14:26:32 INFO - 'MAIL': '/var/mail/cltbld', 14:26:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:26:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:32 INFO - 'MOZ_NO_REMOTE': '1', 14:26:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:32 INFO - 'NO_EM_RESTART': '1', 14:26:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:32 INFO - 'PWD': '/builds/slave/test', 14:26:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:26:32 INFO - 'SHELL': '/bin/bash', 14:26:32 INFO - 'SHLVL': '1', 14:26:32 INFO - 'TERM': 'linux', 14:26:32 INFO - 'TMOUT': '86400', 14:26:32 INFO - 'USER': 'cltbld', 14:26:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080', 14:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:32 INFO - '_': '/tools/buildbot/bin/python'} 14:26:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:26:33 INFO - mozversion application_buildid: 20160525113021 14:26:33 INFO - mozversion application_changeset: 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 14:26:33 INFO - mozversion application_display_name: Nightly 14:26:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:26:33 INFO - mozversion application_name: Firefox 14:26:33 INFO - mozversion application_remotingname: firefox 14:26:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:26:33 INFO - mozversion application_vendor: Mozilla 14:26:33 INFO - mozversion application_version: 49.0a1 14:26:33 INFO - mozversion platform_buildid: 20160525113021 14:26:33 INFO - mozversion platform_changeset: 7b972fe5e8e38c1fa21fe9ad1eaf6e1566dc7370 14:26:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:26:33 INFO - mozversion platform_version: 49.0a1 14:26:33 INFO - using testdate: 1464211593 14:26:33 INFO - actual date: 1464211593 14:26:33 INFO - starting webserver on 'localhost:33015' 14:26:33 INFO - SUITE-START | Running 2 tests 14:26:33 INFO - TEST-START | dromaeo_css 14:26:33 INFO - operating with platform_type : linux_ 14:26:33 INFO - Initialising browser for dromaeo_css test... 14:26:33 INFO - TEST-INFO | started process 19291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfCYHE/profile http://localhost:33015/getInfo.html) 14:26:37 INFO - PROCESS | 19291 | __metrics Screen width/height:1600/1200 14:26:37 INFO - PROCESS | 19291 | colorDepth:24 14:26:37 INFO - PROCESS | 19291 | Browser inner width/height: 1024/697 14:26:37 INFO - PROCESS | 19291 | __metrics 14:26:38 ERROR - PROCESS | 19291 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:26:39 INFO - TEST-INFO | 19291: exit 0 14:26:39 INFO - Browser initialized. 14:26:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:26:39 INFO - TEST-INFO | started process 19371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfCYHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:50 INFO - PROCESS | 19371 | RSS: Main: 154841088 14:26:50 INFO - PROCESS | 19371 | 14:27:41 INFO - PROCESS | 19371 | 1464211661755 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] 14:29:49 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33015/tests/dromaeo/cssquery-ext.html) 14:29:50 INFO - PROCESS | 19371 | RSS: Main: 252796928 14:29:50 INFO - PROCESS | 19371 | 14:32:53 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-ext.html (next: http://localhost:33015/tests/dromaeo/cssquery-jquery.html) 14:32:53 INFO - PROCESS | 19371 | RSS: Main: 242896896 14:32:53 INFO - PROCESS | 19371 | 14:35:55 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33015/tests/dromaeo/cssquery-mootools.html) 14:35:56 INFO - PROCESS | 19371 | RSS: Main: 250294272 14:35:56 INFO - PROCESS | 19371 | 14:38:58 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33015/tests/dromaeo/cssquery-prototype.html) 14:38:58 INFO - PROCESS | 19371 | RSS: Main: 250593280 14:38:58 INFO - PROCESS | 19371 | 14:42:01 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33015/tests/dromaeo/cssquery-yui.html) 14:42:01 INFO - PROCESS | 19371 | RSS: Main: 212324352 14:42:01 INFO - PROCESS | 19371 | 14:45:04 INFO - PROCESS | 19371 | Cycle 1(1): loaded http://localhost:33015/tests/dromaeo/cssquery-yui.html (next: http://localhost:33015/tests/dromaeo/cssquery-dojo.html) 14:45:05 INFO - PROCESS | 19371 | RSS: Main: 277123072 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | __start_tp_report 14:45:05 INFO - PROCESS | 19371 | _x_x_mozilla_page_load 14:45:05 INFO - PROCESS | 19371 | _x_x_mozilla_page_load_details 14:45:05 INFO - PROCESS | 19371 | |i|pagename|runs| 14:45:05 INFO - PROCESS | 19371 | |0;dojo.html;3121.6566177720456;3142.1987393214727;3163.01946396617;3174.936501269973;3201.087690008348;5330.573554115671;5380.273663055486;5407.161889907071;5457.181422786584;5469.835904922854;5318.335208098988;5320.308359913215;5430.15832545956;5452.890942181154;5477.5070243678065;4796.808127674889;4892.14387482191;4904.975475122619;4913.70517768935;5170.431252562215;5063.974680126613;5104.489551044903;5122.795088196486;5131.0764062468925;5178.948210517903;4825.10735513931;4853.563179313861;4920.21276595743;4987.526185012418;4998.250262460624;5000.924986125211;5006.048850718352;5012;5080.415752188472;5082.009008243394;4970.564423432492;4973.055119527278;4988.451270360258;5002.324686167393;5036.647434679574;5072.416672082684;5291.28567643367;5353.437889021675;5451.073317536028;5451.972740136274;5885.4997325227405;5911.793087241969;5912.615679980788;5917.911231331534;5922.644641321534;5885.999380105392;5921.73352199152;5921.970390148064;5937;5944.138099975523;5194.298769666085;5377.919331210035;5428.83713488596;5436.130219164994;5501.367342755554;6015.608985416022;6029.758809647565;6030.849228769316;6039.78860739872;6042.486388656926;5779.0464573344925;5791.88416231673;5792.681402522818;5795.536357091422;5802.65184088956;5532.585056120807;5740.6268592541355;5805.042168042311;5859.472647461749;5871.911921321183;5705.4579814917515;5713.171590119493;5730.627509211888;5738.971305143447;5774.509166720792;5737.85655358611;5746.913796293059;5751.626144300607;5752;5753.568482363839;4268.0823622921225;4289.935650965238;4296.935545966813;4349.565043495625;4353.25994580922;3910.6284902934176;3913.6477717005605;3944.1717239379477;3953.2686453006286;3959.9010024749614;5446.8910621787345;5489.478499542537;5491.862703432366;5563.248961390242;5573.749181286852;5792.971035144881;5820.563457740686;5842.620229685142;5847.94152058474;5909.2908850938165;5470.425605311465;5478.205660179252;5526.198701188305;5526.58550608706;5527.695976721319;4745.905081898342;4909.558139767438;4936.506349365107;4941.752912354368;4964.255361695775;6165.506759459233;6175.660338681416;6182.474489668429;6184.567080304426;6184.907226391608;5643.689597072201;5907.320658124198;5952.642841429441;5960;5971.940280597139;5688.544916406595;5987.550933680079;6069.36271691466;6101.786437474667;6103;5714.428557144252;5760.395158508464;5762.30852297727;5764.827055188351;5766.971165144148;5589.860253493695;5865.589408741347;5878.853028674317;5879.823605291848;5880.059190529495;5609.775608975759;5632.464915832989;5691.516221121251;5710.200571920018;5722.17028530869;5709.914351284817;5710.600257981901;5714.485696287354;5714.742836572281;5717.857053573527;5326.0679381107375;5524.502794748492;5630.634008789416;5635.042042852807;5638.436156384329;5683.71581420919;5798.971005144947;5803.3616302207565;5805.593608447368;5807.070868660994;5599.580031497572;5607.8878422432135;5613.101903695389;5623.3814280428305;5627.352854421631 14:45:05 INFO - PROCESS | 19371 | |1;ext.html;600.3066458240734;626.5864529410588;630.7067213745607;644.893592557228;647.4820143884891;33047.66952330479;35818.46272305914;46215.537844621584;47423;47451.76274118625;45364.865878353055;46204.53795462044;46262.306065409044;46316.536834631646;46472.30291545621;8173.264406203441;8729.825403491926;8885.111488851095;8926.821463570725;8927.06265842087;10211.285210035301;10572.365658060502;10576.947115264413;10900.945495272512;10907.781844363108;10641.201909856753;10828.620998265062;10832.458377081153;10834.104031794444;10838.72903177423;8199.057108432547;10456.843147352796;10667.306625069385;10741.892581074168;10767.676969690921;10609.628662996834;10715.83926241107;10719.678409647722;10721.731956701067;10724;42433.78783106096;42778;42858.57141428577;42921.14157716859;42936;3690.686291665185;3803.7147213959065;3814.1227517670814;4018.6148371201866;4326.156399502099;32641.673583264102;32953.505697414315;33431.83284083589;33534;33932.32135357304;4397.362382454558;4435.578620031092;4481.708688935241;4514.210013247702;4656.930146047812;323481.3825930879;325804;328669;328882;330342;36248.63751362506;54211.45788542143;54526;54597.45402546003;54648.72675636596;37140;37219;37468.81265593655;37538.249235015144;37542.06144846401;15532;15629.140397278032;15700.293486793122;15707.921460392625;15712.371505139667;12443.688907777378;12519.248845069325;12543.811842822364;12545.74908501825;12557.686057848627;8399.790005249917;8410.957945210235;8427.662893484192;8481.491110533389;8488.957555212184;3244.837758112085;3250.8862189823244;3263;3270.8528116234825;3278.2951665392056;880.300161371711;983.6901376066517;1082.53992053377;1133.5635780224673;1199.7540504196618;32757.344853102804;32814;32886.177845554055;32977.505337419956;33374.666253337644;1100.8789033206501;1121.8934201250868;1166.4517676691942;1200.765850659113;1216.689744115245;17118.630509559207;17254.309827606754;17443.825561744474;17455.912720436318;17479.825201748074;542806;546040.3167746571;553456;553572;555701;58867.705661472275;60304.39695603075;60375.39624603785;60495.69752151211;60515.39484605098;1267.4106540458731;1360.7346567419456;1368.945242190321;1371.3623165228016;1376.9724605507834;30827.537586935767;33322.33355332831;33518.497222542166;33600.831995839864;33610.49584256287;50451.49548504468;51112;51167.23249151191;51169.394754472276;51248.74375628098;384369;392244;392968;393201;395913;24926.37684057913;26891.327716807235;27409.58885616757;27752.167434976982;29903.850480747456;49020.5097949016;49175.508244917095;49533.50466495289;50132.74933625309;50259.24611130909;41434.37848432216;41598.792006039774;42183;42551.3617295747;42595.5740442604;40890.38664420095;41500.1699966005;41591.79204104081;41676.16647666969;41680.16639667129;41024.79487602543;41265.1746965053;41274.1745165101;41776;41818.16363672649;35293.29413411666;36517.68038178225;36806.815965919996;36982.63017369899;37543.62456375401;28102.43795124127;28117.43765124645;28179.942056594722;28352;28388 14:45:05 INFO - PROCESS | 19371 | |2;jquery.html;397.7573680055167;399.4687066201952;402.8589993502273;403.78195774281886;415.198666573513;17724.291028358868;19249.230030798786;19269.518262043457;19299.710504342427;20298.289559865407;17766.64466710665;18480.815191848076;18496.260149594;19115;19485.805141948575;5253.553447956919;5414.972925135388;5511.9724401378135;5727.455891690282;5761.596688231825;5986.670733109677;5986.760529578812;5997.070454079625;6007.909881351783;6035.275766907977;5600.52395546379;5772.076467765159;5953.196318497013;6039.063945088518;6042.305134909476;5722.742476588543;5974.551908606872;6007.609505382136;6012.458878700938;6350.936490635081;5682.062459694187;5807.30312362515;5843.094320380348;5844.240248767633;5849.151872978395;13977.510787122503;14031.1581305121;14043.578692639136;14233.85766142346;14252.21612811295;2365.9116806269135;2371.098982386682;2386.4391867911027;2430.0522796109353;2443.4746529496065;10411.635592754217;10466.21503387249;10803.459827008619;10832.512536935857;13566.796498052538;1937.82559569638;2013.1947221111673;2031.563213909002;2042.458748431667;2045.427280361501;80084.01358517523;82835.58582207111;82992.58503707443;83732.58133709292;84343;9275.90724092764;9668.951655241819;9980.500974951223;9981.850272245922;10137.239707022003;13343.399547020408;13402.396892139877;13428.798568021488;13439;13483;7755.72854950074;7922.088959769585;7972.083210430758;8119.878201826978;8136.22705842944;8069.596520173968;8124.106348301682;8158.510489370657;8251.793705157419;8312.958435207785;4151.398047283127;4183.5398106208295;4187.120704651997;4199.769012704331;4222.239996800606;2013.677811550145;2017.9697304540443;2020.5150763816873;2035.2774764958522;2045.9795402046086;901.3014913442134;1023.8003589300164;1023.9129673977795;1062.8830828608848;1067.2102644043352;19190.712139317922;19684;19697.606047878962;19874;19942.401727948185;1005.8742657167854;1011.585250047477;1016.3038318751679;1017.211660962745;1022.5551884930079;6292.874142517216;10972.286801357886;11086.889131108746;11135.832962505569;11167.106631469625;290354;319967;335268;470180;470323;92478;94658.5267073674;95787;95882.52058739802;97451.51274243584;463.6406784741852;467.64692657044395;472.9030548737501;474.058992899095;475.06412367635704;11075.501602428072;11374.886251137383;11612.187146899636;11783.88216117862;12006.579769708018;40517.797411012754;43553.78223108864;43633.781831090644;44539.10921781482;46065.53934460613;37932.810335949245;39010.609893901834;39270.41094383644;45593.77203114096;55209.44790552043;8737.344699147463;8956.776080597776;9001.954990225007;9106.134917182857;9232.446053236827;9776.755581110245;13553.728925421634;13817.930910345785;14014.509492167725;14246.857531424554;11895;12021.519139234333;12156.75686486283;12367.381630918599;12527.624171274876;11883.702907427383;11976.700582485508;12195.146339756131;12307.75384492323;12346.691332716753;12292.446839892405;12332.32172230536;12384.690382740144;12565.74868502643;12626.621201363974;8609.440386374865;8703.086175951687;8942.642294308154;9076.954615226881;9081.45511269326;9317.86023209666;11969.64091077269;12453.501859925502;12460.252384856938;12512.93743531313 14:45:05 INFO - PROCESS | 19371 | |3;mootools.html;1349.466960550582;1538.26163441548;1550.5503404012836;1754.1930711872537;1877.080230686962;8790.252828509576;9147.359684822066;9190.586423610945;9409.811803763921;9428.858567121499;9060.682876099338;9224.215941644952;9261.444313341188;9285.210757085639;9297.442153470796;2074.7925207479207;2356.175338631474;2401.7838394544533;2421.5156968606348;2430.453148041694;2445.070873068232;2452.239805660242;2452.472718365551;2452.8773561321864;2455.8894849731805;2388.3432056184515;2406.42245860993;2437.5612389769835;2438.743931887153;2440.3777036855577;2035.155410504639;2331.1374791327316;2358.6933698619155;2393.3777217923293;2401.615741481372;2359.362971997551;2381.9047238110456;2385.8329916905823;2386.546556154325;2402.159244264511;9271.397359171633;9320.30097742672;9331;9336.3464557481;9338.112879276458;5402.756875940592;5538.806141785059;5539.446055394468;5543.307086614173;5546.251256080418;3523.312953973976;3533.2050288685095;3585.982070089633;3681.226942342111;3691.1325838427947;1115.754534002518;1130.2257953302014;1132.6771870017005;1170.6371024982197;1185.9407029648482;13116.147450415692;13143.34283285832;13155.671108222276;13155.736885262337;13158.473661053546;4799.9760001199775;4853.247746599282;4975.353204083446;4985.950140498621;4992.450830408652;10900.182486313399;10920.890791092146;10934.4532773361;10950.890491095146;10958.397288149228;5556.833295001156;5591.30108736408;5592.720363981866;5596.048671725816;5598.664080155204;4433.046894917608;4974.77613507393;5100.158473851773;5104.744762761921;5174.353205849269;3860.903477413031;3981.7212795104065;4022.6178513041214;4023.436718859362;4074.6740260779065;1280;1285.0875878126449;1299.2659147581776;1305.053835968934;1305.5169587252776;988.8961659025699;1046.1264843855465;1051.8264486359665;1056.572088304238;1071.8231491803765;6510;6534.085228068075;6572.507061970371;6599.73601055962;6664.8000559983275;490.1422510606439;495.40056531597173;1007.5063219022773;1063.2132222155703;1119.0879433261866;4458.621017213508;4492.528284530143;4519.525449827721;4524.343970124313;4548.090381923628;11068.114550835913;11402.486888090056;11708.824367634492;11720.531178752753;11786.646400607995;11343.773124537463;11669.941650291694;11831.88168118325;11833.526658933719;11847.703807404712;8547.316214702809;8765.254953329038;8768.035516093225;8777.999999999873;8783.385163038654;5734.799282025109;6025.3070896845675;6065.696715164312;6134.969325153345;6176.505879529716;10663.680089597325;10856.402897840695;10953.780924381308;10967;11022.448877556251;11105.888941110485;11294.265872718248;11371.601993930173;11377.032952199155;11389.43052847371;7218.927810722035;7979.321757650665;8201.26188643025;8302.211289927447;8451.28164106058;9181.586828592595;9204.297205017094;9293.303002274992;9316.441013538939;9327.58025888823;8144.714934977247;8281.917180828115;8365.330773538224;8407.53758543286;8479.95760021196;7795.298423141944;7936.920630793618;8138.389620778347;8203.794905127419;8262.215089566482;7291.963540182477;7344.669489872862;7609.239076092346;7628.8855667163925;7632.542047477169;5577.6653400796085;5642.463965923231;5660.066089095253;5703.5722320826935;5900.350961394329;5735.254416925773;5780.508656764054;5799.449052340021;5821.446962538552;5877.471027607536 14:45:05 INFO - PROCESS | 19371 | |4;prototype.html;334.93824576093795;338.6765638814932;346.1605606404469;346.7763292676224;349.47055211354785;5403.432639572848;5422.2951016367815;5469.179623056543;5473.972630136849;5487.368952570456;5334.973325133369;5371.301730774994;5388.7305634718305;5397.3523177218785;5427.937383794163;3976.3637817949134;4195.769232692201;4200.474940632421;4248.702590818644;4276.700630955842;4174.958250417502;4189.748615083089;4216.283231850577;4217.45173127493;4230.492340919094;4171.374293855915;4176.812043458037;4196.496420429553;4200.642945349649;4213.620774130328;4001.799910004488;4065.512138543364;4174.499060112776;4189.413482112506;4200.621944025022;3666.2850744104912;3675.2649470106085;3679.3929001714687;3687.4284485904727;3693.8918324502542;5025.974870125662;5220.712860792655;5252.3171987641745;5261.184516399964;5266.815661451869;4620.260758278693;4787.8563643090765;4804.5916097131785;4810.591099756525;4834.129856625806;5647.576431767634;5649.209110724501;5649.378568357477;5657.321121465409;5660.660360378391;3903.2974064668347;3974;3995.3407687731487;4000.2599519089063;4006.2988976928923;5775.942240577624;5777.711114444303;5795.40626327759;5824.941750582525;5841.37138287768;4112.067328355668;4112.218678451085;4122.154958233555;4125.360569111733;4147.937780933288;4023.2355852387955;4177.456930599003;4196.328587426058;4198.307279298881;4199.706020578591;4723.574878260973;4730.148573256847;4741.43102827656;4750.809967601257;4786.16242157621;5619.578531610146;5620.971895140498;5626.85932851682;5690.207584610835;5702.714864256771;1377.435251546861;1423.779314206279;1443.2278730879138;1446.9927650361892;1448.6233579269465;901.3285102598475;917.6375331743924;935.2471260635118;939.3096074385321;943.32080901752;4896.314515967767;4898.436679781799;4908.509149085063;4910.238912968495;4941.925871111936;5080.669756465818;5150.742462876841;5151.6908985461;5185.081519837684;5253.03203689914;4955.4796746341835;5218.66078704883;5253.921191182136;5482.890342193134;5501.724913754377;3055.3125546751803;3066.6013418255484;3072.2012276807745;3076.6000419945262;3080.6765289644263;5825.50483208932;5993.580449368589;6033.276006879115;6077.878442431127;6085.908711369333;5773.249477567973;5849.94150058494;5866.560007999417;5867.64794112346;5919.704014799243;5977.252843394575;6036.788712395133;6061.575689701766;6081.331053584102;6084.543659225487;5621.088829797888;5739.282589676291;5762.94237057624;5786.566007549535;5798.739056742541;5716.771329146787;5736.340320863154;5736.799212027559;5759.337676167127;5777.653340799566;5741.3971532988435;6044.214252147192;6054.3642917493025;6082.2093127893095;6087.4521293083835;4084.183163367398;4102.118044620421;4107.137501124677;4112.712110152261;4112.856050038235;5754.597178197486;5766.221560089502;5795.217645617956;5822.912656310074;5830.2420685310635;5364.570834333322;5605.309451463402;5627.986962346817;5659.490645841894;5683.630564013326;5615.943840561542;5621.8594535136945;5695.601307908407;5700.714964251688;5700.971495142498;5490.670559766427;5507.366652834975;5518.2826232591115;5593.328800543961;5656.2929633795775;5345.135926307042;5578.748956297058;5635.182898479616;5665.291838520185;5689.374168841507;5375.543078838343;5523.309586301712;5540.916886246629;5551.861203469945;5568.415316391721 14:45:05 INFO - PROCESS | 19371 | |5;yui.html;820.2289847543309;852.2925971443706;859.4284800607596;869.1873098652757;890.9732708018757;14628.853711462896;15176.620584485394;15222.162781047038;15223.238838058094;15866.52400427989;14492.492762753305;14502.492412765556;14547.78178327326;14662.926685366558;14757.18835464049;680.7209044291841;806.762005208462;827.3546633625766;838.2204549768712;842.8819965204876;811.2131232704268;841.0748177005306;845.471580262336;846.2426128614886;846.4667259626427;882.9293656507464;882.9558522073903;884.5798245833209;884.752269364579;884.9513276769775;721.4877437019722;845.2688424512813;866.7963028688316;867.9435836670597;883.5582208895552;632.2570979099586;632.424493710721;632.5034847644623;632.7658766256468;633.607163558592;15240.085594864344;15243;15286.159261240628;15293.158876261801;15302.081875087419;14171;14328.211948342838;14355.641108972255;14385.856141438557;14466.566003019927;12838.935805321007;12971.610851674464;13144.60566183016;13229.735405291936;13248.735025299537;4496.775161241958;4528.366028755977;4572.908541829178;4618.191816432144;4660.300954856764;59293;60227.39772602262;60523.69738151281;60689.393106069256;60900;11325.2072354936;11472.426378681033;11485.138614603939;11628.1860269782;11736.237144585575;21017;21198.576028479652;21208.787912120682;21215.89392053061;21513.892430537748;8371;8404;8453.704120355758;8559.786005349915;8839.248663863515;4583.495815460296;4631.583157515773;4662.510436404196;4678.345031695565;4770.642201834877;3447.6897079262985;3519.0322661268356;3551.698105660996;3558.697510711567;3558.822058897045;639.8176519691865;643.3020173112226;645.812714312844;663.7610460234312;664.378805816563;660.8215781739;699.6886385558479;714.3213946750608;745.4111252110772;770.7456539342004;9944.900550994542;10068.617980101775;10089.445080520494;10095.840282791127;10131.189504839595;573.6099452372343;610.716017052073;628.8176428835586;707.5507053021369;715.9785206443711;4480.439945006874;4559.772011399416;4593.540645935446;4731.574158325767;5190.403103643054;73010.2698973014;74830.25169748232;75193.62403188058;75699.24300757032;76089.23910760932;62090.68954655198;63355.366446335865;64236;66332;67667;57631.42368576261;58485;58617.70691146517;59741;61164;10396.116330112025;10467.267291289536;10516.68449946503;10526.157907367238;10585.9470702646;36952.63047369492;37040.6295937048;37282.813585932985;37386.62613373831;37614.435783463814;47535.52464475449;50381;51412;53969.46944458319;54719;13093.738125237633;13489.797653035015;13498.662533436742;13500.594982150551;13579.185248885098;14844.332005059583;14909.17999509994;15055.473058442902;15110.924445377703;15842;14204.502842400467;14342;14651.706965860836;14716.043457175248;14720.77918831197;13667.794983075062;13782.86217137856;13972.860271397156;13996.37016334247;14742.778858316919;13923.373448195058;14025.29873506341;14035.438582456587;14425.35085921115;14731.484398046017;11137.327041510141;11345.262557933707;11387.54449822031;11943.94028029889;12181.08641851847;11580.88419115798;11739.242924809785;11907.345096019802;11947.522099115939;11965.222260553037 14:45:05 INFO - PROCESS | 19371 | __end_tp_report 14:45:05 INFO - PROCESS | 19371 | __start_cc_report 14:45:05 INFO - PROCESS | 19371 | _x_x_mozilla_cycle_collect,871 14:45:05 INFO - PROCESS | 19371 | __end_cc_report 14:45:05 INFO - PROCESS | 19371 | __startTimestamp1464212705048__endTimestamp 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | ------- Summary: start ------- 14:45:05 INFO - PROCESS | 19371 | Number of tests: 6 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#0] dojo.html Cycles:165 Average:5410.69 Median:5613.10 stddev:632.67 (11.3%) stddev-sans-first:608.59 14:45:05 INFO - PROCESS | 19371 | Values: 3121.7 3142.2 3163.0 3174.9 3201.1 5330.6 5380.3 5407.2 5457.2 5469.8 5318.3 5320.3 5430.2 5452.9 5477.5 4796.8 4892.1 4905.0 4913.7 5170.4 5064.0 5104.5 5122.8 5131.1 5178.9 4825.1 4853.6 4920.2 4987.5 4998.3 5000.9 5006.0 5012.0 5080.4 5082.0 4970.6 4973.1 4988.5 5002.3 5036.6 5072.4 5291.3 5353.4 5451.1 5452.0 5885.5 5911.8 5912.6 5917.9 5922.6 5886.0 5921.7 5922.0 5937.0 5944.1 5194.3 5377.9 5428.8 5436.1 5501.4 6015.6 6029.8 6030.8 6039.8 6042.5 5779.0 5791.9 5792.7 5795.5 5802.7 5532.6 5740.6 5805.0 5859.5 5871.9 5705.5 5713.2 5730.6 5739.0 5774.5 5737.9 5746.9 5751.6 5752.0 5753.6 4268.1 4289.9 4296.9 4349.6 4353.3 3910.6 3913.6 3944.2 3953.3 3959.9 5446.9 5489.5 5491.9 5563.2 5573.7 5793.0 5820.6 5842.6 5847.9 5909.3 5470.4 5478.2 5526.2 5526.6 5527.7 4745.9 4909.6 4936.5 4941.8 4964.3 6165.5 6175.7 6182.5 6184.6 6184.9 5643.7 5907.3 5952.6 5960.0 5971.9 5688.5 5987.6 6069.4 6101.8 6103.0 5714.4 5760.4 5762.3 5764.8 5767.0 5589.9 5865.6 5878.9 5879.8 5880.1 5609.8 5632.5 5691.5 5710.2 5722.2 5709.9 5710.6 5714.5 5714.7 5717.9 5326.1 5524.5 5630.6 5635.0 5638.4 5683.7 5799.0 5803.4 5805.6 5807.1 5599.6 5607.9 5613.1 5623.4 5627.4 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#1] ext.html Cycles:180 Average:57964.03 Median:37179.50 stddev:115044.53 (309.4%) stddev-sans-first:115286.64 14:45:05 INFO - PROCESS | 19371 | Values: 600.3 626.6 630.7 644.9 647.5 33047.7 35818.5 46215.5 47423.0 47451.8 45364.9 46204.5 46262.3 46316.5 46472.3 8173.3 8729.8 8885.1 8926.8 8927.1 10211.3 10572.4 10576.9 10900.9 10907.8 10641.2 10828.6 10832.5 10834.1 10838.7 8199.1 10456.8 10667.3 10741.9 10767.7 10609.6 10715.8 10719.7 10721.7 10724.0 42433.8 42778.0 42858.6 42921.1 42936.0 3690.7 3803.7 3814.1 4018.6 4326.2 32641.7 32953.5 33431.8 33534.0 33932.3 4397.4 4435.6 4481.7 4514.2 4656.9 323481.4 325804.0 328669.0 328882.0 330342.0 36248.6 54211.5 54526.0 54597.5 54648.7 37140.0 37219.0 37468.8 37538.2 37542.1 15532.0 15629.1 15700.3 15707.9 15712.4 12443.7 12519.2 12543.8 12545.7 12557.7 8399.8 8411.0 8427.7 8481.5 8489.0 3244.8 3250.9 3263.0 3270.9 3278.3 880.3 983.7 1082.5 1133.6 1199.8 32757.3 32814.0 32886.2 32977.5 33374.7 1100.9 1121.9 1166.5 1200.8 1216.7 17118.6 17254.3 17443.8 17455.9 17479.8 542806.0 546040.3 553456.0 553572.0 555701.0 58867.7 60304.4 60375.4 60495.7 60515.4 1267.4 1360.7 1368.9 1371.4 1377.0 30827.5 33322.3 33518.5 33600.8 33610.5 50451.5 51112.0 51167.2 51169.4 51248.7 384369.0 392244.0 392968.0 393201.0 395913.0 24926.4 26891.3 27409.6 27752.2 29903.9 49020.5 49175.5 49533.5 50132.7 50259.2 41434.4 41598.8 42183.0 42551.4 42595.6 40890.4 41500.2 41591.8 41676.2 41680.2 41024.8 41265.2 41274.2 41776.0 41818.2 35293.3 36517.7 36806.8 36982.6 37543.6 28102.4 28117.4 28179.9 28352.0 28388.0 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#2] jquery.html Cycles:180 Average:25236.87 Median:38471.71 stddev:64366.31 (167.3%) stddev-sans-first:64519.86 14:45:05 INFO - PROCESS | 19371 | Values: 397.8 399.5 402.9 403.8 415.2 17724.3 19249.2 19269.5 19299.7 20298.3 17766.6 18480.8 18496.3 19115.0 19485.8 5253.6 5415.0 5512.0 5727.5 5761.6 5986.7 5986.8 5997.1 6007.9 6035.3 5600.5 5772.1 5953.2 6039.1 6042.3 5722.7 5974.6 6007.6 6012.5 6350.9 5682.1 5807.3 5843.1 5844.2 5849.2 13977.5 14031.2 14043.6 14233.9 14252.2 2365.9 2371.1 2386.4 2430.1 2443.5 10411.6 10466.2 10803.5 10832.5 13566.8 1937.8 2013.2 2031.6 2042.5 2045.4 80084.0 82835.6 82992.6 83732.6 84343.0 9275.9 9669.0 9980.5 9981.9 10137.2 13343.4 13402.4 13428.8 13439.0 13483.0 7755.7 7922.1 7972.1 8119.9 8136.2 8069.6 8124.1 8158.5 8251.8 8313.0 4151.4 4183.5 4187.1 4199.8 4222.2 2013.7 2018.0 2020.5 2035.3 2046.0 901.3 1023.8 1023.9 1062.9 1067.2 19190.7 19684.0 19697.6 19874.0 19942.4 1005.9 1011.6 1016.3 1017.2 1022.6 6292.9 10972.3 11086.9 11135.8 11167.1 290354.0 319967.0 335268.0 470180.0 470323.0 92478.0 94658.5 95787.0 95882.5 97451.5 463.6 467.6 472.9 474.1 475.1 11075.5 11374.9 11612.2 11783.9 12006.6 40517.8 43553.8 43633.8 44539.1 46065.5 37932.8 39010.6 39270.4 45593.8 55209.4 8737.3 8956.8 9002.0 9106.1 9232.4 9776.8 13553.7 13817.9 14014.5 14246.9 11895.0 12021.5 12156.8 12367.4 12527.6 11883.7 11976.7 12195.1 12307.8 12346.7 12292.4 12332.3 12384.7 12565.7 12626.6 8609.4 8703.1 8942.6 9077.0 9081.5 9317.9 11969.6 12453.5 12460.3 12512.9 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#3] mootools.html Cycles:180 Average:6172.46 Median:4521.93 stddev:3557.50 (78.7%) stddev-sans-first:3549.01 14:45:05 INFO - PROCESS | 19371 | Values: 1349.5 1538.3 1550.6 1754.2 1877.1 8790.3 9147.4 9190.6 9409.8 9428.9 9060.7 9224.2 9261.4 9285.2 9297.4 2074.8 2356.2 2401.8 2421.5 2430.5 2445.1 2452.2 2452.5 2452.9 2455.9 2388.3 2406.4 2437.6 2438.7 2440.4 2035.2 2331.1 2358.7 2393.4 2401.6 2359.4 2381.9 2385.8 2386.5 2402.2 9271.4 9320.3 9331.0 9336.3 9338.1 5402.8 5538.8 5539.4 5543.3 5546.3 3523.3 3533.2 3586.0 3681.2 3691.1 1115.8 1130.2 1132.7 1170.6 1185.9 13116.1 13143.3 13155.7 13155.7 13158.5 4800.0 4853.2 4975.4 4986.0 4992.5 10900.2 10920.9 10934.5 10950.9 10958.4 5556.8 5591.3 5592.7 5596.0 5598.7 4433.0 4974.8 5100.2 5104.7 5174.4 3860.9 3981.7 4022.6 4023.4 4074.7 1280.0 1285.1 1299.3 1305.1 1305.5 988.9 1046.1 1051.8 1056.6 1071.8 6510.0 6534.1 6572.5 6599.7 6664.8 490.1 495.4 1007.5 1063.2 1119.1 4458.6 4492.5 4519.5 4524.3 4548.1 11068.1 11402.5 11708.8 11720.5 11786.6 11343.8 11669.9 11831.9 11833.5 11847.7 8547.3 8765.3 8768.0 8778.0 8783.4 5734.8 6025.3 6065.7 6135.0 6176.5 10663.7 10856.4 10953.8 10967.0 11022.4 11105.9 11294.3 11371.6 11377.0 11389.4 7218.9 7979.3 8201.3 8302.2 8451.3 9181.6 9204.3 9293.3 9316.4 9327.6 8144.7 8281.9 8365.3 8407.5 8480.0 7795.3 7936.9 8138.4 8203.8 8262.2 7292.0 7344.7 7609.2 7628.9 7632.5 5577.7 5642.5 5660.1 5703.6 5900.4 5735.3 5780.5 5799.4 5821.4 5877.5 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#4] prototype.html Cycles:180 Average:4712.02 Median:5367.94 stddev:1389.47 (25.9%) stddev-sans-first:1353.97 14:45:05 INFO - PROCESS | 19371 | Values: 334.9 338.7 346.2 346.8 349.5 5403.4 5422.3 5469.2 5474.0 5487.4 5335.0 5371.3 5388.7 5397.4 5427.9 3976.4 4195.8 4200.5 4248.7 4276.7 4175.0 4189.7 4216.3 4217.5 4230.5 4171.4 4176.8 4196.5 4200.6 4213.6 4001.8 4065.5 4174.5 4189.4 4200.6 3666.3 3675.3 3679.4 3687.4 3693.9 5026.0 5220.7 5252.3 5261.2 5266.8 4620.3 4787.9 4804.6 4810.6 4834.1 5647.6 5649.2 5649.4 5657.3 5660.7 3903.3 3974.0 3995.3 4000.3 4006.3 5775.9 5777.7 5795.4 5824.9 5841.4 4112.1 4112.2 4122.2 4125.4 4147.9 4023.2 4177.5 4196.3 4198.3 4199.7 4723.6 4730.1 4741.4 4750.8 4786.2 5619.6 5621.0 5626.9 5690.2 5702.7 1377.4 1423.8 1443.2 1447.0 1448.6 901.3 917.6 935.2 939.3 943.3 4896.3 4898.4 4908.5 4910.2 4941.9 5080.7 5150.7 5151.7 5185.1 5253.0 4955.5 5218.7 5253.9 5482.9 5501.7 3055.3 3066.6 3072.2 3076.6 3080.7 5825.5 5993.6 6033.3 6077.9 6085.9 5773.2 5849.9 5866.6 5867.6 5919.7 5977.3 6036.8 6061.6 6081.3 6084.5 5621.1 5739.3 5762.9 5786.6 5798.7 5716.8 5736.3 5736.8 5759.3 5777.7 5741.4 6044.2 6054.4 6082.2 6087.5 4084.2 4102.1 4107.1 4112.7 4112.9 5754.6 5766.2 5795.2 5822.9 5830.2 5364.6 5605.3 5628.0 5659.5 5683.6 5615.9 5621.9 5695.6 5700.7 5701.0 5490.7 5507.4 5518.3 5593.3 5656.3 5345.1 5578.7 5635.2 5665.3 5689.4 5375.5 5523.3 5540.9 5551.9 5568.4 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - PROCESS | 19371 | [#5] yui.html Cycles:180 Average:16709.07 Median:4512.57 stddev:19958.63 (442.3%) stddev-sans-first:19978.96 14:45:05 INFO - PROCESS | 19371 | Values: 820.2 852.3 859.4 869.2 891.0 14628.9 15176.6 15222.2 15223.2 15866.5 14492.5 14502.5 14547.8 14662.9 14757.2 680.7 806.8 827.4 838.2 842.9 811.2 841.1 845.5 846.2 846.5 882.9 883.0 884.6 884.8 885.0 721.5 845.3 866.8 867.9 883.6 632.3 632.4 632.5 632.8 633.6 15240.1 15243.0 15286.2 15293.2 15302.1 14171.0 14328.2 14355.6 14385.9 14466.6 12838.9 12971.6 13144.6 13229.7 13248.7 4496.8 4528.4 4572.9 4618.2 4660.3 59293.0 60227.4 60523.7 60689.4 60900.0 11325.2 11472.4 11485.1 11628.2 11736.2 21017.0 21198.6 21208.8 21215.9 21513.9 8371.0 8404.0 8453.7 8559.8 8839.2 4583.5 4631.6 4662.5 4678.3 4770.6 3447.7 3519.0 3551.7 3558.7 3558.8 639.8 643.3 645.8 663.8 664.4 660.8 699.7 714.3 745.4 770.7 9944.9 10068.6 10089.4 10095.8 10131.2 573.6 610.7 628.8 707.6 716.0 4480.4 4559.8 4593.5 4731.6 5190.4 73010.3 74830.3 75193.6 75699.2 76089.2 62090.7 63355.4 64236.0 66332.0 67667.0 57631.4 58485.0 58617.7 59741.0 61164.0 10396.1 10467.3 10516.7 10526.2 10585.9 36952.6 37040.6 37282.8 37386.6 37614.4 47535.5 50381.0 51412.0 53969.5 54719.0 13093.7 13489.8 13498.7 13500.6 13579.2 14844.3 14909.2 15055.5 15110.9 15842.0 14204.5 14342.0 14651.7 14716.0 14720.8 13667.8 13782.9 13972.9 13996.4 14742.8 13923.4 14025.3 14035.4 14425.4 14731.5 11137.3 11345.3 11387.5 11943.9 12181.1 11580.9 11739.2 11907.3 11947.5 11965.2 14:45:05 INFO - PROCESS | 19371 | -------- Summary: end -------- 14:45:05 INFO - PROCESS | 19371 | 14:45:05 INFO - TEST-INFO | 19371: exit 0 14:45:05 INFO - TEST-OK | dromaeo_css | took 1112680ms 14:45:05 INFO - TEST-START | kraken 14:45:05 INFO - operating with platform_type : linux_ 14:45:05 INFO - Initialising browser for kraken test... 14:45:05 INFO - TEST-INFO | started process 19554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDk2ceC/profile http://localhost:33015/getInfo.html) 14:45:09 INFO - PROCESS | 19554 | __metrics Screen width/height:1600/1200 14:45:09 INFO - PROCESS | 19554 | colorDepth:24 14:45:09 INFO - PROCESS | 19554 | Browser inner width/height: 1024/697 14:45:09 INFO - PROCESS | 19554 | __metrics 14:45:10 ERROR - PROCESS | 19554 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:45:11 INFO - TEST-INFO | 19554: exit 0 14:45:11 INFO - Browser initialized. 14:45:11 INFO - Running cycle 1/1 for kraken test... 14:45:11 INFO - TEST-INFO | started process 19633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDk2ceC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:45:23 INFO - PROCESS | 19633 | RSS: Main: 155394048 14:45:23 INFO - PROCESS | 19633 | 14:45:25 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-beat-detection) 14:45:26 INFO - PROCESS | 19633 | RSS: Main: 211558400 14:45:26 INFO - PROCESS | 19633 | 14:45:29 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-dft) 14:45:29 INFO - PROCESS | 19633 | RSS: Main: 200122368 14:45:29 INFO - PROCESS | 19633 | 14:45:33 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-fft) 14:45:33 INFO - PROCESS | 19633 | RSS: Main: 268390400 14:45:33 INFO - PROCESS | 19633 | 14:45:35 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33015/tests/kraken/driver.html?testName=audio-oscillator) 14:45:36 INFO - PROCESS | 19633 | RSS: Main: 176738304 14:45:36 INFO - PROCESS | 19633 | 14:45:38 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:45:39 INFO - PROCESS | 19633 | RSS: Main: 181608448 14:45:39 INFO - PROCESS | 19633 | 14:45:42 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-darkroom) 14:45:42 INFO - PROCESS | 19633 | RSS: Main: 217649152 14:45:42 INFO - PROCESS | 19633 | 14:45:46 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33015/tests/kraken/driver.html?testName=imaging-desaturate) 14:45:46 INFO - PROCESS | 19633 | RSS: Main: 218648576 14:45:46 INFO - PROCESS | 19633 | 14:45:49 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33015/tests/kraken/driver.html?testName=json-parse-financial) 14:45:50 INFO - PROCESS | 19633 | RSS: Main: 219099136 14:45:50 INFO - PROCESS | 19633 | 14:45:51 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:45:52 INFO - PROCESS | 19633 | RSS: Main: 205488128 14:45:52 INFO - PROCESS | 19633 | 14:45:53 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:45:54 INFO - PROCESS | 19633 | RSS: Main: 209727488 14:45:54 INFO - PROCESS | 19633 | 14:45:56 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:45:57 INFO - PROCESS | 19633 | RSS: Main: 220467200 14:45:57 INFO - PROCESS | 19633 | 14:45:59 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:46:00 INFO - PROCESS | 19633 | RSS: Main: 226922496 14:46:00 INFO - PROCESS | 19633 | 14:46:03 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:46:03 INFO - PROCESS | 19633 | RSS: Main: 223404032 14:46:03 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | Cycle 1(1): loaded http://localhost:33015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33015/tests/kraken/driver.html?testName=ai-astar) 14:46:05 INFO - PROCESS | 19633 | RSS: Main: 269803520 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | __start_tp_report 14:46:05 INFO - PROCESS | 19633 | _x_x_mozilla_page_load 14:46:05 INFO - PROCESS | 19633 | _x_x_mozilla_page_load_details 14:46:05 INFO - PROCESS | 19633 | |i|pagename|runs| 14:46:05 INFO - PROCESS | 19633 | |0;ai-astar;111;105;109;109;113;111;113;110;109;109 14:46:05 INFO - PROCESS | 19633 | |1;audio-beat-detection;153;122;128;170;135;126;160;130;159;132 14:46:05 INFO - PROCESS | 19633 | |2;audio-dft;160;161;161;160;159;160;160;162;161;160 14:46:05 INFO - PROCESS | 19633 | |3;audio-fft;75;74;77;115;75;76;73;74;96;75 14:46:05 INFO - PROCESS | 19633 | |4;audio-oscillator;82;82;123;82;83;84;119;82;82;128 14:46:05 INFO - PROCESS | 19633 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;116;117;118 14:46:05 INFO - PROCESS | 19633 | |6;imaging-darkroom;145;146;145;145;144;145;144;145;144;146 14:46:05 INFO - PROCESS | 19633 | |7;imaging-desaturate;95;95;95;95;94;94;95;95;95;94 14:46:05 INFO - PROCESS | 19633 | |8;json-parse-financial;63;54;55;54;55;55;54;69;53;51 14:46:05 INFO - PROCESS | 19633 | |9;json-stringify-tinderbox;61;62;61;61;61;61;67;62;61;67 14:46:05 INFO - PROCESS | 19633 | |10;stanford-crypto-aes;93;78;79;78;81;80;80;79;80;86 14:46:05 INFO - PROCESS | 19633 | |11;stanford-crypto-ccm;124;134;121;118;124;135;122;123;169;119 14:46:05 INFO - PROCESS | 19633 | |12;stanford-crypto-pbkdf2;162;158;159;158;162;159;160;158;159;157 14:46:05 INFO - PROCESS | 19633 | |13;stanford-crypto-sha256-iterative;63;66;63;66;62;63;63;62;62;61 14:46:05 INFO - PROCESS | 19633 | __end_tp_report 14:46:05 INFO - PROCESS | 19633 | __start_cc_report 14:46:05 INFO - PROCESS | 19633 | _x_x_mozilla_cycle_collect,1645 14:46:05 INFO - PROCESS | 19633 | __end_cc_report 14:46:05 INFO - PROCESS | 19633 | __startTimestamp1464212765689__endTimestamp 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | ------- Summary: start ------- 14:46:05 INFO - PROCESS | 19633 | Number of tests: 14 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.33 (2.1%) stddev-sans-first:2.44 14:46:05 INFO - PROCESS | 19633 | Values: 111.0 105.0 109.0 109.0 113.0 111.0 113.0 110.0 109.0 109.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:144.00 stddev:17.19 (11.9%) stddev-sans-first:17.73 14:46:05 INFO - PROCESS | 19633 | Values: 153.0 122.0 128.0 170.0 135.0 126.0 160.0 130.0 159.0 132.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 14:46:05 INFO - PROCESS | 19633 | Values: 160.0 161.0 161.0 160.0 159.0 160.0 160.0 162.0 161.0 160.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.71 (18.3%) stddev-sans-first:14.37 14:46:05 INFO - PROCESS | 19633 | Values: 75.0 74.0 77.0 115.0 75.0 76.0 73.0 74.0 96.0 75.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:82.00 stddev:19.88 (24.2%) stddev-sans-first:20.55 14:46:05 INFO - PROCESS | 19633 | Values: 82.0 82.0 123.0 82.0 83.0 84.0 119.0 82.0 82.0 128.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:46:05 INFO - PROCESS | 19633 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:46:05 INFO - PROCESS | 19633 | Values: 145.0 146.0 145.0 145.0 144.0 145.0 144.0 145.0 144.0 146.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:46:05 INFO - PROCESS | 19633 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:5.44 (9.9%) stddev-sans-first:5.20 14:46:05 INFO - PROCESS | 19633 | Values: 63.0 54.0 55.0 54.0 55.0 55.0 54.0 69.0 53.0 51.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:61.50 stddev:2.46 (4.0%) stddev-sans-first:2.55 14:46:05 INFO - PROCESS | 19633 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 67.0 62.0 61.0 67.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:4.67 (5.8%) stddev-sans-first:2.42 14:46:05 INFO - PROCESS | 19633 | Values: 93.0 78.0 79.0 78.0 81.0 80.0 80.0 79.0 80.0 86.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:124.00 stddev:15.21 (12.3%) stddev-sans-first:16.02 14:46:05 INFO - PROCESS | 19633 | Values: 124.0 134.0 121.0 118.0 124.0 135.0 122.0 123.0 169.0 119.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:1.69 (1.1%) stddev-sans-first:1.45 14:46:05 INFO - PROCESS | 19633 | Values: 162.0 158.0 159.0 158.0 162.0 159.0 160.0 158.0 159.0 157.0 14:46:05 INFO - PROCESS | 19633 | 14:46:05 INFO - PROCESS | 19633 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.76 14:46:05 INFO - PROCESS | 19633 | Values: 63.0 66.0 63.0 66.0 62.0 63.0 63.0 62.0 62.0 61.0 14:46:05 INFO - PROCESS | 19633 | -------- Summary: end -------- 14:46:05 INFO - PROCESS | 19633 | 14:46:06 INFO - TEST-INFO | 19633: exit 0 14:46:06 INFO - TEST-OK | kraken | took 60847ms 14:46:06 INFO - SUITE-END | took 1173s 14:46:06 INFO - Completed test suite (00:19:33) 14:46:06 INFO - javascript benchmark 14:46:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.6566177720456, 3142.1987393214727, 3163.01946396617, 3174.936501269973, 3201.087690008348, 5330.573554115671, 5380.273663055486, 5407.161889907071, 5457.181422786584, 5469.835904922854, 5318.335208098988, 5320.308359913215, 5430.15832545956, 5452.890942181154, 5477.5070243678065, 4796.808127674889, 4892.14387482191, 4904.975475122619, 4913.70517768935, 5170.431252562215, 5063.974680126613, 5104.489551044903, 5122.795088196486, 5131.0764062468925, 5178.948210517903, 4825.10735513931, 4853.563179313861, 4920.21276595743, 4987.526185012418, 4998.250262460624, 5000.924986125211, 5006.048850718352, 5012.0, 5080.415752188472, 5082.009008243394, 4970.564423432492, 4973.055119527278, 4988.451270360258, 5002.324686167393, 5036.647434679574, 5072.416672082684, 5291.28567643367, 5353.437889021675, 5451.073317536028, 5451.972740136274, 5885.4997325227405, 5911.793087241969, 5912.615679980788, 5917.911231331534, 5922.644641321534, 5885.999380105392, 5921.73352199152, 5921.970390148064, 5937.0, 5944.138099975523, 5194.298769666085, 5377.919331210035, 5428.83713488596, 5436.130219164994, 5501.367342755554, 6015.608985416022, 6029.758809647565, 6030.849228769316, 6039.78860739872, 6042.486388656926, 5779.0464573344925, 5791.88416231673, 5792.681402522818, 5795.536357091422, 5802.65184088956, 5532.585056120807, 5740.6268592541355, 5805.042168042311, 5859.472647461749, 5871.911921321183, 5705.4579814917515, 5713.171590119493, 5730.627509211888, 5738.971305143447, 5774.509166720792, 5737.85655358611, 5746.913796293059, 5751.626144300607, 5752.0, 5753.568482363839, 4268.0823622921225, 4289.935650965238, 4296.935545966813, 4349.565043495625, 4353.25994580922, 3910.6284902934176, 3913.6477717005605, 3944.1717239379477, 3953.2686453006286, 3959.9010024749614, 5446.8910621787345, 5489.478499542537, 5491.862703432366, 5563.248961390242, 5573.749181286852, 5792.971035144881, 5820.563457740686, 5842.620229685142, 5847.94152058474, 5909.2908850938165, 5470.425605311465, 5478.205660179252, 5526.198701188305, 5526.58550608706, 5527.695976721319, 4745.905081898342, 4909.558139767438, 4936.506349365107, 4941.752912354368, 4964.255361695775, 6165.506759459233, 6175.660338681416, 6182.474489668429, 6184.567080304426, 6184.907226391608, 5643.689597072201, 5907.320658124198, 5952.642841429441, 5960.0, 5971.940280597139, 5688.544916406595, 5987.550933680079, 6069.36271691466, 6101.786437474667, 6103.0, 5714.428557144252, 5760.395158508464, 5762.30852297727, 5764.827055188351, 5766.971165144148, 5589.860253493695, 5865.589408741347, 5878.853028674317, 5879.823605291848, 5880.059190529495, 5609.775608975759, 5632.464915832989, 5691.516221121251, 5710.200571920018, 5722.17028530869, 5709.914351284817, 5710.600257981901, 5714.485696287354, 5714.742836572281, 5717.857053573527, 5326.0679381107375, 5524.502794748492, 5630.634008789416, 5635.042042852807, 5638.436156384329, 5683.71581420919, 5798.971005144947, 5803.3616302207565, 5805.593608447368, 5807.070868660994, 5599.580031497572, 5607.8878422432135, 5613.101903695389, 5623.3814280428305, 5627.352854421631], "value": 5367.208456706749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.3066458240734, 626.5864529410588, 630.7067213745607, 644.893592557228, 647.4820143884891, 33047.66952330479, 35818.46272305914, 46215.537844621584, 47423.0, 47451.76274118625, 45364.865878353055, 46204.53795462044, 46262.306065409044, 46316.536834631646, 46472.30291545621, 8173.264406203441, 8729.825403491926, 8885.111488851095, 8926.821463570725, 8927.06265842087, 10211.285210035301, 10572.365658060502, 10576.947115264413, 10900.945495272512, 10907.781844363108, 10641.201909856753, 10828.620998265062, 10832.458377081153, 10834.104031794444, 10838.72903177423, 8199.057108432547, 10456.843147352796, 10667.306625069385, 10741.892581074168, 10767.676969690921, 10609.628662996834, 10715.83926241107, 10719.678409647722, 10721.731956701067, 10724.0, 42433.78783106096, 42778.0, 42858.57141428577, 42921.14157716859, 42936.0, 3690.686291665185, 3803.7147213959065, 3814.1227517670814, 4018.6148371201866, 4326.156399502099, 32641.673583264102, 32953.505697414315, 33431.83284083589, 33534.0, 33932.32135357304, 4397.362382454558, 4435.578620031092, 4481.708688935241, 4514.210013247702, 4656.930146047812, 323481.3825930879, 325804.0, 328669.0, 328882.0, 330342.0, 36248.63751362506, 54211.45788542143, 54526.0, 54597.45402546003, 54648.72675636596, 37140.0, 37219.0, 37468.81265593655, 37538.249235015144, 37542.06144846401, 15532.0, 15629.140397278032, 15700.293486793122, 15707.921460392625, 15712.371505139667, 12443.688907777378, 12519.248845069325, 12543.811842822364, 12545.74908501825, 12557.686057848627, 8399.790005249917, 8410.957945210235, 8427.662893484192, 8481.491110533389, 8488.957555212184, 3244.837758112085, 3250.8862189823244, 3263.0, 3270.8528116234825, 3278.2951665392056, 880.300161371711, 983.6901376066517, 1082.53992053377, 1133.5635780224673, 1199.7540504196618, 32757.344853102804, 32814.0, 32886.177845554055, 32977.505337419956, 33374.666253337644, 1100.8789033206501, 1121.8934201250868, 1166.4517676691942, 1200.765850659113, 1216.689744115245, 17118.630509559207, 17254.309827606754, 17443.825561744474, 17455.912720436318, 17479.825201748074, 542806.0, 546040.3167746571, 553456.0, 553572.0, 555701.0, 58867.705661472275, 60304.39695603075, 60375.39624603785, 60495.69752151211, 60515.39484605098, 1267.4106540458731, 1360.7346567419456, 1368.945242190321, 1371.3623165228016, 1376.9724605507834, 30827.537586935767, 33322.33355332831, 33518.497222542166, 33600.831995839864, 33610.49584256287, 50451.49548504468, 51112.0, 51167.23249151191, 51169.394754472276, 51248.74375628098, 384369.0, 392244.0, 392968.0, 393201.0, 395913.0, 24926.37684057913, 26891.327716807235, 27409.58885616757, 27752.167434976982, 29903.850480747456, 49020.5097949016, 49175.508244917095, 49533.50466495289, 50132.74933625309, 50259.24611130909, 41434.37848432216, 41598.792006039774, 42183.0, 42551.3617295747, 42595.5740442604, 40890.38664420095, 41500.1699966005, 41591.79204104081, 41676.16647666969, 41680.16639667129, 41024.79487602543, 41265.1746965053, 41274.1745165101, 41776.0, 41818.16363672649, 35293.29413411666, 36517.68038178225, 36806.815965919996, 36982.63017369899, 37543.62456375401, 28102.43795124127, 28117.43765124645, 28179.942056594722, 28352.0, 28388.0], "value": 19416.57225770836, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7573680055167, 399.4687066201952, 402.8589993502273, 403.78195774281886, 415.198666573513, 17724.291028358868, 19249.230030798786, 19269.518262043457, 19299.710504342427, 20298.289559865407, 17766.64466710665, 18480.815191848076, 18496.260149594, 19115.0, 19485.805141948575, 5253.553447956919, 5414.972925135388, 5511.9724401378135, 5727.455891690282, 5761.596688231825, 5986.670733109677, 5986.760529578812, 5997.070454079625, 6007.909881351783, 6035.275766907977, 5600.52395546379, 5772.076467765159, 5953.196318497013, 6039.063945088518, 6042.305134909476, 5722.742476588543, 5974.551908606872, 6007.609505382136, 6012.458878700938, 6350.936490635081, 5682.062459694187, 5807.30312362515, 5843.094320380348, 5844.240248767633, 5849.151872978395, 13977.510787122503, 14031.1581305121, 14043.578692639136, 14233.85766142346, 14252.21612811295, 2365.9116806269135, 2371.098982386682, 2386.4391867911027, 2430.0522796109353, 2443.4746529496065, 10411.635592754217, 10466.21503387249, 10803.459827008619, 10832.512536935857, 13566.796498052538, 1937.82559569638, 2013.1947221111673, 2031.563213909002, 2042.458748431667, 2045.427280361501, 80084.01358517523, 82835.58582207111, 82992.58503707443, 83732.58133709292, 84343.0, 9275.90724092764, 9668.951655241819, 9980.500974951223, 9981.850272245922, 10137.239707022003, 13343.399547020408, 13402.396892139877, 13428.798568021488, 13439.0, 13483.0, 7755.72854950074, 7922.088959769585, 7972.083210430758, 8119.878201826978, 8136.22705842944, 8069.596520173968, 8124.106348301682, 8158.510489370657, 8251.793705157419, 8312.958435207785, 4151.398047283127, 4183.5398106208295, 4187.120704651997, 4199.769012704331, 4222.239996800606, 2013.677811550145, 2017.9697304540443, 2020.5150763816873, 2035.2774764958522, 2045.9795402046086, 901.3014913442134, 1023.8003589300164, 1023.9129673977795, 1062.8830828608848, 1067.2102644043352, 19190.712139317922, 19684.0, 19697.606047878962, 19874.0, 19942.401727948185, 1005.8742657167854, 1011.585250047477, 1016.3038318751679, 1017.211660962745, 1022.5551884930079, 6292.874142517216, 10972.286801357886, 11086.889131108746, 11135.832962505569, 11167.106631469625, 290354.0, 319967.0, 335268.0, 470180.0, 470323.0, 92478.0, 94658.5267073674, 95787.0, 95882.52058739802, 97451.51274243584, 463.6406784741852, 467.64692657044395, 472.9030548737501, 474.058992899095, 475.06412367635704, 11075.501602428072, 11374.886251137383, 11612.187146899636, 11783.88216117862, 12006.579769708018, 40517.797411012754, 43553.78223108864, 43633.781831090644, 44539.10921781482, 46065.53934460613, 37932.810335949245, 39010.609893901834, 39270.41094383644, 45593.77203114096, 55209.44790552043, 8737.344699147463, 8956.776080597776, 9001.954990225007, 9106.134917182857, 9232.446053236827, 9776.755581110245, 13553.728925421634, 13817.930910345785, 14014.509492167725, 14246.857531424554, 11895.0, 12021.519139234333, 12156.75686486283, 12367.381630918599, 12527.624171274876, 11883.702907427383, 11976.700582485508, 12195.146339756131, 12307.75384492323, 12346.691332716753, 12292.446839892405, 12332.32172230536, 12384.690382740144, 12565.74868502643, 12626.621201363974, 8609.440386374865, 8703.086175951687, 8942.642294308154, 9076.954615226881, 9081.45511269326, 9317.86023209666, 11969.64091077269, 12453.501859925502, 12460.252384856938, 12512.93743531313], "value": 8742.034017940925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.466960550582, 1538.26163441548, 1550.5503404012836, 1754.1930711872537, 1877.080230686962, 8790.252828509576, 9147.359684822066, 9190.586423610945, 9409.811803763921, 9428.858567121499, 9060.682876099338, 9224.215941644952, 9261.444313341188, 9285.210757085639, 9297.442153470796, 2074.7925207479207, 2356.175338631474, 2401.7838394544533, 2421.5156968606348, 2430.453148041694, 2445.070873068232, 2452.239805660242, 2452.472718365551, 2452.8773561321864, 2455.8894849731805, 2388.3432056184515, 2406.42245860993, 2437.5612389769835, 2438.743931887153, 2440.3777036855577, 2035.155410504639, 2331.1374791327316, 2358.6933698619155, 2393.3777217923293, 2401.615741481372, 2359.362971997551, 2381.9047238110456, 2385.8329916905823, 2386.546556154325, 2402.159244264511, 9271.397359171633, 9320.30097742672, 9331.0, 9336.3464557481, 9338.112879276458, 5402.756875940592, 5538.806141785059, 5539.446055394468, 5543.307086614173, 5546.251256080418, 3523.312953973976, 3533.2050288685095, 3585.982070089633, 3681.226942342111, 3691.1325838427947, 1115.754534002518, 1130.2257953302014, 1132.6771870017005, 1170.6371024982197, 1185.9407029648482, 13116.147450415692, 13143.34283285832, 13155.671108222276, 13155.736885262337, 13158.473661053546, 4799.9760001199775, 4853.247746599282, 4975.353204083446, 4985.950140498621, 4992.450830408652, 10900.182486313399, 10920.890791092146, 10934.4532773361, 10950.890491095146, 10958.397288149228, 5556.833295001156, 5591.30108736408, 5592.720363981866, 5596.048671725816, 5598.664080155204, 4433.046894917608, 4974.77613507393, 5100.158473851773, 5104.744762761921, 5174.353205849269, 3860.903477413031, 3981.7212795104065, 4022.6178513041214, 4023.436718859362, 4074.6740260779065, 1280.0, 1285.0875878126449, 1299.2659147581776, 1305.053835968934, 1305.5169587252776, 988.8961659025699, 1046.1264843855465, 1051.8264486359665, 1056.572088304238, 1071.8231491803765, 6510.0, 6534.085228068075, 6572.507061970371, 6599.73601055962, 6664.8000559983275, 490.1422510606439, 495.40056531597173, 1007.5063219022773, 1063.2132222155703, 1119.0879433261866, 4458.621017213508, 4492.528284530143, 4519.525449827721, 4524.343970124313, 4548.090381923628, 11068.114550835913, 11402.486888090056, 11708.824367634492, 11720.531178752753, 11786.646400607995, 11343.773124537463, 11669.941650291694, 11831.88168118325, 11833.526658933719, 11847.703807404712, 8547.316214702809, 8765.254953329038, 8768.035516093225, 8777.999999999873, 8783.385163038654, 5734.799282025109, 6025.3070896845675, 6065.696715164312, 6134.969325153345, 6176.505879529716, 10663.680089597325, 10856.402897840695, 10953.780924381308, 10967.0, 11022.448877556251, 11105.888941110485, 11294.265872718248, 11371.601993930173, 11377.032952199155, 11389.43052847371, 7218.927810722035, 7979.321757650665, 8201.26188643025, 8302.211289927447, 8451.28164106058, 9181.586828592595, 9204.297205017094, 9293.303002274992, 9316.441013538939, 9327.58025888823, 8144.714934977247, 8281.917180828115, 8365.330773538224, 8407.53758543286, 8479.95760021196, 7795.298423141944, 7936.920630793618, 8138.389620778347, 8203.794905127419, 8262.215089566482, 7291.963540182477, 7344.669489872862, 7609.239076092346, 7628.8855667163925, 7632.542047477169, 5577.6653400796085, 5642.463965923231, 5660.066089095253, 5703.5722320826935, 5900.350961394329, 5735.254416925773, 5780.508656764054, 5799.449052340021, 5821.446962538552, 5877.471027607536], "value": 4885.298480717177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.93824576093795, 338.6765638814932, 346.1605606404469, 346.7763292676224, 349.47055211354785, 5403.432639572848, 5422.2951016367815, 5469.179623056543, 5473.972630136849, 5487.368952570456, 5334.973325133369, 5371.301730774994, 5388.7305634718305, 5397.3523177218785, 5427.937383794163, 3976.3637817949134, 4195.769232692201, 4200.474940632421, 4248.702590818644, 4276.700630955842, 4174.958250417502, 4189.748615083089, 4216.283231850577, 4217.45173127493, 4230.492340919094, 4171.374293855915, 4176.812043458037, 4196.496420429553, 4200.642945349649, 4213.620774130328, 4001.799910004488, 4065.512138543364, 4174.499060112776, 4189.413482112506, 4200.621944025022, 3666.2850744104912, 3675.2649470106085, 3679.3929001714687, 3687.4284485904727, 3693.8918324502542, 5025.974870125662, 5220.712860792655, 5252.3171987641745, 5261.184516399964, 5266.815661451869, 4620.260758278693, 4787.8563643090765, 4804.5916097131785, 4810.591099756525, 4834.129856625806, 5647.576431767634, 5649.209110724501, 5649.378568357477, 5657.321121465409, 5660.660360378391, 3903.2974064668347, 3974.0, 3995.3407687731487, 4000.2599519089063, 4006.2988976928923, 5775.942240577624, 5777.711114444303, 5795.40626327759, 5824.941750582525, 5841.37138287768, 4112.067328355668, 4112.218678451085, 4122.154958233555, 4125.360569111733, 4147.937780933288, 4023.2355852387955, 4177.456930599003, 4196.328587426058, 4198.307279298881, 4199.706020578591, 4723.574878260973, 4730.148573256847, 4741.43102827656, 4750.809967601257, 4786.16242157621, 5619.578531610146, 5620.971895140498, 5626.85932851682, 5690.207584610835, 5702.714864256771, 1377.435251546861, 1423.779314206279, 1443.2278730879138, 1446.9927650361892, 1448.6233579269465, 901.3285102598475, 917.6375331743924, 935.2471260635118, 939.3096074385321, 943.32080901752, 4896.314515967767, 4898.436679781799, 4908.509149085063, 4910.238912968495, 4941.925871111936, 5080.669756465818, 5150.742462876841, 5151.6908985461, 5185.081519837684, 5253.03203689914, 4955.4796746341835, 5218.66078704883, 5253.921191182136, 5482.890342193134, 5501.724913754377, 3055.3125546751803, 3066.6013418255484, 3072.2012276807745, 3076.6000419945262, 3080.6765289644263, 5825.50483208932, 5993.580449368589, 6033.276006879115, 6077.878442431127, 6085.908711369333, 5773.249477567973, 5849.94150058494, 5866.560007999417, 5867.64794112346, 5919.704014799243, 5977.252843394575, 6036.788712395133, 6061.575689701766, 6081.331053584102, 6084.543659225487, 5621.088829797888, 5739.282589676291, 5762.94237057624, 5786.566007549535, 5798.739056742541, 5716.771329146787, 5736.340320863154, 5736.799212027559, 5759.337676167127, 5777.653340799566, 5741.3971532988435, 6044.214252147192, 6054.3642917493025, 6082.2093127893095, 6087.4521293083835, 4084.183163367398, 4102.118044620421, 4107.137501124677, 4112.712110152261, 4112.856050038235, 5754.597178197486, 5766.221560089502, 5795.217645617956, 5822.912656310074, 5830.2420685310635, 5364.570834333322, 5605.309451463402, 5627.986962346817, 5659.490645841894, 5683.630564013326, 5615.943840561542, 5621.8594535136945, 5695.601307908407, 5700.714964251688, 5700.971495142498, 5490.670559766427, 5507.366652834975, 5518.2826232591115, 5593.328800543961, 5656.2929633795775, 5345.135926307042, 5578.748956297058, 5635.182898479616, 5665.291838520185, 5689.374168841507, 5375.543078838343, 5523.309586301712, 5540.916886246629, 5551.861203469945, 5568.415316391721], "value": 4270.3086194414545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.2289847543309, 852.2925971443706, 859.4284800607596, 869.1873098652757, 890.9732708018757, 14628.853711462896, 15176.620584485394, 15222.162781047038, 15223.238838058094, 15866.52400427989, 14492.492762753305, 14502.492412765556, 14547.78178327326, 14662.926685366558, 14757.18835464049, 680.7209044291841, 806.762005208462, 827.3546633625766, 838.2204549768712, 842.8819965204876, 811.2131232704268, 841.0748177005306, 845.471580262336, 846.2426128614886, 846.4667259626427, 882.9293656507464, 882.9558522073903, 884.5798245833209, 884.752269364579, 884.9513276769775, 721.4877437019722, 845.2688424512813, 866.7963028688316, 867.9435836670597, 883.5582208895552, 632.2570979099586, 632.424493710721, 632.5034847644623, 632.7658766256468, 633.607163558592, 15240.085594864344, 15243.0, 15286.159261240628, 15293.158876261801, 15302.081875087419, 14171.0, 14328.211948342838, 14355.641108972255, 14385.856141438557, 14466.566003019927, 12838.935805321007, 12971.610851674464, 13144.60566183016, 13229.735405291936, 13248.735025299537, 4496.775161241958, 4528.366028755977, 4572.908541829178, 4618.191816432144, 4660.300954856764, 59293.0, 60227.39772602262, 60523.69738151281, 60689.393106069256, 60900.0, 11325.2072354936, 11472.426378681033, 11485.138614603939, 11628.1860269782, 11736.237144585575, 21017.0, 21198.576028479652, 21208.787912120682, 21215.89392053061, 21513.892430537748, 8371.0, 8404.0, 8453.704120355758, 8559.786005349915, 8839.248663863515, 4583.495815460296, 4631.583157515773, 4662.510436404196, 4678.345031695565, 4770.642201834877, 3447.6897079262985, 3519.0322661268356, 3551.698105660996, 3558.697510711567, 3558.822058897045, 639.8176519691865, 643.3020173112226, 645.812714312844, 663.7610460234312, 664.378805816563, 660.8215781739, 699.6886385558479, 714.3213946750608, 745.4111252110772, 770.7456539342004, 9944.900550994542, 10068.617980101775, 10089.445080520494, 10095.840282791127, 10131.189504839595, 573.6099452372343, 610.716017052073, 628.8176428835586, 707.5507053021369, 715.9785206443711, 4480.439945006874, 4559.772011399416, 4593.540645935446, 4731.574158325767, 5190.403103643054, 73010.2698973014, 74830.25169748232, 75193.62403188058, 75699.24300757032, 76089.23910760932, 62090.68954655198, 63355.366446335865, 64236.0, 66332.0, 67667.0, 57631.42368576261, 58485.0, 58617.70691146517, 59741.0, 61164.0, 10396.116330112025, 10467.267291289536, 10516.68449946503, 10526.157907367238, 10585.9470702646, 36952.63047369492, 37040.6295937048, 37282.813585932985, 37386.62613373831, 37614.435783463814, 47535.52464475449, 50381.0, 51412.0, 53969.46944458319, 54719.0, 13093.738125237633, 13489.797653035015, 13498.662533436742, 13500.594982150551, 13579.185248885098, 14844.332005059583, 14909.17999509994, 15055.473058442902, 15110.924445377703, 15842.0, 14204.502842400467, 14342.0, 14651.706965860836, 14716.043457175248, 14720.77918831197, 13667.794983075062, 13782.86217137856, 13972.860271397156, 13996.37016334247, 14742.778858316919, 13923.373448195058, 14025.29873506341, 14035.438582456587, 14425.35085921115, 14731.484398046017, 11137.327041510141, 11345.262557933707, 11387.54449822031, 11943.94028029889, 12181.08641851847, 11580.88419115798, 11739.242924809785, 11907.345096019802, 11947.522099115939, 11965.222260553037], "value": 7283.053300809961, "unit": "score"}], "name": "dromaeo_css", "value": 7192.386931830397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 109.0, 113.0, 111.0, 113.0, 110.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 128.0, 170.0, 135.0, 126.0, 160.0, 130.0, 159.0, 132.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 160.0, 160.0, 162.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 115.0, 75.0, 76.0, 73.0, 74.0, 96.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 123.0, 82.0, 83.0, 84.0, 119.0, 82.0, 82.0, 128.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 144.0, 145.0, 144.0, 145.0, 144.0, 146.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 69.0, 53.0, 51.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 67.0, 62.0, 61.0, 67.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 78.0, 79.0, 78.0, 81.0, 80.0, 80.0, 79.0, 80.0, 86.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 121.0, 118.0, 124.0, 135.0, 122.0, 123.0, 169.0, 119.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 159.0, 158.0, 162.0, 159.0, 160.0, 158.0, 159.0, 157.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 66.0, 62.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1495.4, "alertThreshold": 2.0}]} 14:46:06 INFO - Return code: 0 14:46:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:46:07 ERROR - # TBPL SUCCESS # 14:46:07 INFO - Running post-action listener: _resource_record_post_action 14:46:07 INFO - ##### 14:46:07 INFO - ##### Finished run-tests step (success) 14:46:07 INFO - ##### 14:46:07 INFO - Running post-run listener: _resource_record_post_run 14:46:07 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 540897280; Read time: 0; Write time: 564780 14:46:07 INFO - TinderboxPrint: CPU usage
13.2% 14:46:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:46:07 INFO - TinderboxPrint: I/O write bytes / time
540,897,280 / 564,780 14:46:07 INFO - TinderboxPrint: CPU idle
8,253.4 (86.8%) 14:46:07 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 14:46:07 INFO - TinderboxPrint: Swap in / out
0 / 0 14:46:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253812736; Read time: 0; Write time: 303056 14:46:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 287084544; Read time: 0; Write time: 261724 14:46:07 INFO - Running post-run listener: _upload_blobber_files 14:46:07 INFO - Blob upload gear active. 14:46:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:46:07 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 14:46:07 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'] 14:46:07 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 14:46:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:08 INFO - (blobuploader) - INFO - Done attempting. 14:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:09 INFO - (blobuploader) - INFO - Done attempting. 14:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:46:13 INFO - (blobuploader) - INFO - Done attempting. 14:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 14:46:13 INFO - Return code: 0 14:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b35c9ff379bfcf85b32ab77a7c94a9bbec220d81c56ff893dc37506640b521615e17b5e12cd9907fccd050a1091e7f45347d38cd38ba64213de5b131b1769f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c2daab4b0f3b42e6da52fbbbfe10a631e7cfe61adb046c6d7fd5ac15e250d5a132117f10601f1f282287de4be15f640baf44cf75bb485fca8d1e2b03b2f75f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad444144dc2ce75a9af3826fe085b29ffad38a8eec57e22c56dd50def369779083e51130f667b20d7d41cd2f126d26c14609c9ea1ec555e3e28001c406e30417"} 14:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:46:13 INFO - Contents: 14:46:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b35c9ff379bfcf85b32ab77a7c94a9bbec220d81c56ff893dc37506640b521615e17b5e12cd9907fccd050a1091e7f45347d38cd38ba64213de5b131b1769f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c2daab4b0f3b42e6da52fbbbfe10a631e7cfe61adb046c6d7fd5ac15e250d5a132117f10601f1f282287de4be15f640baf44cf75bb485fca8d1e2b03b2f75f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad444144dc2ce75a9af3826fe085b29ffad38a8eec57e22c56dd50def369779083e51130f667b20d7d41cd2f126d26c14609c9ea1ec555e3e28001c406e30417"} 14:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 14:46:13 INFO - Copying logs to upload dir... 14:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 14:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.354334 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-25 14:46:13.310170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:46:13.313870) ========= 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=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b35c9ff379bfcf85b32ab77a7c94a9bbec220d81c56ff893dc37506640b521615e17b5e12cd9907fccd050a1091e7f45347d38cd38ba64213de5b131b1769f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c2daab4b0f3b42e6da52fbbbfe10a631e7cfe61adb046c6d7fd5ac15e250d5a132117f10601f1f282287de4be15f640baf44cf75bb485fca8d1e2b03b2f75f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad444144dc2ce75a9af3826fe085b29ffad38a8eec57e22c56dd50def369779083e51130f667b20d7d41cd2f126d26c14609c9ea1ec555e3e28001c406e30417"} build_url:https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/NrEsC-o6S4O3m6rRfS5fpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b35c9ff379bfcf85b32ab77a7c94a9bbec220d81c56ff893dc37506640b521615e17b5e12cd9907fccd050a1091e7f45347d38cd38ba64213de5b131b1769f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c2daab4b0f3b42e6da52fbbbfe10a631e7cfe61adb046c6d7fd5ac15e250d5a132117f10601f1f282287de4be15f640baf44cf75bb485fca8d1e2b03b2f75f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad444144dc2ce75a9af3826fe085b29ffad38a8eec57e22c56dd50def369779083e51130f667b20d7d41cd2f126d26c14609c9ea1ec555e3e28001c406e30417"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:46:13.341418) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:46:13.342048) ========= 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=62c568580acbfdaac3eec7be000001dc-1464211538.397589-121638080 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:46:13.425581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:46:13.425900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:46:13.426197) ========= ========= Total master_lag: 0.18 =========