builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1464145129.27 results: success (0) buildid: 20160524173017 builduid: 21dc8c984ecd44c581e20f7f7fc6d176 revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.268774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.269321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.269597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.285315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.285610) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 19:58:49-- 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% 40.4M=0s 2016-05-24 19:58:49 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.393376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.393882) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017148 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.447350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:49.447983) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 788365ddaf61746bc66479335ae72d3e566c38ec --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 788365ddaf61746bc66479335ae72d3e566c38ec --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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 19:58:49,799 truncating revision to first 12 chars 2016-05-24 19:58:49,799 Setting DEBUG logging. 2016-05-24 19:58:49,799 attempt 1/10 2016-05-24 19:58:49,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/788365ddaf61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 19:58:50,418 unpacking tar archive at: fx-team-788365ddaf61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:50.399168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:50.399468) ========= script_repo_revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:50.399862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:50.400135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:50.411150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-24 19:58:50.411422) ========= /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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:50 INFO - MultiFileLogger online at 20160524 19:58:50 in /builds/slave/test 19:58:50 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 19:58:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:50 INFO - {'append_to_log': False, 19:58:50 INFO - 'base_work_dir': '/builds/slave/test', 19:58:50 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:50 INFO - 'branch': 'Fx-Team', 19:58:50 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:50 INFO - 'config_files': ('talos/linux_config.py',), 19:58:50 INFO - 'default_actions': ('clobber', 19:58:50 INFO - 'read-buildbot-config', 19:58:50 INFO - 'download-and-extract', 19:58:50 INFO - 'populate-webroot', 19:58:50 INFO - 'create-virtualenv', 19:58:50 INFO - 'install', 19:58:50 INFO - 'run-tests'), 19:58:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:50 INFO - 'download_minidump_stackwalk': True, 19:58:50 INFO - 'download_symbols': 'ondemand', 19:58:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:50 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:50 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:50 INFO - 'installer_path': 'installer.exe', 19:58:50 INFO - 'log_level': 'info', 19:58:50 INFO - 'log_name': 'talos', 19:58:50 INFO - 'log_to_console': True, 19:58:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:50 INFO - 'opt_config_files': (), 19:58:50 INFO - 'pip_index': False, 19:58:50 INFO - 'sps_profile': False, 19:58:50 INFO - 'sps_profile_interval': 0, 19:58:50 INFO - 'suite': 'dromaeojs', 19:58:50 INFO - 'system_bits': '32', 19:58:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:50 INFO - 'title': 'talos-linux64-ix-047', 19:58:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:50 INFO - 'use_talos_json': True, 19:58:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:50 INFO - 'work_dir': 'build'} 19:58:50 INFO - ##### 19:58:50 INFO - ##### Running clobber step. 19:58:50 INFO - ##### 19:58:50 INFO - Running pre-action listener: _resource_record_pre_action 19:58:50 INFO - Running main action method: clobber 19:58:50 INFO - rmtree: /builds/slave/test/build 19:58:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:51 INFO - Running post-action listener: _resource_record_post_action 19:58:51 INFO - ##### 19:58:51 INFO - ##### Finished clobber step (success) 19:58:51 INFO - ##### 19:58:51 INFO - ##### 19:58:51 INFO - ##### Running read-buildbot-config step. 19:58:51 INFO - ##### 19:58:51 INFO - Running pre-action listener: _resource_record_pre_action 19:58:51 INFO - Running main action method: read_buildbot_config 19:58:51 INFO - Using buildbot properties: 19:58:51 INFO - { 19:58:51 INFO - "project": "", 19:58:51 INFO - "product": "firefox", 19:58:51 INFO - "script_repo_revision": "production", 19:58:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:51 INFO - "repository": "", 19:58:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:58:51 INFO - "buildid": "20160524173017", 19:58:51 INFO - "pgo_build": "True", 19:58:51 INFO - "basedir": "/builds/slave/test", 19:58:51 INFO - "buildnumber": 1182, 19:58:51 INFO - "slavename": "talos-linux64-ix-047", 19:58:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:58:51 INFO - "platform": "ubuntu64_hw", 19:58:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:51 INFO - "branch": "fx-team", 19:58:51 INFO - "repo_path": "integration/fx-team", 19:58:51 INFO - "revision": "788365ddaf61746bc66479335ae72d3e566c38ec", 19:58:51 INFO - "stage_platform": "linux64-pgo", 19:58:51 INFO - "builduid": "21dc8c984ecd44c581e20f7f7fc6d176", 19:58:51 INFO - "slavebuilddir": "test" 19:58:51 INFO - } 19:58:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:58:51 INFO - Running post-action listener: _resource_record_post_action 19:58:51 INFO - ##### 19:58:51 INFO - ##### Finished read-buildbot-config step (success) 19:58:51 INFO - ##### 19:58:51 INFO - ##### 19:58:51 INFO - ##### Running download-and-extract step. 19:58:51 INFO - ##### 19:58:51 INFO - Running pre-action listener: _resource_record_pre_action 19:58:51 INFO - Running main action method: download_and_extract 19:58:51 INFO - mkdir: /builds/slave/test/build/tests 19:58:51 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')]} 19:58:51 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:52 INFO - Downloaded 1361 bytes. 19:58:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:52 INFO - Using the following test package requirements: 19:58:52 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:58:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'jsshell-linux-x86_64.zip'], 19:58:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:52 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:52 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:52 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')]} 19:58:52 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:53 INFO - Downloaded 24417235 bytes. 19:58:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:58:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:58:54 INFO - Return code: 0 19:58:54 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 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:55 INFO - Downloaded 24417235 bytes. 19:58:55 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'] 19:58:55 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 19:58:57 INFO - Return code: 0 19:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:57 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:58 INFO - Downloaded 10840359 bytes. 19:58:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:58:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:58:59 INFO - Return code: 0 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/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 19:59:00 INFO - Downloaded 58621454 bytes. 19:59:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:59:00 INFO - mkdir: /builds/slave/test/properties 19:59:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:00 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:00 INFO - Contents: 19:59:00 INFO - build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:59:01 INFO - Running post-action listener: _resource_record_post_action 19:59:01 INFO - Running post-action listener: set_extra_try_arguments 19:59:01 INFO - ##### 19:59:01 INFO - ##### Finished download-and-extract step (success) 19:59:01 INFO - ##### 19:59:01 INFO - ##### 19:59:01 INFO - ##### Running populate-webroot step. 19:59:01 INFO - ##### 19:59:01 INFO - Running pre-action listener: _resource_record_pre_action 19:59:01 INFO - Running main action method: populate_webroot 19:59:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:01 INFO - '--tppagecycles', 19:59:01 INFO - '7'], 19:59:01 INFO - 'tests': ['tsvgm']}}, 19:59:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:59:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:59:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:59:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['damp', 'tps']}, 19:59:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'tests': ['damp', 'tps']}, 19:59:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['dromaeo_dom']}, 19:59:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'other-e10s': {'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['a11yr', 19:59:01 INFO - 'ts_paint', 19:59:01 INFO - 'tpaint', 19:59:01 INFO - 'sessionrestore', 19:59:01 INFO - 'sessionrestore_no_auto_restore', 19:59:01 INFO - 'tabpaint']}, 19:59:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['tsvgx', 19:59:01 INFO - 'tsvgr_opacity', 19:59:01 INFO - 'tart', 19:59:01 INFO - 'tscrollx', 19:59:01 INFO - 'cart']}, 19:59:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:59:01 INFO - 'tsvgr_opacity', 19:59:01 INFO - 'tart', 19:59:01 INFO - 'tscrollx', 19:59:01 INFO - 'cart']}, 19:59:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'talos_options': ['--disable-e10s'], 19:59:01 INFO - 'tests': ['tp5o']}, 19:59:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'tests': ['tp5o']}, 19:59:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'talos_options': ['--disable-e10s', 19:59:01 INFO - '--xperf_path', 19:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:01 INFO - 'tests': ['tp5n']}, 19:59:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:01 INFO - 'talos_options': ['--xperf_path', 19:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:01 INFO - 'tests': ['tp5n']}}, 19:59:01 INFO - 'talos.zip': {'path': '', 19:59:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:01 INFO - Running post-action listener: _resource_record_post_action 19:59:01 INFO - ##### 19:59:01 INFO - ##### Finished populate-webroot step (success) 19:59:01 INFO - ##### 19:59:01 INFO - ##### 19:59:01 INFO - ##### Running create-virtualenv step. 19:59:01 INFO - ##### 19:59:01 INFO - Running pre-action listener: _resource_record_pre_action 19:59:01 INFO - Running main action method: create_virtualenv 19:59:01 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:01 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 19:59:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:01 INFO - Using real prefix '/usr' 19:59:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:01 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:03 INFO - Installing pip.................done. 19:59:03 INFO - Return code: 0 19:59:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:59:03 INFO - Using env: {'DISPLAY': ':0', 19:59:03 INFO - 'HOME': '/home/cltbld', 19:59:03 INFO - 'LANG': 'en_US.UTF-8', 19:59:03 INFO - 'LANGUAGE': 'en_US:en', 19:59:03 INFO - 'LOGNAME': 'cltbld', 19:59:03 INFO - 'MAIL': '/var/mail/cltbld', 19:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:03 INFO - 'MOZ_NO_REMOTE': '1', 19:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:03 INFO - 'NO_EM_RESTART': '1', 19:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:03 INFO - 'PWD': '/builds/slave/test', 19:59:03 INFO - 'SHELL': '/bin/bash', 19:59:03 INFO - 'SHLVL': '1', 19:59:03 INFO - 'TERM': 'linux', 19:59:03 INFO - 'TMOUT': '86400', 19:59:03 INFO - 'USER': 'cltbld', 19:59:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:03 INFO - '_': '/tools/buildbot/bin/python'} 19:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:59:03 INFO - Cleaning up... 19:59:03 INFO - Return code: 0 19:59:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:59:03 INFO - Using env: {'DISPLAY': ':0', 19:59:03 INFO - 'HOME': '/home/cltbld', 19:59:03 INFO - 'LANG': 'en_US.UTF-8', 19:59:03 INFO - 'LANGUAGE': 'en_US:en', 19:59:03 INFO - 'LOGNAME': 'cltbld', 19:59:03 INFO - 'MAIL': '/var/mail/cltbld', 19:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:03 INFO - 'MOZ_NO_REMOTE': '1', 19:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:03 INFO - 'NO_EM_RESTART': '1', 19:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:03 INFO - 'PWD': '/builds/slave/test', 19:59:03 INFO - 'SHELL': '/bin/bash', 19:59:03 INFO - 'SHLVL': '1', 19:59:03 INFO - 'TERM': 'linux', 19:59:03 INFO - 'TMOUT': '86400', 19:59:03 INFO - 'USER': 'cltbld', 19:59:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:03 INFO - '_': '/tools/buildbot/bin/python'} 19:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:04 INFO - Downloading/unpacking psutil>=3.1.1 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:06 INFO - Installing collected packages: psutil 19:59:06 INFO - Running setup.py install for psutil 19:59:06 INFO - building 'psutil._psutil_linux' extension 19:59:06 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 19:59:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:59:06 INFO - building 'psutil._psutil_posix' extension 19:59:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:59:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:06 INFO - Successfully installed psutil 19:59:06 INFO - Cleaning up... 19:59:06 INFO - Return code: 0 19:59:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:59:06 INFO - Using env: {'DISPLAY': ':0', 19:59:06 INFO - 'HOME': '/home/cltbld', 19:59:06 INFO - 'LANG': 'en_US.UTF-8', 19:59:06 INFO - 'LANGUAGE': 'en_US:en', 19:59:06 INFO - 'LOGNAME': 'cltbld', 19:59:06 INFO - 'MAIL': '/var/mail/cltbld', 19:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:06 INFO - 'MOZ_NO_REMOTE': '1', 19:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:06 INFO - 'NO_EM_RESTART': '1', 19:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:06 INFO - 'PWD': '/builds/slave/test', 19:59:06 INFO - 'SHELL': '/bin/bash', 19:59:06 INFO - 'SHLVL': '1', 19:59:06 INFO - 'TERM': 'linux', 19:59:06 INFO - 'TMOUT': '86400', 19:59:06 INFO - 'USER': 'cltbld', 19:59:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:06 INFO - '_': '/tools/buildbot/bin/python'} 19:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:59:08 INFO - Installing collected packages: mozsystemmonitor 19:59:08 INFO - Running setup.py install for mozsystemmonitor 19:59:08 INFO - Successfully installed mozsystemmonitor 19:59:08 INFO - Cleaning up... 19:59:08 INFO - Return code: 0 19:59:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:08 INFO - Using env: {'DISPLAY': ':0', 19:59:08 INFO - 'HOME': '/home/cltbld', 19:59:08 INFO - 'LANG': 'en_US.UTF-8', 19:59:08 INFO - 'LANGUAGE': 'en_US:en', 19:59:08 INFO - 'LOGNAME': 'cltbld', 19:59:08 INFO - 'MAIL': '/var/mail/cltbld', 19:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:08 INFO - 'MOZ_NO_REMOTE': '1', 19:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:08 INFO - 'NO_EM_RESTART': '1', 19:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:08 INFO - 'PWD': '/builds/slave/test', 19:59:08 INFO - 'SHELL': '/bin/bash', 19:59:08 INFO - 'SHLVL': '1', 19:59:08 INFO - 'TERM': 'linux', 19:59:08 INFO - 'TMOUT': '86400', 19:59:08 INFO - 'USER': 'cltbld', 19:59:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:08 INFO - '_': '/tools/buildbot/bin/python'} 19:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:09 INFO - Downloading/unpacking blobuploader==1.2.4 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:11 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:11 INFO - Downloading docopt-0.6.1.tar.gz 19:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:11 INFO - Running setup.py install for blobuploader 19:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:11 INFO - Running setup.py install for requests 19:59:12 INFO - Running setup.py install for docopt 19:59:12 INFO - Successfully installed blobuploader requests docopt 19:59:12 INFO - Cleaning up... 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:12 INFO - Running setup.py (path:/tmp/pip-eeAZr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:12 INFO - Running setup.py (path:/tmp/pip-YEY60p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:12 INFO - Running setup.py (path:/tmp/pip-YYosq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:12 INFO - Running setup.py (path:/tmp/pip-CyrCmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:12 INFO - Running setup.py (path:/tmp/pip-cJLmmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:13 INFO - Running setup.py (path:/tmp/pip-aVbw2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:13 INFO - Running setup.py (path:/tmp/pip-lbsjJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:13 INFO - Running setup.py (path:/tmp/pip-Y0YX3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:13 INFO - Running setup.py (path:/tmp/pip-N8qrJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:13 INFO - Running setup.py (path:/tmp/pip-2NgVAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:13 INFO - Running setup.py (path:/tmp/pip-EuvqdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:13 INFO - Running setup.py (path:/tmp/pip-BwBmWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:13 INFO - Running setup.py (path:/tmp/pip-VDIWcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:13 INFO - Running setup.py (path:/tmp/pip-w7hMgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:13 INFO - Running setup.py (path:/tmp/pip-elfzt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:13 INFO - Running setup.py (path:/tmp/pip-RuNnf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:13 INFO - Running setup.py (path:/tmp/pip-nE9QBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:13 INFO - Running setup.py install for manifestparser 19:59:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:59:13 INFO - Running setup.py install for mozcrash 19:59:14 INFO - Running setup.py install for mozdebug 19:59:14 INFO - Running setup.py install for mozdevice 19:59:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Running setup.py install for mozfile 19:59:14 INFO - Running setup.py install for mozhttpd 19:59:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Running setup.py install for mozinfo 19:59:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Running setup.py install for mozInstall 19:59:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Running setup.py install for mozleak 19:59:14 INFO - Running setup.py install for mozlog 19:59:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:59:14 INFO - Running setup.py install for moznetwork 19:59:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Running setup.py install for mozprocess 19:59:15 INFO - Running setup.py install for mozprofile 19:59:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Running setup.py install for mozrunner 19:59:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Running setup.py install for mozscreenshot 19:59:15 INFO - Running setup.py install for moztest 19:59:15 INFO - Running setup.py install for mozversion 19:59:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:15 INFO - Cleaning up... 19:59:15 INFO - Return code: 0 19:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:59:15 INFO - Using env: {'DISPLAY': ':0', 19:59:15 INFO - 'HOME': '/home/cltbld', 19:59:15 INFO - 'LANG': 'en_US.UTF-8', 19:59:15 INFO - 'LANGUAGE': 'en_US:en', 19:59:15 INFO - 'LOGNAME': 'cltbld', 19:59:15 INFO - 'MAIL': '/var/mail/cltbld', 19:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:15 INFO - 'MOZ_NO_REMOTE': '1', 19:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:15 INFO - 'NO_EM_RESTART': '1', 19:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:15 INFO - 'PWD': '/builds/slave/test', 19:59:15 INFO - 'SHELL': '/bin/bash', 19:59:15 INFO - 'SHLVL': '1', 19:59:15 INFO - 'TERM': 'linux', 19:59:15 INFO - 'TMOUT': '86400', 19:59:15 INFO - 'USER': 'cltbld', 19:59:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:15 INFO - '_': '/tools/buildbot/bin/python'} 19:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:15 INFO - Running setup.py (path:/tmp/pip-2H2fdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:15 INFO - Running setup.py (path:/tmp/pip-P76q2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:16 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)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:16 INFO - Running setup.py (path:/tmp/pip-kSorXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:16 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)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:16 INFO - Running setup.py (path:/tmp/pip-jvVY3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:16 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)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:16 INFO - Running setup.py (path:/tmp/pip-EZXQP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:16 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)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:16 INFO - Running setup.py (path:/tmp/pip-bl9EqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:16 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)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:16 INFO - Running setup.py (path:/tmp/pip-9WlN7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:16 INFO - Running setup.py (path:/tmp/pip-nFTmeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:16 INFO - Running setup.py (path:/tmp/pip-sWcu8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:16 INFO - Running setup.py (path:/tmp/pip-zA8tdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:16 INFO - Running setup.py (path:/tmp/pip-CuWNO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:16 INFO - Running setup.py (path:/tmp/pip-tiC4mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:16 INFO - Running setup.py (path:/tmp/pip-1_5Ocp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:16 INFO - Running setup.py (path:/tmp/pip-f8IzOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:16 INFO - Running setup.py (path:/tmp/pip-WkJrLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:16 INFO - Running setup.py (path:/tmp/pip-_iu2TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:17 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)) 19:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:17 INFO - Running setup.py (path:/tmp/pip-n_eNYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:17 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)) 19:59:17 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)) 19:59:17 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)) 19:59:17 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)) 19:59:17 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)) 19:59:17 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)) 19:59:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:17 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 19:59:18 INFO - Downloading blessings-1.6.tar.gz 19:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:19 INFO - Installing collected packages: blessings 19:59:19 INFO - Running setup.py install for blessings 19:59:19 INFO - Successfully installed blessings 19:59:19 INFO - Cleaning up... 19:59:19 INFO - Return code: 0 19:59:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:19 INFO - Reading from file tmpfile_stdout 19:59:19 INFO - Current package versions: 19:59:19 INFO - argparse == 1.2.1 19:59:19 INFO - blessings == 1.6 19:59:19 INFO - blobuploader == 1.2.4 19:59:19 INFO - docopt == 0.6.1 19:59:19 INFO - manifestparser == 1.1 19:59:19 INFO - mozInstall == 1.12 19:59:19 INFO - mozcrash == 0.17 19:59:19 INFO - mozdebug == 0.1 19:59:19 INFO - mozdevice == 0.48 19:59:19 INFO - mozfile == 1.2 19:59:19 INFO - mozhttpd == 0.7 19:59:19 INFO - mozinfo == 0.9 19:59:19 INFO - mozleak == 0.1 19:59:19 INFO - mozlog == 3.2 19:59:19 INFO - moznetwork == 0.27 19:59:19 INFO - mozprocess == 0.22 19:59:19 INFO - mozprofile == 0.28 19:59:19 INFO - mozrunner == 6.11 19:59:19 INFO - mozscreenshot == 0.1 19:59:19 INFO - mozsystemmonitor == 0.3 19:59:19 INFO - moztest == 0.7 19:59:19 INFO - mozversion == 1.4 19:59:19 INFO - psutil == 3.1.1 19:59:19 INFO - requests == 1.2.3 19:59:19 INFO - wsgiref == 0.1.2 19:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:59:19 INFO - Using env: {'DISPLAY': ':0', 19:59:19 INFO - 'HOME': '/home/cltbld', 19:59:19 INFO - 'LANG': 'en_US.UTF-8', 19:59:19 INFO - 'LANGUAGE': 'en_US:en', 19:59:19 INFO - 'LOGNAME': 'cltbld', 19:59:19 INFO - 'MAIL': '/var/mail/cltbld', 19:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:19 INFO - 'MOZ_NO_REMOTE': '1', 19:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:19 INFO - 'NO_EM_RESTART': '1', 19:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:19 INFO - 'PWD': '/builds/slave/test', 19:59:19 INFO - 'SHELL': '/bin/bash', 19:59:19 INFO - 'SHLVL': '1', 19:59:19 INFO - 'TERM': 'linux', 19:59:19 INFO - 'TMOUT': '86400', 19:59:19 INFO - 'USER': 'cltbld', 19:59:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:19 INFO - '_': '/tools/buildbot/bin/python'} 19:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:59:19 INFO - Cleaning up... 19:59:19 INFO - Return code: 0 19:59:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:59:19 INFO - Using env: {'DISPLAY': ':0', 19:59:19 INFO - 'HOME': '/home/cltbld', 19:59:19 INFO - 'LANG': 'en_US.UTF-8', 19:59:19 INFO - 'LANGUAGE': 'en_US:en', 19:59:19 INFO - 'LOGNAME': 'cltbld', 19:59:19 INFO - 'MAIL': '/var/mail/cltbld', 19:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:19 INFO - 'MOZ_NO_REMOTE': '1', 19:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:19 INFO - 'NO_EM_RESTART': '1', 19:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:19 INFO - 'PWD': '/builds/slave/test', 19:59:19 INFO - 'SHELL': '/bin/bash', 19:59:19 INFO - 'SHLVL': '1', 19:59:19 INFO - 'TERM': 'linux', 19:59:19 INFO - 'TMOUT': '86400', 19:59:19 INFO - 'USER': 'cltbld', 19:59:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:19 INFO - '_': '/tools/buildbot/bin/python'} 19:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:19 INFO - Downloading/unpacking jsonschema 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:21 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:21 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:22 INFO - warning: no files found matching '*.txt' 19:59:22 INFO - no previously-included directories found matching 'build' 19:59:22 INFO - no previously-included directories found matching 'dist' 19:59:22 INFO - no previously-included directories found matching '.git*' 19:59:22 INFO - Installing collected packages: jsonschema, functools32 19:59:22 INFO - Running setup.py install for functools32 19:59:22 INFO - warning: no files found matching '*.txt' 19:59:22 INFO - no previously-included directories found matching 'build' 19:59:22 INFO - no previously-included directories found matching 'dist' 19:59:22 INFO - no previously-included directories found matching '.git*' 19:59:22 INFO - Successfully installed jsonschema functools32 19:59:22 INFO - Cleaning up... 19:59:22 INFO - Return code: 0 19:59:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:59:22 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')]} 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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')]} 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:22 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 0x7f5acbdddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e30770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', '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 19:59:22 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 19:59:22 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 19:59:22 INFO - Using env: {'DISPLAY': ':0', 19:59:22 INFO - 'HOME': '/home/cltbld', 19:59:22 INFO - 'LANG': 'en_US.UTF-8', 19:59:22 INFO - 'LANGUAGE': 'en_US:en', 19:59:22 INFO - 'LOGNAME': 'cltbld', 19:59:22 INFO - 'MAIL': '/var/mail/cltbld', 19:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:22 INFO - 'MOZ_NO_REMOTE': '1', 19:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:22 INFO - 'NO_EM_RESTART': '1', 19:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:22 INFO - 'PWD': '/builds/slave/test', 19:59:22 INFO - 'SHELL': '/bin/bash', 19:59:22 INFO - 'SHLVL': '1', 19:59:22 INFO - 'TERM': 'linux', 19:59:22 INFO - 'TMOUT': '86400', 19:59:22 INFO - 'USER': 'cltbld', 19:59:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:22 INFO - '_': '/tools/buildbot/bin/python'} 19:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:22 INFO - Downloading/unpacking flake8 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:25 INFO - no previously-included directories found matching 'docs/_build' 19:59:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:25 INFO - Running setup.py install for pep8 19:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:25 INFO - no previously-included directories found matching 'docs/_build' 19:59:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:59:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:25 INFO - Cleaning up... 19:59:25 INFO - Return code: 0 19:59:25 INFO - Running post-action listener: _resource_record_post_action 19:59:25 INFO - Running post-action listener: _start_resource_monitoring 19:59:25 INFO - Starting resource monitoring. 19:59:25 INFO - ##### 19:59:25 INFO - ##### Finished create-virtualenv step (success) 19:59:25 INFO - ##### 19:59:25 INFO - ##### 19:59:25 INFO - ##### Running install step. 19:59:25 INFO - ##### 19:59:25 INFO - Running pre-action listener: _resource_record_pre_action 19:59:25 INFO - Running main action method: install 19:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:25 INFO - Reading from file tmpfile_stdout 19:59:25 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:25 INFO - Reading from file tmpfile_stdout 19:59:25 INFO - Output received: 19:59:25 INFO - Usage: mozinstall [options] installer 19:59:25 INFO - Options: 19:59:25 INFO - -h, --help show this help message and exit 19:59:25 INFO - -d DEST, --destination=DEST 19:59:25 INFO - Directory to install application into. [default: 19:59:25 INFO - "/builds/slave/test"] 19:59:25 INFO - --app=APP Application being installed. [default: firefox] 19:59:25 INFO - mkdir: /builds/slave/test/build/application 19:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:59:42 INFO - Reading from file tmpfile_stdout 19:59:42 INFO - Output received: 19:59:42 INFO - /builds/slave/test/build/application/firefox/firefox 19:59:42 INFO - Running post-action listener: _resource_record_post_action 19:59:42 INFO - ##### 19:59:42 INFO - ##### Finished install step (success) 19:59:42 INFO - ##### 19:59:42 INFO - ##### 19:59:42 INFO - ##### Running run-tests step. 19:59:42 INFO - ##### 19:59:42 INFO - Running pre-action listener: _resource_record_pre_action 19:59:42 INFO - Running main action method: run_tests 19:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:42 INFO - Python 2.7.3 19:59:42 INFO - Return code: 0 19:59:42 INFO - grabbing minidump binary from tooltool 19:59:42 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')]} 19:59:42 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 0x1ebf9c0>, '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 0x1ec08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:42 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 19:59:42 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 19:59:42 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 19:59:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:42 INFO - Return code: 0 19:59:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:59:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:59:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:59:43 INFO - Return code: 0 19:59:43 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/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 19:59:43 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/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 19:59:43 INFO - Using env: {'DISPLAY': ':0', 19:59:43 INFO - 'HOME': '/home/cltbld', 19:59:43 INFO - 'LANG': 'en_US.UTF-8', 19:59:43 INFO - 'LANGUAGE': 'en_US:en', 19:59:43 INFO - 'LOGNAME': 'cltbld', 19:59:43 INFO - 'MAIL': '/var/mail/cltbld', 19:59:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:43 INFO - 'MOZ_NO_REMOTE': '1', 19:59:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:43 INFO - 'NO_EM_RESTART': '1', 19:59:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:43 INFO - 'PWD': '/builds/slave/test', 19:59:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:43 INFO - 'SHELL': '/bin/bash', 19:59:43 INFO - 'SHLVL': '1', 19:59:43 INFO - 'TERM': 'linux', 19:59:43 INFO - 'TMOUT': '86400', 19:59:43 INFO - 'USER': 'cltbld', 19:59:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313', 19:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:43 INFO - '_': '/tools/buildbot/bin/python'} 19:59:43 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/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 19:59:43 INFO - mozversion application_buildid: 20160524173017 19:59:43 INFO - mozversion application_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 19:59:43 INFO - mozversion application_display_name: Nightly 19:59:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:43 INFO - mozversion application_name: Firefox 19:59:43 INFO - mozversion application_remotingname: firefox 19:59:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:43 INFO - mozversion application_vendor: Mozilla 19:59:43 INFO - mozversion application_version: 49.0a1 19:59:43 INFO - mozversion platform_buildid: 20160524173017 19:59:43 INFO - mozversion platform_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 19:59:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:43 INFO - mozversion platform_version: 49.0a1 19:59:43 INFO - using testdate: 1464145183 19:59:43 INFO - actual date: 1464145183 19:59:43 INFO - starting webserver on 'localhost:50380' 19:59:43 INFO - SUITE-START | Running 2 tests 19:59:43 INFO - TEST-START | dromaeo_css 19:59:43 INFO - operating with platform_type : linux_ 19:59:43 INFO - Initialising browser for dromaeo_css test... 19:59:43 INFO - TEST-INFO | started process 7826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWeEqg6/profile http://localhost:50380/getInfo.html) 19:59:47 INFO - PROCESS | 7826 | __metrics Screen width/height:1600/1200 19:59:47 INFO - PROCESS | 7826 | colorDepth:24 19:59:47 INFO - PROCESS | 7826 | Browser inner width/height: 1024/697 19:59:47 INFO - PROCESS | 7826 | __metrics 19:59:48 ERROR - PROCESS | 7826 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:59:49 INFO - TEST-INFO | 7826: exit 0 19:59:49 INFO - Browser initialized. 19:59:49 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:49 INFO - TEST-INFO | started process 7907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWeEqg6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:01 INFO - PROCESS | 7907 | RSS: Main: 153227264 20:00:01 INFO - PROCESS | 7907 | 20:00:52 INFO - PROCESS | 7907 | 1464145252176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:03:00 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50380/tests/dromaeo/cssquery-ext.html) 20:03:01 INFO - PROCESS | 7907 | RSS: Main: 259665920 20:03:01 INFO - PROCESS | 7907 | 20:06:03 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-ext.html (next: http://localhost:50380/tests/dromaeo/cssquery-jquery.html) 20:06:03 INFO - PROCESS | 7907 | RSS: Main: 236085248 20:06:03 INFO - PROCESS | 7907 | 20:09:05 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50380/tests/dromaeo/cssquery-mootools.html) 20:09:06 INFO - PROCESS | 7907 | RSS: Main: 239054848 20:09:06 INFO - PROCESS | 7907 | 20:12:08 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50380/tests/dromaeo/cssquery-prototype.html) 20:12:08 INFO - PROCESS | 7907 | RSS: Main: 226267136 20:12:08 INFO - PROCESS | 7907 | 20:15:11 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50380/tests/dromaeo/cssquery-yui.html) 20:15:12 INFO - PROCESS | 7907 | RSS: Main: 221478912 20:15:12 INFO - PROCESS | 7907 | 20:18:14 INFO - PROCESS | 7907 | Cycle 1(1): loaded http://localhost:50380/tests/dromaeo/cssquery-yui.html (next: http://localhost:50380/tests/dromaeo/cssquery-dojo.html) 20:18:15 INFO - PROCESS | 7907 | RSS: Main: 254533632 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | __start_tp_report 20:18:15 INFO - PROCESS | 7907 | _x_x_mozilla_page_load 20:18:15 INFO - PROCESS | 7907 | _x_x_mozilla_page_load_details 20:18:15 INFO - PROCESS | 7907 | |i|pagename|runs| 20:18:15 INFO - PROCESS | 7907 | |0;dojo.html;3087.5677405163283;3090.613673290837;3114.377124575085;3130.3895740330645;3145.0564830550843;5142.460041695625;5226.7909283628705;5244.318238628977;5334.813281535142;5336.493033161843;5353.437889021655;5377.381601115872;5379.112446446342;5412.323459567554;5455.454454554542;4617.284320930261;4881.219004959198;4934.309196712463;4945.085159245533;4950.034743225073;4677.4620918594455;4901.4608393076915;4931.5068493150575;4940.950590494085;4948;4766.499517550659;4801.567858892699;4821.855344339658;4842.031593681278;4843.66094373394;4754.477007529169;4806.086843499724;4806.735629540374;4807.062622788558;4852.708837469763;4688.929666055012;4754.952450475485;4762.928556071662;4766.76166191689;4795.2807078938085;5329.520343169133;5348.839534813962;5358.383785864637;5366.4633536646415;5373.978944000627;5721.342045664718;5730.971345143289;5731.942680573183;5766.625169363978;5766.884662306772;5558.194061861048;5713.028785106542;5726.427357264281;5733.799317023926;5773.509251713609;5438.320209973754;5463.125899856004;5465.426130256305;5469.425710300441;5475.917861232085;5932.49573786233;5949.940500594938;5951.077582974646;5952.940470595238;5954.225950626391;5524.861878453071;5589.105743081088;5619.8033068843215;5624.409437009137;5727.11229759388;5768.538516918637;5812.593118481665;5814.651120932757;5817.825465236049;5824.563157763185;5742.31092268922;5749.281339832521;5752.194692743019;5755.021646320136;5755.913661295084;5498.1752737088955;5657.6039677223025;5695.800646977336;5697.316322041299;5738.512226460714;4358.171947329997;4364.170807546556;4365.388845561624;4368.7815609219415;4387.758673273001;3824.5984171661576;3869.3035253654048;3907.257621051991;3959.97040769402;3967.6627486663956;5345.305110335631;5345.919811202835;5390.67655940637;5411.810586629449;5417.079096553595;5663.433656634386;5674.319081710221;5702.173184888168;5719.628224165416;5760.683162426107;5289.3652761668845;5294.391145018295;5307.575393968474;5403.540699040625;5417.783288668488;4881.560659540658;4893.7063776173545;4902.460729319772;4933.407991041098;4938.160512712848;5846.444587764156;5848.415158484203;5857.004309267435;5859.824205273849;5865.472107510259;5510.779568817203;5657.15142728594;5746.885062298814;5791.710414479344;5797.507211887037;6027.336992930686;6038.365971573097;6043.456088952015;6047.153398524122;6053.031514957585;5712.171735098471;5714.514266287246;5721.628094173865;5721.828345149652;5725.341585717696;5609.663420194802;5621.831345059655;5643.830685079454;5668;5798.33319168301;5525.254090697865;5537.612367134262;5537.9169312459535;5543.667379957215;5547.0570003098765;5473.8357849264585;5487.780488780564;5523.585731070266;5542.473465020817;5570.749316280696;5411.864703382447;5488.0395930711165;5513.61404701667;5540.612157149122;5589.133684278943;5671.574631902707;5685.431456854281;5686;5729.570282228766;5730.684812335361;5299.735013249399;5570.303712035996;5571.721413929368;5576.86057848557;5611.102223644198 20:18:15 INFO - PROCESS | 7907 | |1;ext.html;586.8591538030873;616.8427051101968;629.8299459146031;634.0584232414864;636.9681515924202;43526.78236608816;45101.54898451015;45117;45335.54664453355;49215.75392123043;45674;46100;46154;46218.76890615551;46238.768806155924;8691.913080869173;8854.513001784899;8858;8865.468071915706;8870.822583548324;8729.170728780788;8848.070952549953;8867.201951824334;8870.290376769875;8873.157050080265;8904.198622124008;8936.910630893706;8952.8657070144;8953.23897468716;8966.058563850767;8876.378653494257;8921.955390223073;8923.732288031337;8925.464472131693;8934.910650893473;8834.69078582253;8934.525803242457;8936.195742383152;8937.150970657776;8947.731568052968;43394.78302608467;44045.55954440447;44083.338749918774;44150;44174.453894113874;3092.721655051034;3456.861725530976;3666.7066634669163;3676.246369494247;3794.582595914447;32393.35213295721;32495.83752081248;32837.83581082103;33135;33543.161420964425;4159.251334759742;4190.476190476191;4200.70595058346;4282.400463935051;4343.717658352229;326828;330096;330426;331034;332243;34839.4774078389;54203;54928;55001;55070.173947390824;35317.64682353195;37159.4426083609;37201.44197837035;37224;37228;14292.213928234047;14483.203423811581;14488.058276212012;14498.130112193303;14518.419263229564;11947.880521194851;12034.277943323428;12035.037197024218;12036.518539258506;12037.578684746168;8384.8742268866;8436.831263374821;8439.746807595782;8443.957780211182;8534.402591818638;3308.7022168004996;3326.2183386904057;3334.133125387417;3346.6987971082717;3349.849256783402;1078.8489611454402;1079.422508957704;1086.1528008153653;1139.9911078695413;1177.3701069927547;32776.180595485304;33351.83324083364;33703.73514855166;33972.83013584916;34159.31681366359;1072.951717172729;1203.6389083274983;1211.6062279758937;1223.7063104854772;1239.9318037507844;17543.21055552503;17598.82401175972;17730.379436719653;17778.37775677845;17785.46643600694;562576;565097;567296;569702;570896;60481.39518604846;60956;61018;61024;61043.6947815267;1216.7262365967763;1294.7863602505481;1318.0575888239955;1413.8162038934872;1421.9289035548181;32530;33788.493172602924;33839.19633029386;34147.829260853534;34664.480032800035;51014.74492627513;51346.74326628343;51725;51788.48211517837;51863;366133;366889;366924;367931;368708;23308.76691233066;27932.581011285252;28505.42989140247;28707.138785836458;28745.281367965967;49399;49649.25526117039;50047.49952500574;50456.74771626118;50629.49370506395;41048.384274235315;42220.301123842895;42822.78588607037;42998.570014299454;43717.344239835795;40694.59305407026;41242.79378603088;41268.38097428481;41810;41885.162296754504;40999.38500922548;42344.153116938105;42545.78727106345;42619;42727.3590896143;35304.64695353014;36520.52377506663;37204.44193337048;37466.43800342942;37835.81082094572;28202.85898570576;28454;28570.14289571316;28881.855590721912;28931.710682892903 20:18:15 INFO - PROCESS | 7907 | |2;jquery.html;373.5965157629762;386.26031150347086;396.6667998880939;399.7841165770484;402.48481943112824;17490.737638935425;19392.70910936337;19792.40622781319;19871.602567948634;19889.204431822727;17523.38668146612;17690;17875.463736087906;18036.368727094556;18174.091295435243;5573.4147914469;5608.327000759915;5724.885502289952;5809.73856176471;5827.825165245049;4083.3466645336753;6109.419605137505;6484.740610375579;6489.902651460232;6498.545101842873;6274.592151510137;6413.518986076039;6423.29343772187;6430.0354946758125;6502.967485162568;4099.795010249476;6437.806865793987;6491.188601424822;6497.935020649804;6504.252011018746;5363.517283444469;5672.858178545528;5674.319081710221;5767.942320576783;5771.278590176228;22262.55474890493;22509.77490225093;22528.662070068964;23374.415639608975;23377;2304.7695230476984;2374.9881250593808;2442.6091825307867;2503.574392353304;2856.043225519433;15455.61360965985;16010.5997350066;16028.439004634782;16149.385061493875;16251.349946002263;2027.5742094160244;2039.7144399784042;2061.907214175351;2085.9061342239634;2173.2067795254775;90419;92818;95326.52336738342;95495.04504954931;95808;16792.664146716997;17192.828071719123;17434.389796357067;17540;17873.28506859711;30783;30877.228069298;31117.377652446823;31148;31299.374012519624;9242.584083716249;9568.4737339447;9585.952070239744;9648.179904708039;9860.556274967643;7904.2095790421645;7934.651109311431;8076.55578943152;8077.071136819341;8150.551719655476;7229.567012336033;8591.93793489558;8829;8930.419522731001;9195.126462986005;2935.251510864716;3205.7114859662743;3208.2941752814345;3246.4481038223557;3610.9638903610626;717.5264325545115;963.2149797914677;1003.603576587244;1013.9353678637401;1015.2994433840627;18078.3672571462;18364.908175459037;18385.26458941654;19023.334183303796;19197.616047678966;965.2567523007245;970.84466485362;976.8534719791946;1011.858339832424;1016.8423894296396;10165.949170254102;10744.355338679548;10751.0324070834;10752.139828813677;10775;484092;490022;493262;506042;507347;88215.55892220497;91568.54215728879;91929;92119;93160.53419732858;972.5380444288907;978.7210644966151;987.2003677021636;1017.1151098544166;1017.6845177994845;16196.271167797242;16306.18469076565;16639;16691.332346705996;16822.242999064827;29241;36606;39744.20511589694;40011.399829003174;40274.798626007854;53816.730916345165;56001.15998259948;56670;56688.43311566832;57192.142117867435;8113.797155071171;8244.340452763645;8256.422050456411;8281.627326770431;8362.080171181044;9663.371880827724;10271.589136434757;12730.363481825687;13144.474221031052;13464.326783660581;11507.424628768695;11595.796798608237;11855.822162667739;11863.822042669195;11931.642050738492;11164.274322169033;11431.771364572829;11696.649100526998;11782.293062416282;11946.104042197045;11751.177417580688;11875.821862671894;11913.344766037952;12030.819537706766;12111.333876636869;8243.299319557666;8275.668973241003;8283.420160588941;8356.122607126164;8839.646414143363;11469.369184694922;11697.766044679229;11832.230904991147;12013.219140755822;12042.397880106135 20:18:15 INFO - PROCESS | 7907 | |3;mootools.html;1317.855035946045;1490.7167638148753;1532.0654400815504;1614.2655091933173;1808.2315016118139;8089.555074470902;8418.200270974256;8441.577921103935;8619.569021548929;8623.267022303111;8448.493090414579;8619;8623.525706086162;8637.827243455127;8641.65433382664;1985.205917632944;2181.923632672857;2260.977390226093;2266.5693518231483;2294.655801629752;2229.899654515543;2238.1271304191296;2238.160689741347;2243.2036626997424;2243.6858839762444;2259.152817693365;2259.89830457629;2319.246244970383;2319.8724070176136;2323.546908352872;1872.5973915608142;2115.883626400547;2170.8806015669134;2178.9782102178933;2215.601191785478;2213.380253529014;2237.093976939342;2240.1039584166465;2240.932772016842;2259.35608351619;8538.573071346469;8579.914200858037;8609.053004169537;8609.26821220197;8615.052344242129;5069.974650126763;5189.662671926313;5200.427952925175;5213.374395072616;5214.921776173361;2986.1489475499598;3066.463368910454;3139.293658926746;3151.16494129056;3173.587433633613;1017.4048181813574;1062.6015244283394;1076.5155679944057;1089.2320913755784;1095.8356246563;12069.577564785279;12110.212836165621;12115.818262725978;12128.272303661808;12129.575464858775;4398.934015989698;4487.080148569536;4542.432195975503;4561.589456948891;4642.744649044267;10080.798384032425;10113.747156321151;10128.34165779222;10155.64455244063;10159.9492002541;5107.8723031923755;5115.309433226541;5124.461931497139;5125.1799712045895;5127.333446651986;4204.180184863983;4349.173657005159;4466.932996005063;4468.218061839165;4536.750478723702;3966.147278335172;3991.840326386912;4049.5545489996075;4062.614051665087;4092.7748973806724;1263.8988880889506;1276.7446510697898;1276.7446510697898;1294.0618051912288;1309.4500309869877;933.2394098809449;998.1066945084109;998.4907697074399;1011.5397494140149;1031.886492485826;5971.5222782177325;5983.102534619842;6010.4891084258325;6018.8194354169445;6289.811305660837;977.7799995001068;989.9010098990043;998.4408731110601;1001.3140998416109;1028.0233777911014;3821.6560509554274;4043.029672878547;4050.007748101734;4072.6945479089186;4105.4662893823615;10251.38491690501;10322.896771032343;10496.527656255486;10577.524011419504;10618.840717389245;10324.690259292232;10360.119389851947;10435.37387756722;10440.112590429899;10472.371657700562;8079.4344395892895;8116.5941702914615;8242.17578242171;8274.29668478174;8277.130901255401;5694.345150307602;5857.824265271878;5874.383189765184;5896.587238893237;5907.556933229939;9864.802703946025;10013.599456021677;10052.396856188652;10123.443210623487;10162.187025038127;10155.39067655943;10190.388576685422;10208.132308753542;10256.17950563968;10323.535440905027;6361.745530178741;6886.10480637514;7093.82265443368;7108.07595012645;7201.783946481614;8303.00363956329;8319.084900660802;8346.916530834615;8363.330933525182;8386.706465273686;7241.710331586678;7356.852862942818;7440.479166458296;7472.962635186789;7538.982237397881;7084.504084714021;7187.389071928945;7247.673854676446;7283.198848126808;7419.962900185465;6924.930750692429;6960.79117626472;7004.3696067354185;7008.264132266243;7016.052832867497;4944.134776414041;5007.899842003067;5030.2957585937265;5126.256692779451;5188.9740551297;5130.769115389891;5200.375954885287;5232.476752324737;5336.626436149432;5394.217838413487 20:18:15 INFO - PROCESS | 7907 | |4;prototype.html;325.0621955657927;328.1942830351486;334.44816053511704;343.97248220142393;346.7053004945795;5162.174052151657;5236.581073514119;5257.526822585966;5334.1732031535075;5355.678659280441;5190.195519694444;5231.529162375386;5234.063396543284;5246.7638956246965;5248.212768084789;4102.220578090169;4103.466549348581;4109.21924834282;4122.443470131524;4137.13120244749;3901.2782635212575;3929.7249192556533;4049.311617025113;4096.160287141144;4120.979395103035;4034;4064.5732198119217;4076.8165432555606;4119.40268661044;4119.711620186588;4027.261462205699;4069.860439077078;4072.2059198456313;4085.673146148301;4093.9590604093873;3562.358775420423;3624.6194149614175;3657.4696668982847;3664.853405863789;3675.3568125578186;5009.44896061433;5048;5059.16523773577;5062.772175252086;5077.543021128116;4669.252919532859;4671.766411679437;4680.602148817355;4680.789364478606;4690.882727931795;5181.792728290864;5411.83764487066;5420.647657902263;5425.26758887553;5434.429384914567;3918.2555314490155;3920.862769803043;3925.489686340786;3932.8820135395986;3943.7633741975287;5609.5792815539;5669.149627555858;5695.259616249861;5697.572682048822;5718.0851063830005;4031.133306339151;4033.657139143147;4035.7174997750462;4059.106996460774;4069.593040695907;3974.205158968218;4102.958970410257;4119.567445418248;4135.545090040093;4138.379243113497;4593.586577208067;4657.6506761992305;4674.649401294916;4680.438347398334;4682.150550532589;5455.427180146107;5468.507834294853;5470.72646367688;5487.1741053357555;5498.752556134984;1373.4025698821044;1394.4840409048718;1419.7728363461797;1437.4322142753554;1440.164704471404;928.4197376639601;929.3726734454216;936.840737074699;943.7357539888704;946.252460556153;4762.4285085789925;4808.855734327975;4815.3017812417;4818.253170758538;4843.782029808667;5073.467285934998;5097.5981605058905;5102.642815002914;5109.8722531937;5110.28456016158;4843.951560484421;4844.588210002119;4850.466448690641;4855.490173531799;5008.57427118699;2998.355353598943;3005.8797648093832;3014.593029940974;3061.9846900765356;3074.707902749235;5845.590808643439;5845.766169353178;5884.499817515473;5938.406159384027;5940.257467816523;5547.916781248285;5767.192593036978;5817.76728930838;5848.590598658053;5855.59010869235;5839.270091238595;5921.2302400688495;5948.821535353946;5972.25346831646;5982.700864956735;5547.4175211603815;5787.36339002701;5791.536677065909;5798.5651076168615;5808.680522571299;5609.635373700697;5610.803621873378;5658.462446067617;5675;5680.71596420169;5828.213191219131;5841;5912.438318359749;5987.68270980401;5996.610220335664;3818.6945044395825;3990.201959608148;4010.6791456682813;4020.7386519876113;4029.1135950090934;5520.641158324696;5658.660480371191;5692.943070569241;5704.201411802268;5746.482816546531;5357.758900849549;5535.667859928417;5540.695261760642;5555.30558680165;5564.581031836856;5474.479924407175;5474.835754927359;5515.200295957144;5516.641418307797;5537.972310138423;5204.947950520446;5414.187871819101;5450.836474905759;5457.372402173642;5476.138113041585;5508.586855985737;5531.640443371168;5536.335639723259;5549.973254947848;5604.719764011865;5444.183372494158;5447.073997420369;5460.153676180198;5465.316835395575;5480.3971563128825 20:18:15 INFO - PROCESS | 7907 | |5;yui.html;719.1873183302866;741.2365263778308;758.8292634157319;775.4106878772138;783.1541934710511;13301.534446294381;13644.38600262988;14095;14242.501512447066;14251.287435628228;12439.813402798942;12445.813312800292;12445.937770311159;12451.003919686425;12455.314957677325;675.8377989282586;780.7345502529139;810.9189081091888;818.5129847740615;827.4249396669318;820.1921107708902;821.3018933906162;821.363443331417;823.8434697407504;823.9093699693029;865.8744482050099;867.1718508824058;867.301822033263;867.7093173786758;867.7526904832124;708.8582283543286;819.1194465949069;854.4147259127486;856.3662889461816;856.4732689396039;625.5496042849142;625.6496362037228;625.8967270400378;626.4988009592308;626.7868924565624;13464.663383415394;13506.594802155852;13522.391492382867;13524.25616591087;13537.458501659921;13125.474981000749;13314.667133321647;13334.466621335136;13355.065145439727;13418.46326146953;11080.667579972614;11098.944505277503;11253;12191.939040304742;12303.077269204845;4459.64677842378;4548.681592288541;4571.2457444521615;4595.494495605481;4625.861224163281;58295.125573116435;58528.41471585315;59165;59220.70389648024;59290;10230;10258.28192026566;10435.843462348072;10475.685729428129;10732.624358147428;18252.908735456236;18332.908335458236;18351.54121146982;18477.260909563734;18592.721109183374;7988.720394786154;8083.393745469113;8230.135835737281;8323.6670533178;8488.830223395498;4715.834945776881;4738.4550776660435;4801.903961920742;4836.081144582518;4881.804727810919;3274.492453669685;3321.8671253149605;3337.098983274551;3347.3640008398324;3348.7823291485975;599.7421108923118;603.728322254987;606.2543072021439;632.2918331468693;638.958467699598;694.7116946467261;701.2041333086983;702.6592102830124;713.9393151582174;729.1614643160408;9790.853137202948;9949.353292035994;9949.751256218507;10034.949825250827;10069.244806639532;656.3567703650449;695.3046953046953;712.9964350178319;715.8747219236612;719.899214110025;4638.443386793607;4650.325702773147;4698.459677137104;4705.670603057753;4752;66873.33126668671;67429.32570674231;67702;68116.318836811;68208.6589567059;60735.69632151811;61074.69462652658;61245;62653.373466265664;63220.36779632237;56405.71797140988;56715.71642141763;56847.57881052924;56903;57190.7140464295;8832.160944710242;8896.510691912006;8929.598168082583;8972.461652300883;9000.549972501218;33631.4955275676;34081;34439;35413;36777.448338274415;48112.759436203996;48474;48755.75622121867;49040.50959490502;49236.50763492319;11617.88382116168;11883.049356051322;12333.136680432643;12543.12198146121;12552.058595605184;13157.868421316047;13451.596452106452;13741.931290343484;13846.992186133155;14306.57080287593;12854.164479308814;13150.342482876009;13279.468821247043;13346.532871349456;13404.798928016282;12769.936150319189;12804.10371274002;13149.21104733719;13173.143745656886;13475.663108421975;12716.237025778482;12727.93636031814;12975.935120324339;13123.081384303006;13580.864191358356;10602.09882160025;10698.572057117628;10813.706089776884;10989.175811814306;11424.714382140513;10961.177911656818;11135.387553684624;11507.769844603228;11533.077353811843;11564.710882228012 20:18:15 INFO - PROCESS | 7907 | __end_tp_report 20:18:15 INFO - PROCESS | 7907 | __start_cc_report 20:18:15 INFO - PROCESS | 7907 | _x_x_mozilla_cycle_collect,870 20:18:15 INFO - PROCESS | 7907 | __end_cc_report 20:18:15 INFO - PROCESS | 7907 | __startTimestamp1464146295056__endTimestamp 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | ------- Summary: start ------- 20:18:15 INFO - PROCESS | 7907 | Number of tests: 6 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#0] dojo.html Cycles:165 Average:5312.77 Median:5513.61 stddev:613.61 (11.1%) stddev-sans-first:590.14 20:18:15 INFO - PROCESS | 7907 | Values: 3087.6 3090.6 3114.4 3130.4 3145.1 5142.5 5226.8 5244.3 5334.8 5336.5 5353.4 5377.4 5379.1 5412.3 5455.5 4617.3 4881.2 4934.3 4945.1 4950.0 4677.5 4901.5 4931.5 4941.0 4948.0 4766.5 4801.6 4821.9 4842.0 4843.7 4754.5 4806.1 4806.7 4807.1 4852.7 4688.9 4755.0 4762.9 4766.8 4795.3 5329.5 5348.8 5358.4 5366.5 5374.0 5721.3 5731.0 5731.9 5766.6 5766.9 5558.2 5713.0 5726.4 5733.8 5773.5 5438.3 5463.1 5465.4 5469.4 5475.9 5932.5 5949.9 5951.1 5952.9 5954.2 5524.9 5589.1 5619.8 5624.4 5727.1 5768.5 5812.6 5814.7 5817.8 5824.6 5742.3 5749.3 5752.2 5755.0 5755.9 5498.2 5657.6 5695.8 5697.3 5738.5 4358.2 4364.2 4365.4 4368.8 4387.8 3824.6 3869.3 3907.3 3960.0 3967.7 5345.3 5345.9 5390.7 5411.8 5417.1 5663.4 5674.3 5702.2 5719.6 5760.7 5289.4 5294.4 5307.6 5403.5 5417.8 4881.6 4893.7 4902.5 4933.4 4938.2 5846.4 5848.4 5857.0 5859.8 5865.5 5510.8 5657.2 5746.9 5791.7 5797.5 6027.3 6038.4 6043.5 6047.2 6053.0 5712.2 5714.5 5721.6 5721.8 5725.3 5609.7 5621.8 5643.8 5668.0 5798.3 5525.3 5537.6 5537.9 5543.7 5547.1 5473.8 5487.8 5523.6 5542.5 5570.7 5411.9 5488.0 5513.6 5540.6 5589.1 5671.6 5685.4 5686.0 5729.6 5730.7 5299.7 5570.3 5571.7 5576.9 5611.1 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#1] ext.html Cycles:180 Average:57838.08 Median:22713.82 stddev:115417.82 (508.1%) stddev-sans-first:115661.55 20:18:15 INFO - PROCESS | 7907 | Values: 586.9 616.8 629.8 634.1 637.0 43526.8 45101.5 45117.0 45335.5 49215.8 45674.0 46100.0 46154.0 46218.8 46238.8 8691.9 8854.5 8858.0 8865.5 8870.8 8729.2 8848.1 8867.2 8870.3 8873.2 8904.2 8936.9 8952.9 8953.2 8966.1 8876.4 8922.0 8923.7 8925.5 8934.9 8834.7 8934.5 8936.2 8937.2 8947.7 43394.8 44045.6 44083.3 44150.0 44174.5 3092.7 3456.9 3666.7 3676.2 3794.6 32393.4 32495.8 32837.8 33135.0 33543.2 4159.3 4190.5 4200.7 4282.4 4343.7 326828.0 330096.0 330426.0 331034.0 332243.0 34839.5 54203.0 54928.0 55001.0 55070.2 35317.6 37159.4 37201.4 37224.0 37228.0 14292.2 14483.2 14488.1 14498.1 14518.4 11947.9 12034.3 12035.0 12036.5 12037.6 8384.9 8436.8 8439.7 8444.0 8534.4 3308.7 3326.2 3334.1 3346.7 3349.8 1078.8 1079.4 1086.2 1140.0 1177.4 32776.2 33351.8 33703.7 33972.8 34159.3 1073.0 1203.6 1211.6 1223.7 1239.9 17543.2 17598.8 17730.4 17778.4 17785.5 562576.0 565097.0 567296.0 569702.0 570896.0 60481.4 60956.0 61018.0 61024.0 61043.7 1216.7 1294.8 1318.1 1413.8 1421.9 32530.0 33788.5 33839.2 34147.8 34664.5 51014.7 51346.7 51725.0 51788.5 51863.0 366133.0 366889.0 366924.0 367931.0 368708.0 23308.8 27932.6 28505.4 28707.1 28745.3 49399.0 49649.3 50047.5 50456.7 50629.5 41048.4 42220.3 42822.8 42998.6 43717.3 40694.6 41242.8 41268.4 41810.0 41885.2 40999.4 42344.2 42545.8 42619.0 42727.4 35304.6 36520.5 37204.4 37466.4 37835.8 28202.9 28454.0 28570.1 28881.9 28931.7 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#2] jquery.html Cycles:180 Average:30208.74 Median:3428.71 stddev:81855.42 (2387.4%) stddev-sans-first:82054.39 20:18:15 INFO - PROCESS | 7907 | Values: 373.6 386.3 396.7 399.8 402.5 17490.7 19392.7 19792.4 19871.6 19889.2 17523.4 17690.0 17875.5 18036.4 18174.1 5573.4 5608.3 5724.9 5809.7 5827.8 4083.3 6109.4 6484.7 6489.9 6498.5 6274.6 6413.5 6423.3 6430.0 6503.0 4099.8 6437.8 6491.2 6497.9 6504.3 5363.5 5672.9 5674.3 5767.9 5771.3 22262.6 22509.8 22528.7 23374.4 23377.0 2304.8 2375.0 2442.6 2503.6 2856.0 15455.6 16010.6 16028.4 16149.4 16251.3 2027.6 2039.7 2061.9 2085.9 2173.2 90419.0 92818.0 95326.5 95495.0 95808.0 16792.7 17192.8 17434.4 17540.0 17873.3 30783.0 30877.2 31117.4 31148.0 31299.4 9242.6 9568.5 9586.0 9648.2 9860.6 7904.2 7934.7 8076.6 8077.1 8150.6 7229.6 8591.9 8829.0 8930.4 9195.1 2935.3 3205.7 3208.3 3246.4 3611.0 717.5 963.2 1003.6 1013.9 1015.3 18078.4 18364.9 18385.3 19023.3 19197.6 965.3 970.8 976.9 1011.9 1016.8 10165.9 10744.4 10751.0 10752.1 10775.0 484092.0 490022.0 493262.0 506042.0 507347.0 88215.6 91568.5 91929.0 92119.0 93160.5 972.5 978.7 987.2 1017.1 1017.7 16196.3 16306.2 16639.0 16691.3 16822.2 29241.0 36606.0 39744.2 40011.4 40274.8 53816.7 56001.2 56670.0 56688.4 57192.1 8113.8 8244.3 8256.4 8281.6 8362.1 9663.4 10271.6 12730.4 13144.5 13464.3 11507.4 11595.8 11855.8 11863.8 11931.6 11164.3 11431.8 11696.6 11782.3 11946.1 11751.2 11875.8 11913.3 12030.8 12111.3 8243.3 8275.7 8283.4 8356.1 8839.6 11469.4 11697.8 11832.2 12013.2 12042.4 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#3] mootools.html Cycles:180 Average:5657.91 Median:4432.93 stddev:3218.59 (72.6%) stddev-sans-first:3211.09 20:18:15 INFO - PROCESS | 7907 | Values: 1317.9 1490.7 1532.1 1614.3 1808.2 8089.6 8418.2 8441.6 8619.6 8623.3 8448.5 8619.0 8623.5 8637.8 8641.7 1985.2 2181.9 2261.0 2266.6 2294.7 2229.9 2238.1 2238.2 2243.2 2243.7 2259.2 2259.9 2319.2 2319.9 2323.5 1872.6 2115.9 2170.9 2179.0 2215.6 2213.4 2237.1 2240.1 2240.9 2259.4 8538.6 8579.9 8609.1 8609.3 8615.1 5070.0 5189.7 5200.4 5213.4 5214.9 2986.1 3066.5 3139.3 3151.2 3173.6 1017.4 1062.6 1076.5 1089.2 1095.8 12069.6 12110.2 12115.8 12128.3 12129.6 4398.9 4487.1 4542.4 4561.6 4642.7 10080.8 10113.7 10128.3 10155.6 10159.9 5107.9 5115.3 5124.5 5125.2 5127.3 4204.2 4349.2 4466.9 4468.2 4536.8 3966.1 3991.8 4049.6 4062.6 4092.8 1263.9 1276.7 1276.7 1294.1 1309.5 933.2 998.1 998.5 1011.5 1031.9 5971.5 5983.1 6010.5 6018.8 6289.8 977.8 989.9 998.4 1001.3 1028.0 3821.7 4043.0 4050.0 4072.7 4105.5 10251.4 10322.9 10496.5 10577.5 10618.8 10324.7 10360.1 10435.4 10440.1 10472.4 8079.4 8116.6 8242.2 8274.3 8277.1 5694.3 5857.8 5874.4 5896.6 5907.6 9864.8 10013.6 10052.4 10123.4 10162.2 10155.4 10190.4 10208.1 10256.2 10323.5 6361.7 6886.1 7093.8 7108.1 7201.8 8303.0 8319.1 8346.9 8363.3 8386.7 7241.7 7356.9 7440.5 7473.0 7539.0 7084.5 7187.4 7247.7 7283.2 7420.0 6924.9 6960.8 7004.4 7008.3 7016.1 4944.1 5007.9 5030.3 5126.3 5189.0 5130.8 5200.4 5232.5 5336.6 5394.2 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#4] prototype.html Cycles:180 Average:4607.54 Median:5171.98 stddev:1355.03 (26.2%) stddev-sans-first:1320.15 20:18:15 INFO - PROCESS | 7907 | Values: 325.1 328.2 334.4 344.0 346.7 5162.2 5236.6 5257.5 5334.2 5355.7 5190.2 5231.5 5234.1 5246.8 5248.2 4102.2 4103.5 4109.2 4122.4 4137.1 3901.3 3929.7 4049.3 4096.2 4121.0 4034.0 4064.6 4076.8 4119.4 4119.7 4027.3 4069.9 4072.2 4085.7 4094.0 3562.4 3624.6 3657.5 3664.9 3675.4 5009.4 5048.0 5059.2 5062.8 5077.5 4669.3 4671.8 4680.6 4680.8 4690.9 5181.8 5411.8 5420.6 5425.3 5434.4 3918.3 3920.9 3925.5 3932.9 3943.8 5609.6 5669.1 5695.3 5697.6 5718.1 4031.1 4033.7 4035.7 4059.1 4069.6 3974.2 4103.0 4119.6 4135.5 4138.4 4593.6 4657.7 4674.6 4680.4 4682.2 5455.4 5468.5 5470.7 5487.2 5498.8 1373.4 1394.5 1419.8 1437.4 1440.2 928.4 929.4 936.8 943.7 946.3 4762.4 4808.9 4815.3 4818.3 4843.8 5073.5 5097.6 5102.6 5109.9 5110.3 4844.0 4844.6 4850.5 4855.5 5008.6 2998.4 3005.9 3014.6 3062.0 3074.7 5845.6 5845.8 5884.5 5938.4 5940.3 5547.9 5767.2 5817.8 5848.6 5855.6 5839.3 5921.2 5948.8 5972.3 5982.7 5547.4 5787.4 5791.5 5798.6 5808.7 5609.6 5610.8 5658.5 5675.0 5680.7 5828.2 5841.0 5912.4 5987.7 5996.6 3818.7 3990.2 4010.7 4020.7 4029.1 5520.6 5658.7 5692.9 5704.2 5746.5 5357.8 5535.7 5540.7 5555.3 5564.6 5474.5 5474.8 5515.2 5516.6 5538.0 5204.9 5414.2 5450.8 5457.4 5476.1 5508.6 5531.6 5536.3 5550.0 5604.7 5444.2 5447.1 5460.2 5465.3 5480.4 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - PROCESS | 7907 | [#5] yui.html Cycles:180 Average:15582.21 Median:4710.75 stddev:18807.01 (399.2%) stddev-sans-first:18826.65 20:18:15 INFO - PROCESS | 7907 | Values: 719.2 741.2 758.8 775.4 783.2 13301.5 13644.4 14095.0 14242.5 14251.3 12439.8 12445.8 12445.9 12451.0 12455.3 675.8 780.7 810.9 818.5 827.4 820.2 821.3 821.4 823.8 823.9 865.9 867.2 867.3 867.7 867.8 708.9 819.1 854.4 856.4 856.5 625.5 625.6 625.9 626.5 626.8 13464.7 13506.6 13522.4 13524.3 13537.5 13125.5 13314.7 13334.5 13355.1 13418.5 11080.7 11098.9 11253.0 12191.9 12303.1 4459.6 4548.7 4571.2 4595.5 4625.9 58295.1 58528.4 59165.0 59220.7 59290.0 10230.0 10258.3 10435.8 10475.7 10732.6 18252.9 18332.9 18351.5 18477.3 18592.7 7988.7 8083.4 8230.1 8323.7 8488.8 4715.8 4738.5 4801.9 4836.1 4881.8 3274.5 3321.9 3337.1 3347.4 3348.8 599.7 603.7 606.3 632.3 639.0 694.7 701.2 702.7 713.9 729.2 9790.9 9949.4 9949.8 10034.9 10069.2 656.4 695.3 713.0 715.9 719.9 4638.4 4650.3 4698.5 4705.7 4752.0 66873.3 67429.3 67702.0 68116.3 68208.7 60735.7 61074.7 61245.0 62653.4 63220.4 56405.7 56715.7 56847.6 56903.0 57190.7 8832.2 8896.5 8929.6 8972.5 9000.5 33631.5 34081.0 34439.0 35413.0 36777.4 48112.8 48474.0 48755.8 49040.5 49236.5 11617.9 11883.0 12333.1 12543.1 12552.1 13157.9 13451.6 13741.9 13847.0 14306.6 12854.2 13150.3 13279.5 13346.5 13404.8 12769.9 12804.1 13149.2 13173.1 13475.7 12716.2 12727.9 12975.9 13123.1 13580.9 10602.1 10698.6 10813.7 10989.2 11424.7 10961.2 11135.4 11507.8 11533.1 11564.7 20:18:15 INFO - PROCESS | 7907 | -------- Summary: end -------- 20:18:15 INFO - PROCESS | 7907 | 20:18:15 INFO - TEST-INFO | 7907: exit 0 20:18:15 INFO - TEST-OK | dromaeo_css | took 1112178ms 20:18:15 INFO - TEST-START | kraken 20:18:15 INFO - operating with platform_type : linux_ 20:18:15 INFO - Initialising browser for kraken test... 20:18:15 INFO - TEST-INFO | started process 8091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqhV2E/profile http://localhost:50380/getInfo.html) 20:18:19 INFO - PROCESS | 8091 | __metrics Screen width/height:1600/1200 20:18:19 INFO - PROCESS | 8091 | colorDepth:24 20:18:19 INFO - PROCESS | 8091 | Browser inner width/height: 1024/697 20:18:19 INFO - PROCESS | 8091 | __metrics 20:18:20 ERROR - PROCESS | 8091 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:18:21 INFO - TEST-INFO | 8091: exit 0 20:18:21 INFO - Browser initialized. 20:18:21 INFO - Running cycle 1/1 for kraken test... 20:18:21 INFO - TEST-INFO | started process 8171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqhV2E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:33 INFO - PROCESS | 8171 | RSS: Main: 153645056 20:18:33 INFO - PROCESS | 8171 | 20:18:35 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:36 INFO - PROCESS | 8171 | RSS: Main: 210112512 20:18:36 INFO - PROCESS | 8171 | 20:18:39 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-dft) 20:18:39 INFO - PROCESS | 8171 | RSS: Main: 197849088 20:18:39 INFO - PROCESS | 8171 | 20:18:43 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-fft) 20:18:43 INFO - PROCESS | 8171 | RSS: Main: 266641408 20:18:43 INFO - PROCESS | 8171 | 20:18:45 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50380/tests/kraken/driver.html?testName=audio-oscillator) 20:18:46 INFO - PROCESS | 8171 | RSS: Main: 175620096 20:18:46 INFO - PROCESS | 8171 | 20:18:48 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:49 INFO - PROCESS | 8171 | RSS: Main: 179146752 20:18:49 INFO - PROCESS | 8171 | 20:18:52 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:52 INFO - PROCESS | 8171 | RSS: Main: 215834624 20:18:52 INFO - PROCESS | 8171 | 20:18:56 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50380/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:56 INFO - PROCESS | 8171 | RSS: Main: 216514560 20:18:56 INFO - PROCESS | 8171 | 20:18:59 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50380/tests/kraken/driver.html?testName=json-parse-financial) 20:19:00 INFO - PROCESS | 8171 | RSS: Main: 216592384 20:19:00 INFO - PROCESS | 8171 | 20:19:01 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:02 INFO - PROCESS | 8171 | RSS: Main: 202498048 20:19:02 INFO - PROCESS | 8171 | 20:19:04 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:04 INFO - PROCESS | 8171 | RSS: Main: 206749696 20:19:04 INFO - PROCESS | 8171 | 20:19:06 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:07 INFO - PROCESS | 8171 | RSS: Main: 217763840 20:19:07 INFO - PROCESS | 8171 | 20:19:09 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:10 INFO - PROCESS | 8171 | RSS: Main: 224768000 20:19:10 INFO - PROCESS | 8171 | 20:19:13 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:13 INFO - PROCESS | 8171 | RSS: Main: 222547968 20:19:13 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | Cycle 1(1): loaded http://localhost:50380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50380/tests/kraken/driver.html?testName=ai-astar) 20:19:15 INFO - PROCESS | 8171 | RSS: Main: 268165120 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | __start_tp_report 20:19:15 INFO - PROCESS | 8171 | _x_x_mozilla_page_load 20:19:15 INFO - PROCESS | 8171 | _x_x_mozilla_page_load_details 20:19:15 INFO - PROCESS | 8171 | |i|pagename|runs| 20:19:15 INFO - PROCESS | 8171 | |0;ai-astar;111;106;120;109;110;110;111;110;110;112 20:19:15 INFO - PROCESS | 8171 | |1;audio-beat-detection;156;126;126;189;138;125;154;126;154;125 20:19:15 INFO - PROCESS | 8171 | |2;audio-dft;160;160;162;161;160;161;161;161;160;160 20:19:15 INFO - PROCESS | 8171 | |3;audio-fft;76;75;75;108;73;74;74;75;105;73 20:19:15 INFO - PROCESS | 8171 | |4;audio-oscillator;83;82;126;83;84;84;121;84;83;120 20:19:15 INFO - PROCESS | 8171 | |5;imaging-gaussian-blur;116;117;117;116;117;117;118;116;117;117 20:19:15 INFO - PROCESS | 8171 | |6;imaging-darkroom;145;146;146;146;146;145;145;146;145;145 20:19:15 INFO - PROCESS | 8171 | |7;imaging-desaturate;95;94;94;94;95;94;95;94;95;95 20:19:15 INFO - PROCESS | 8171 | |8;json-parse-financial;55;55;55;54;55;55;54;72;52;52 20:19:15 INFO - PROCESS | 8171 | |9;json-stringify-tinderbox;62;62;62;61;61;60;61;61;61;61 20:19:15 INFO - PROCESS | 8171 | |10;stanford-crypto-aes;81;86;80;79;79;81;81;81;82;81 20:19:15 INFO - PROCESS | 8171 | |11;stanford-crypto-ccm;121;121;125;120;118;132;130;130;176;121 20:19:15 INFO - PROCESS | 8171 | |12;stanford-crypto-pbkdf2;165;165;161;160;160;158;161;166;162;162 20:19:15 INFO - PROCESS | 8171 | |13;stanford-crypto-sha256-iterative;64;64;69;63;63;63;67;62;62;62 20:19:15 INFO - PROCESS | 8171 | __end_tp_report 20:19:15 INFO - PROCESS | 8171 | __start_cc_report 20:19:15 INFO - PROCESS | 8171 | _x_x_mozilla_cycle_collect,1616 20:19:15 INFO - PROCESS | 8171 | __end_cc_report 20:19:15 INFO - PROCESS | 8171 | __startTimestamp1464146355833__endTimestamp 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | ------- Summary: start ------- 20:19:15 INFO - PROCESS | 8171 | Number of tests: 14 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.50 stddev:3.57 (3.2%) stddev-sans-first:3.79 20:19:15 INFO - PROCESS | 8171 | Values: 111.0 106.0 120.0 109.0 110.0 110.0 111.0 110.0 110.0 112.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:146.00 stddev:21.23 (14.5%) stddev-sans-first:21.89 20:19:15 INFO - PROCESS | 8171 | Values: 156.0 126.0 126.0 189.0 138.0 125.0 154.0 126.0 154.0 125.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 20:19:15 INFO - PROCESS | 8171 | Values: 160.0 160.0 162.0 161.0 160.0 161.0 161.0 161.0 160.0 160.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:13.60 (18.2%) stddev-sans-first:14.31 20:19:15 INFO - PROCESS | 8171 | Values: 76.0 75.0 75.0 108.0 73.0 74.0 74.0 75.0 105.0 73.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.00 stddev:18.93 (22.8%) stddev-sans-first:19.58 20:19:15 INFO - PROCESS | 8171 | Values: 83.0 82.0 126.0 83.0 84.0 84.0 121.0 84.0 83.0 120.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:19:15 INFO - PROCESS | 8171 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 118.0 116.0 117.0 117.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:19:15 INFO - PROCESS | 8171 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 20:19:15 INFO - PROCESS | 8171 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:5.78 (10.5%) stddev-sans-first:6.12 20:19:15 INFO - PROCESS | 8171 | Values: 55.0 55.0 55.0 54.0 55.0 55.0 54.0 72.0 52.0 52.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 20:19:15 INFO - PROCESS | 8171 | Values: 62.0 62.0 62.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:1.97 (2.4%) stddev-sans-first:2.09 20:19:15 INFO - PROCESS | 8171 | Values: 81.0 86.0 80.0 79.0 79.0 81.0 81.0 81.0 82.0 81.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:127.50 stddev:17.09 (13.4%) stddev-sans-first:17.85 20:19:15 INFO - PROCESS | 8171 | Values: 121.0 121.0 125.0 120.0 118.0 132.0 130.0 130.0 176.0 121.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:2.58 (1.6%) stddev-sans-first:2.50 20:19:15 INFO - PROCESS | 8171 | Values: 165.0 165.0 161.0 160.0 160.0 158.0 161.0 166.0 162.0 162.0 20:19:15 INFO - PROCESS | 8171 | 20:19:15 INFO - PROCESS | 8171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:2.33 (3.7%) stddev-sans-first:2.47 20:19:15 INFO - PROCESS | 8171 | Values: 64.0 64.0 69.0 63.0 63.0 63.0 67.0 62.0 62.0 62.0 20:19:15 INFO - PROCESS | 8171 | -------- Summary: end -------- 20:19:15 INFO - PROCESS | 8171 | 20:19:16 INFO - TEST-INFO | 8171: exit 0 20:19:16 INFO - TEST-OK | kraken | took 61092ms 20:19:16 INFO - SUITE-END | took 1173s 20:19:17 INFO - Completed test suite (00:19:33) 20:19:17 INFO - javascript benchmark 20:19:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.5677405163283, 3090.613673290837, 3114.377124575085, 3130.3895740330645, 3145.0564830550843, 5142.460041695625, 5226.7909283628705, 5244.318238628977, 5334.813281535142, 5336.493033161843, 5353.437889021655, 5377.381601115872, 5379.112446446342, 5412.323459567554, 5455.454454554542, 4617.284320930261, 4881.219004959198, 4934.309196712463, 4945.085159245533, 4950.034743225073, 4677.4620918594455, 4901.4608393076915, 4931.5068493150575, 4940.950590494085, 4948.0, 4766.499517550659, 4801.567858892699, 4821.855344339658, 4842.031593681278, 4843.66094373394, 4754.477007529169, 4806.086843499724, 4806.735629540374, 4807.062622788558, 4852.708837469763, 4688.929666055012, 4754.952450475485, 4762.928556071662, 4766.76166191689, 4795.2807078938085, 5329.520343169133, 5348.839534813962, 5358.383785864637, 5366.4633536646415, 5373.978944000627, 5721.342045664718, 5730.971345143289, 5731.942680573183, 5766.625169363978, 5766.884662306772, 5558.194061861048, 5713.028785106542, 5726.427357264281, 5733.799317023926, 5773.509251713609, 5438.320209973754, 5463.125899856004, 5465.426130256305, 5469.425710300441, 5475.917861232085, 5932.49573786233, 5949.940500594938, 5951.077582974646, 5952.940470595238, 5954.225950626391, 5524.861878453071, 5589.105743081088, 5619.8033068843215, 5624.409437009137, 5727.11229759388, 5768.538516918637, 5812.593118481665, 5814.651120932757, 5817.825465236049, 5824.563157763185, 5742.31092268922, 5749.281339832521, 5752.194692743019, 5755.021646320136, 5755.913661295084, 5498.1752737088955, 5657.6039677223025, 5695.800646977336, 5697.316322041299, 5738.512226460714, 4358.171947329997, 4364.170807546556, 4365.388845561624, 4368.7815609219415, 4387.758673273001, 3824.5984171661576, 3869.3035253654048, 3907.257621051991, 3959.97040769402, 3967.6627486663956, 5345.305110335631, 5345.919811202835, 5390.67655940637, 5411.810586629449, 5417.079096553595, 5663.433656634386, 5674.319081710221, 5702.173184888168, 5719.628224165416, 5760.683162426107, 5289.3652761668845, 5294.391145018295, 5307.575393968474, 5403.540699040625, 5417.783288668488, 4881.560659540658, 4893.7063776173545, 4902.460729319772, 4933.407991041098, 4938.160512712848, 5846.444587764156, 5848.415158484203, 5857.004309267435, 5859.824205273849, 5865.472107510259, 5510.779568817203, 5657.15142728594, 5746.885062298814, 5791.710414479344, 5797.507211887037, 6027.336992930686, 6038.365971573097, 6043.456088952015, 6047.153398524122, 6053.031514957585, 5712.171735098471, 5714.514266287246, 5721.628094173865, 5721.828345149652, 5725.341585717696, 5609.663420194802, 5621.831345059655, 5643.830685079454, 5668.0, 5798.33319168301, 5525.254090697865, 5537.612367134262, 5537.9169312459535, 5543.667379957215, 5547.0570003098765, 5473.8357849264585, 5487.780488780564, 5523.585731070266, 5542.473465020817, 5570.749316280696, 5411.864703382447, 5488.0395930711165, 5513.61404701667, 5540.612157149122, 5589.133684278943, 5671.574631902707, 5685.431456854281, 5686.0, 5729.570282228766, 5730.684812335361, 5299.735013249399, 5570.303712035996, 5571.721413929368, 5576.86057848557, 5611.102223644198], "value": 5271.081191768673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8591538030873, 616.8427051101968, 629.8299459146031, 634.0584232414864, 636.9681515924202, 43526.78236608816, 45101.54898451015, 45117.0, 45335.54664453355, 49215.75392123043, 45674.0, 46100.0, 46154.0, 46218.76890615551, 46238.768806155924, 8691.913080869173, 8854.513001784899, 8858.0, 8865.468071915706, 8870.822583548324, 8729.170728780788, 8848.070952549953, 8867.201951824334, 8870.290376769875, 8873.157050080265, 8904.198622124008, 8936.910630893706, 8952.8657070144, 8953.23897468716, 8966.058563850767, 8876.378653494257, 8921.955390223073, 8923.732288031337, 8925.464472131693, 8934.910650893473, 8834.69078582253, 8934.525803242457, 8936.195742383152, 8937.150970657776, 8947.731568052968, 43394.78302608467, 44045.55954440447, 44083.338749918774, 44150.0, 44174.453894113874, 3092.721655051034, 3456.861725530976, 3666.7066634669163, 3676.246369494247, 3794.582595914447, 32393.35213295721, 32495.83752081248, 32837.83581082103, 33135.0, 33543.161420964425, 4159.251334759742, 4190.476190476191, 4200.70595058346, 4282.400463935051, 4343.717658352229, 326828.0, 330096.0, 330426.0, 331034.0, 332243.0, 34839.4774078389, 54203.0, 54928.0, 55001.0, 55070.173947390824, 35317.64682353195, 37159.4426083609, 37201.44197837035, 37224.0, 37228.0, 14292.213928234047, 14483.203423811581, 14488.058276212012, 14498.130112193303, 14518.419263229564, 11947.880521194851, 12034.277943323428, 12035.037197024218, 12036.518539258506, 12037.578684746168, 8384.8742268866, 8436.831263374821, 8439.746807595782, 8443.957780211182, 8534.402591818638, 3308.7022168004996, 3326.2183386904057, 3334.133125387417, 3346.6987971082717, 3349.849256783402, 1078.8489611454402, 1079.422508957704, 1086.1528008153653, 1139.9911078695413, 1177.3701069927547, 32776.180595485304, 33351.83324083364, 33703.73514855166, 33972.83013584916, 34159.31681366359, 1072.951717172729, 1203.6389083274983, 1211.6062279758937, 1223.7063104854772, 1239.9318037507844, 17543.21055552503, 17598.82401175972, 17730.379436719653, 17778.37775677845, 17785.46643600694, 562576.0, 565097.0, 567296.0, 569702.0, 570896.0, 60481.39518604846, 60956.0, 61018.0, 61024.0, 61043.6947815267, 1216.7262365967763, 1294.7863602505481, 1318.0575888239955, 1413.8162038934872, 1421.9289035548181, 32530.0, 33788.493172602924, 33839.19633029386, 34147.829260853534, 34664.480032800035, 51014.74492627513, 51346.74326628343, 51725.0, 51788.48211517837, 51863.0, 366133.0, 366889.0, 366924.0, 367931.0, 368708.0, 23308.76691233066, 27932.581011285252, 28505.42989140247, 28707.138785836458, 28745.281367965967, 49399.0, 49649.25526117039, 50047.49952500574, 50456.74771626118, 50629.49370506395, 41048.384274235315, 42220.301123842895, 42822.78588607037, 42998.570014299454, 43717.344239835795, 40694.59305407026, 41242.79378603088, 41268.38097428481, 41810.0, 41885.162296754504, 40999.38500922548, 42344.153116938105, 42545.78727106345, 42619.0, 42727.3590896143, 35304.64695353014, 36520.52377506663, 37204.44193337048, 37466.43800342942, 37835.81082094572, 28202.85898570576, 28454.0, 28570.14289571316, 28881.855590721912, 28931.710682892903], "value": 19049.1065156797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.5965157629762, 386.26031150347086, 396.6667998880939, 399.7841165770484, 402.48481943112824, 17490.737638935425, 19392.70910936337, 19792.40622781319, 19871.602567948634, 19889.204431822727, 17523.38668146612, 17690.0, 17875.463736087906, 18036.368727094556, 18174.091295435243, 5573.4147914469, 5608.327000759915, 5724.885502289952, 5809.73856176471, 5827.825165245049, 4083.3466645336753, 6109.419605137505, 6484.740610375579, 6489.902651460232, 6498.545101842873, 6274.592151510137, 6413.518986076039, 6423.29343772187, 6430.0354946758125, 6502.967485162568, 4099.795010249476, 6437.806865793987, 6491.188601424822, 6497.935020649804, 6504.252011018746, 5363.517283444469, 5672.858178545528, 5674.319081710221, 5767.942320576783, 5771.278590176228, 22262.55474890493, 22509.77490225093, 22528.662070068964, 23374.415639608975, 23377.0, 2304.7695230476984, 2374.9881250593808, 2442.6091825307867, 2503.574392353304, 2856.043225519433, 15455.61360965985, 16010.5997350066, 16028.439004634782, 16149.385061493875, 16251.349946002263, 2027.5742094160244, 2039.7144399784042, 2061.907214175351, 2085.9061342239634, 2173.2067795254775, 90419.0, 92818.0, 95326.52336738342, 95495.04504954931, 95808.0, 16792.664146716997, 17192.828071719123, 17434.389796357067, 17540.0, 17873.28506859711, 30783.0, 30877.228069298, 31117.377652446823, 31148.0, 31299.374012519624, 9242.584083716249, 9568.4737339447, 9585.952070239744, 9648.179904708039, 9860.556274967643, 7904.2095790421645, 7934.651109311431, 8076.55578943152, 8077.071136819341, 8150.551719655476, 7229.567012336033, 8591.93793489558, 8829.0, 8930.419522731001, 9195.126462986005, 2935.251510864716, 3205.7114859662743, 3208.2941752814345, 3246.4481038223557, 3610.9638903610626, 717.5264325545115, 963.2149797914677, 1003.603576587244, 1013.9353678637401, 1015.2994433840627, 18078.3672571462, 18364.908175459037, 18385.26458941654, 19023.334183303796, 19197.616047678966, 965.2567523007245, 970.84466485362, 976.8534719791946, 1011.858339832424, 1016.8423894296396, 10165.949170254102, 10744.355338679548, 10751.0324070834, 10752.139828813677, 10775.0, 484092.0, 490022.0, 493262.0, 506042.0, 507347.0, 88215.55892220497, 91568.54215728879, 91929.0, 92119.0, 93160.53419732858, 972.5380444288907, 978.7210644966151, 987.2003677021636, 1017.1151098544166, 1017.6845177994845, 16196.271167797242, 16306.18469076565, 16639.0, 16691.332346705996, 16822.242999064827, 29241.0, 36606.0, 39744.20511589694, 40011.399829003174, 40274.798626007854, 53816.730916345165, 56001.15998259948, 56670.0, 56688.43311566832, 57192.142117867435, 8113.797155071171, 8244.340452763645, 8256.422050456411, 8281.627326770431, 8362.080171181044, 9663.371880827724, 10271.589136434757, 12730.363481825687, 13144.474221031052, 13464.326783660581, 11507.424628768695, 11595.796798608237, 11855.822162667739, 11863.822042669195, 11931.642050738492, 11164.274322169033, 11431.771364572829, 11696.649100526998, 11782.293062416282, 11946.104042197045, 11751.177417580688, 11875.821862671894, 11913.344766037952, 12030.819537706766, 12111.333876636869, 8243.299319557666, 8275.668973241003, 8283.420160588941, 8356.122607126164, 8839.646414143363, 11469.369184694922, 11697.766044679229, 11832.230904991147, 12013.219140755822, 12042.397880106135], "value": 9978.369817830582, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.855035946045, 1490.7167638148753, 1532.0654400815504, 1614.2655091933173, 1808.2315016118139, 8089.555074470902, 8418.200270974256, 8441.577921103935, 8619.569021548929, 8623.267022303111, 8448.493090414579, 8619.0, 8623.525706086162, 8637.827243455127, 8641.65433382664, 1985.205917632944, 2181.923632672857, 2260.977390226093, 2266.5693518231483, 2294.655801629752, 2229.899654515543, 2238.1271304191296, 2238.160689741347, 2243.2036626997424, 2243.6858839762444, 2259.152817693365, 2259.89830457629, 2319.246244970383, 2319.8724070176136, 2323.546908352872, 1872.5973915608142, 2115.883626400547, 2170.8806015669134, 2178.9782102178933, 2215.601191785478, 2213.380253529014, 2237.093976939342, 2240.1039584166465, 2240.932772016842, 2259.35608351619, 8538.573071346469, 8579.914200858037, 8609.053004169537, 8609.26821220197, 8615.052344242129, 5069.974650126763, 5189.662671926313, 5200.427952925175, 5213.374395072616, 5214.921776173361, 2986.1489475499598, 3066.463368910454, 3139.293658926746, 3151.16494129056, 3173.587433633613, 1017.4048181813574, 1062.6015244283394, 1076.5155679944057, 1089.2320913755784, 1095.8356246563, 12069.577564785279, 12110.212836165621, 12115.818262725978, 12128.272303661808, 12129.575464858775, 4398.934015989698, 4487.080148569536, 4542.432195975503, 4561.589456948891, 4642.744649044267, 10080.798384032425, 10113.747156321151, 10128.34165779222, 10155.64455244063, 10159.9492002541, 5107.8723031923755, 5115.309433226541, 5124.461931497139, 5125.1799712045895, 5127.333446651986, 4204.180184863983, 4349.173657005159, 4466.932996005063, 4468.218061839165, 4536.750478723702, 3966.147278335172, 3991.840326386912, 4049.5545489996075, 4062.614051665087, 4092.7748973806724, 1263.8988880889506, 1276.7446510697898, 1276.7446510697898, 1294.0618051912288, 1309.4500309869877, 933.2394098809449, 998.1066945084109, 998.4907697074399, 1011.5397494140149, 1031.886492485826, 5971.5222782177325, 5983.102534619842, 6010.4891084258325, 6018.8194354169445, 6289.811305660837, 977.7799995001068, 989.9010098990043, 998.4408731110601, 1001.3140998416109, 1028.0233777911014, 3821.6560509554274, 4043.029672878547, 4050.007748101734, 4072.6945479089186, 4105.4662893823615, 10251.38491690501, 10322.896771032343, 10496.527656255486, 10577.524011419504, 10618.840717389245, 10324.690259292232, 10360.119389851947, 10435.37387756722, 10440.112590429899, 10472.371657700562, 8079.4344395892895, 8116.5941702914615, 8242.17578242171, 8274.29668478174, 8277.130901255401, 5694.345150307602, 5857.824265271878, 5874.383189765184, 5896.587238893237, 5907.556933229939, 9864.802703946025, 10013.599456021677, 10052.396856188652, 10123.443210623487, 10162.187025038127, 10155.39067655943, 10190.388576685422, 10208.132308753542, 10256.17950563968, 10323.535440905027, 6361.745530178741, 6886.10480637514, 7093.82265443368, 7108.07595012645, 7201.783946481614, 8303.00363956329, 8319.084900660802, 8346.916530834615, 8363.330933525182, 8386.706465273686, 7241.710331586678, 7356.852862942818, 7440.479166458296, 7472.962635186789, 7538.982237397881, 7084.504084714021, 7187.389071928945, 7247.673854676446, 7283.198848126808, 7419.962900185465, 6924.930750692429, 6960.79117626472, 7004.3696067354185, 7008.264132266243, 7016.052832867497, 4944.134776414041, 5007.899842003067, 5030.2957585937265, 5126.256692779451, 5188.9740551297, 5130.769115389891, 5200.375954885287, 5232.476752324737, 5336.626436149432, 5394.217838413487], "value": 4534.146950482187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.0621955657927, 328.1942830351486, 334.44816053511704, 343.97248220142393, 346.7053004945795, 5162.174052151657, 5236.581073514119, 5257.526822585966, 5334.1732031535075, 5355.678659280441, 5190.195519694444, 5231.529162375386, 5234.063396543284, 5246.7638956246965, 5248.212768084789, 4102.220578090169, 4103.466549348581, 4109.21924834282, 4122.443470131524, 4137.13120244749, 3901.2782635212575, 3929.7249192556533, 4049.311617025113, 4096.160287141144, 4120.979395103035, 4034.0, 4064.5732198119217, 4076.8165432555606, 4119.40268661044, 4119.711620186588, 4027.261462205699, 4069.860439077078, 4072.2059198456313, 4085.673146148301, 4093.9590604093873, 3562.358775420423, 3624.6194149614175, 3657.4696668982847, 3664.853405863789, 3675.3568125578186, 5009.44896061433, 5048.0, 5059.16523773577, 5062.772175252086, 5077.543021128116, 4669.252919532859, 4671.766411679437, 4680.602148817355, 4680.789364478606, 4690.882727931795, 5181.792728290864, 5411.83764487066, 5420.647657902263, 5425.26758887553, 5434.429384914567, 3918.2555314490155, 3920.862769803043, 3925.489686340786, 3932.8820135395986, 3943.7633741975287, 5609.5792815539, 5669.149627555858, 5695.259616249861, 5697.572682048822, 5718.0851063830005, 4031.133306339151, 4033.657139143147, 4035.7174997750462, 4059.106996460774, 4069.593040695907, 3974.205158968218, 4102.958970410257, 4119.567445418248, 4135.545090040093, 4138.379243113497, 4593.586577208067, 4657.6506761992305, 4674.649401294916, 4680.438347398334, 4682.150550532589, 5455.427180146107, 5468.507834294853, 5470.72646367688, 5487.1741053357555, 5498.752556134984, 1373.4025698821044, 1394.4840409048718, 1419.7728363461797, 1437.4322142753554, 1440.164704471404, 928.4197376639601, 929.3726734454216, 936.840737074699, 943.7357539888704, 946.252460556153, 4762.4285085789925, 4808.855734327975, 4815.3017812417, 4818.253170758538, 4843.782029808667, 5073.467285934998, 5097.5981605058905, 5102.642815002914, 5109.8722531937, 5110.28456016158, 4843.951560484421, 4844.588210002119, 4850.466448690641, 4855.490173531799, 5008.57427118699, 2998.355353598943, 3005.8797648093832, 3014.593029940974, 3061.9846900765356, 3074.707902749235, 5845.590808643439, 5845.766169353178, 5884.499817515473, 5938.406159384027, 5940.257467816523, 5547.916781248285, 5767.192593036978, 5817.76728930838, 5848.590598658053, 5855.59010869235, 5839.270091238595, 5921.2302400688495, 5948.821535353946, 5972.25346831646, 5982.700864956735, 5547.4175211603815, 5787.36339002701, 5791.536677065909, 5798.5651076168615, 5808.680522571299, 5609.635373700697, 5610.803621873378, 5658.462446067617, 5675.0, 5680.71596420169, 5828.213191219131, 5841.0, 5912.438318359749, 5987.68270980401, 5996.610220335664, 3818.6945044395825, 3990.201959608148, 4010.6791456682813, 4020.7386519876113, 4029.1135950090934, 5520.641158324696, 5658.660480371191, 5692.943070569241, 5704.201411802268, 5746.482816546531, 5357.758900849549, 5535.667859928417, 5540.695261760642, 5555.30558680165, 5564.581031836856, 5474.479924407175, 5474.835754927359, 5515.200295957144, 5516.641418307797, 5537.972310138423, 5204.947950520446, 5414.187871819101, 5450.836474905759, 5457.372402173642, 5476.138113041585, 5508.586855985737, 5531.640443371168, 5536.335639723259, 5549.973254947848, 5604.719764011865, 5444.183372494158, 5447.073997420369, 5460.153676180198, 5465.316835395575, 5480.3971563128825], "value": 4179.974957671778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.1873183302866, 741.2365263778308, 758.8292634157319, 775.4106878772138, 783.1541934710511, 13301.534446294381, 13644.38600262988, 14095.0, 14242.501512447066, 14251.287435628228, 12439.813402798942, 12445.813312800292, 12445.937770311159, 12451.003919686425, 12455.314957677325, 675.8377989282586, 780.7345502529139, 810.9189081091888, 818.5129847740615, 827.4249396669318, 820.1921107708902, 821.3018933906162, 821.363443331417, 823.8434697407504, 823.9093699693029, 865.8744482050099, 867.1718508824058, 867.301822033263, 867.7093173786758, 867.7526904832124, 708.8582283543286, 819.1194465949069, 854.4147259127486, 856.3662889461816, 856.4732689396039, 625.5496042849142, 625.6496362037228, 625.8967270400378, 626.4988009592308, 626.7868924565624, 13464.663383415394, 13506.594802155852, 13522.391492382867, 13524.25616591087, 13537.458501659921, 13125.474981000749, 13314.667133321647, 13334.466621335136, 13355.065145439727, 13418.46326146953, 11080.667579972614, 11098.944505277503, 11253.0, 12191.939040304742, 12303.077269204845, 4459.64677842378, 4548.681592288541, 4571.2457444521615, 4595.494495605481, 4625.861224163281, 58295.125573116435, 58528.41471585315, 59165.0, 59220.70389648024, 59290.0, 10230.0, 10258.28192026566, 10435.843462348072, 10475.685729428129, 10732.624358147428, 18252.908735456236, 18332.908335458236, 18351.54121146982, 18477.260909563734, 18592.721109183374, 7988.720394786154, 8083.393745469113, 8230.135835737281, 8323.6670533178, 8488.830223395498, 4715.834945776881, 4738.4550776660435, 4801.903961920742, 4836.081144582518, 4881.804727810919, 3274.492453669685, 3321.8671253149605, 3337.098983274551, 3347.3640008398324, 3348.7823291485975, 599.7421108923118, 603.728322254987, 606.2543072021439, 632.2918331468693, 638.958467699598, 694.7116946467261, 701.2041333086983, 702.6592102830124, 713.9393151582174, 729.1614643160408, 9790.853137202948, 9949.353292035994, 9949.751256218507, 10034.949825250827, 10069.244806639532, 656.3567703650449, 695.3046953046953, 712.9964350178319, 715.8747219236612, 719.899214110025, 4638.443386793607, 4650.325702773147, 4698.459677137104, 4705.670603057753, 4752.0, 66873.33126668671, 67429.32570674231, 67702.0, 68116.318836811, 68208.6589567059, 60735.69632151811, 61074.69462652658, 61245.0, 62653.373466265664, 63220.36779632237, 56405.71797140988, 56715.71642141763, 56847.57881052924, 56903.0, 57190.7140464295, 8832.160944710242, 8896.510691912006, 8929.598168082583, 8972.461652300883, 9000.549972501218, 33631.4955275676, 34081.0, 34439.0, 35413.0, 36777.448338274415, 48112.759436203996, 48474.0, 48755.75622121867, 49040.50959490502, 49236.50763492319, 11617.88382116168, 11883.049356051322, 12333.136680432643, 12543.12198146121, 12552.058595605184, 13157.868421316047, 13451.596452106452, 13741.931290343484, 13846.992186133155, 14306.57080287593, 12854.164479308814, 13150.342482876009, 13279.468821247043, 13346.532871349456, 13404.798928016282, 12769.936150319189, 12804.10371274002, 13149.21104733719, 13173.143745656886, 13475.663108421975, 12716.237025778482, 12727.93636031814, 12975.935120324339, 13123.081384303006, 13580.864191358356, 10602.09882160025, 10698.572057117628, 10813.706089776884, 10989.175811814306, 11424.714382140513, 10961.177911656818, 11135.387553684624, 11507.769844603228, 11533.077353811843, 11564.710882228012], "value": 6858.245080595308, "unit": "score"}], "name": "dromaeo_css", "value": 7119.677405831061, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 120.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 126.0, 189.0, 138.0, 125.0, 154.0, 126.0, 154.0, 125.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 73.0, 74.0, 74.0, 75.0, 105.0, 73.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 126.0, 83.0, 84.0, 84.0, 121.0, 84.0, 83.0, 120.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 72.0, 52.0, 52.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 80.0, 79.0, 79.0, 81.0, 81.0, 81.0, 82.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 125.0, 120.0, 118.0, 132.0, 130.0, 130.0, 176.0, 121.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 160.0, 160.0, 158.0, 161.0, 166.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 69.0, 63.0, 63.0, 63.0, 67.0, 62.0, 62.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1499.5, "alertThreshold": 2.0}]} 20:19:17 INFO - Return code: 0 20:19:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:17 ERROR - # TBPL SUCCESS # 20:19:17 INFO - Running post-action listener: _resource_record_post_action 20:19:17 INFO - ##### 20:19:17 INFO - ##### Finished run-tests step (success) 20:19:17 INFO - ##### 20:19:17 INFO - Running post-run listener: _resource_record_post_run 20:19:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 546648064; Read time: 0; Write time: 483628 20:19:17 INFO - TinderboxPrint: CPU usage
13.1% 20:19:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:19:17 INFO - TinderboxPrint: I/O write bytes / time
546,648,064 / 483,628 20:19:17 INFO - TinderboxPrint: CPU idle
8,261.2 (86.9%) 20:19:17 INFO - TinderboxPrint: CPU user
1,200.2 (12.6%) 20:19:17 INFO - TinderboxPrint: Swap in / out
0 / 0 20:19:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254734336; Read time: 0; Write time: 264728 20:19:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291913728; Read time: 0; Write time: 218900 20:19:17 INFO - Running post-run listener: _upload_blobber_files 20:19:17 INFO - Blob upload gear active. 20:19:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:19:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:19:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:21 INFO - (blobuploader) - INFO - Done attempting. 20:19:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:22 INFO - (blobuploader) - INFO - Done attempting. 20:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:23 INFO - (blobuploader) - INFO - Done attempting. 20:19:23 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:23 INFO - Return code: 0 20:19:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fadada06d0febba73404a510c65c6a8d3f4872a53a965cee5bdf3e471d47b4da5d967527860e6279877e09d140d42f810ad41747d5fd8cbc5a478103ff07fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40153389e3d55adb58070da15e40ec88b4456917e2ca30e2c51493057d0aabd3cfc35a6d4434cb30168bbe510b0c66a7f6c51f86b7b697492e1da73a70981b20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac132120aee48e64d7da2f5344b5a38071a21b3c8899e469a767b315d968a965607d9e822da211fe3f29e0450ce5dd95075a15c45ab7bca3cc85f794bf838069"} 20:19:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:23 INFO - Contents: 20:19:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6fadada06d0febba73404a510c65c6a8d3f4872a53a965cee5bdf3e471d47b4da5d967527860e6279877e09d140d42f810ad41747d5fd8cbc5a478103ff07fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40153389e3d55adb58070da15e40ec88b4456917e2ca30e2c51493057d0aabd3cfc35a6d4434cb30168bbe510b0c66a7f6c51f86b7b697492e1da73a70981b20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac132120aee48e64d7da2f5344b5a38071a21b3c8899e469a767b315d968a965607d9e822da211fe3f29e0450ce5dd95075a15c45ab7bca3cc85f794bf838069"} 20:19:23 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:23 INFO - Copying logs to upload dir... 20:19:23 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.564055 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-24 20:19:22.994743) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:22.998057) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 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/6fadada06d0febba73404a510c65c6a8d3f4872a53a965cee5bdf3e471d47b4da5d967527860e6279877e09d140d42f810ad41747d5fd8cbc5a478103ff07fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40153389e3d55adb58070da15e40ec88b4456917e2ca30e2c51493057d0aabd3cfc35a6d4434cb30168bbe510b0c66a7f6c51f86b7b697492e1da73a70981b20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac132120aee48e64d7da2f5344b5a38071a21b3c8899e469a767b315d968a965607d9e822da211fe3f29e0450ce5dd95075a15c45ab7bca3cc85f794bf838069"} build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/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/6fadada06d0febba73404a510c65c6a8d3f4872a53a965cee5bdf3e471d47b4da5d967527860e6279877e09d140d42f810ad41747d5fd8cbc5a478103ff07fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40153389e3d55adb58070da15e40ec88b4456917e2ca30e2c51493057d0aabd3cfc35a6d4434cb30168bbe510b0c66a7f6c51f86b7b697492e1da73a70981b20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac132120aee48e64d7da2f5344b5a38071a21b3c8899e469a767b315d968a965607d9e822da211fe3f29e0450ce5dd95075a15c45ab7bca3cc85f794bf838069"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:23.024565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:23.024987) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464137674.95057-1592710313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:23.108455) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:19:23.108774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:19:23.109059) ========= ========= Total master_lag: 0.19 =========