builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466910199.38 results: success (0) buildid: 20160625173005 builduid: 8e08e983ca394de9ad0933396bdbd64d revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.376126) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.376597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.376919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.391929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.392237) ========= 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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 20:03:19-- 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% 228M=0s 2016-06-25 20:03:19 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.519604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.520033) ========= 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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.570445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:19.570866) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 076e176ce22e2602f63781027b0b18c1977cddd0 --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 076e176ce22e2602f63781027b0b18c1977cddd0 --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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 20:03:19,818 truncating revision to first 12 chars 2016-06-25 20:03:19,818 Setting DEBUG logging. 2016-06-25 20:03:19,819 attempt 1/10 2016-06-25 20:03:19,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/076e176ce22e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 20:03:20,248 unpacking tar archive at: fx-team-076e176ce22e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:20.359851) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:20.360172) ========= script_repo_revision: 076e176ce22e2602f63781027b0b18c1977cddd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:20.360623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:20.360968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 20:03:20.372386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-25 20:03:20.372719) ========= /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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:03:20 INFO - MultiFileLogger online at 20160625 20:03:20 in /builds/slave/test 20:03:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:03:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:20 INFO - {'append_to_log': False, 20:03:20 INFO - 'base_work_dir': '/builds/slave/test', 20:03:20 INFO - 'blob_upload_branch': 'Fx-Team', 20:03:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:20 INFO - 'branch': 'Fx-Team', 20:03:20 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:20 INFO - 'config_files': ('talos/linux_config.py',), 20:03:20 INFO - 'default_actions': ('clobber', 20:03:20 INFO - 'read-buildbot-config', 20:03:20 INFO - 'download-and-extract', 20:03:20 INFO - 'populate-webroot', 20:03:20 INFO - 'create-virtualenv', 20:03:20 INFO - 'install', 20:03:20 INFO - 'run-tests'), 20:03:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:20 INFO - 'download_minidump_stackwalk': True, 20:03:20 INFO - 'download_symbols': 'ondemand', 20:03:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:20 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:20 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:20 INFO - 'installer_path': 'installer.exe', 20:03:20 INFO - 'log_level': 'info', 20:03:20 INFO - 'log_name': 'talos', 20:03:20 INFO - 'log_to_console': True, 20:03:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:03:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:03:20 INFO - 'opt_config_files': (), 20:03:20 INFO - 'pip_index': False, 20:03:20 INFO - 'sps_profile': False, 20:03:20 INFO - 'sps_profile_interval': 0, 20:03:20 INFO - 'suite': 'dromaeojs', 20:03:20 INFO - 'system_bits': '32', 20:03:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:20 INFO - 'title': 'talos-linux64-ix-017', 20:03:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:20 INFO - 'use_talos_json': True, 20:03:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:20 INFO - 'work_dir': 'build'} 20:03:20 INFO - ##### 20:03:20 INFO - ##### Running clobber step. 20:03:20 INFO - ##### 20:03:20 INFO - Running pre-action listener: _resource_record_pre_action 20:03:20 INFO - Running main action method: clobber 20:03:20 INFO - rmtree: /builds/slave/test/build 20:03:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:21 INFO - Running post-action listener: _resource_record_post_action 20:03:21 INFO - ##### 20:03:21 INFO - ##### Finished clobber step (success) 20:03:21 INFO - ##### 20:03:21 INFO - ##### 20:03:21 INFO - ##### Running read-buildbot-config step. 20:03:21 INFO - ##### 20:03:21 INFO - Running pre-action listener: _resource_record_pre_action 20:03:21 INFO - Running main action method: read_buildbot_config 20:03:21 INFO - Using buildbot properties: 20:03:21 INFO - { 20:03:21 INFO - "project": "", 20:03:21 INFO - "product": "firefox", 20:03:21 INFO - "script_repo_revision": "production", 20:03:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:03:21 INFO - "repository": "", 20:03:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:03:21 INFO - "buildid": "20160625173005", 20:03:21 INFO - "pgo_build": "True", 20:03:21 INFO - "basedir": "/builds/slave/test", 20:03:21 INFO - "buildnumber": 214, 20:03:21 INFO - "slavename": "talos-linux64-ix-017", 20:03:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:03:21 INFO - "platform": "ubuntu64_hw", 20:03:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:03:21 INFO - "branch": "fx-team", 20:03:21 INFO - "repo_path": "integration/fx-team", 20:03:21 INFO - "revision": "076e176ce22e2602f63781027b0b18c1977cddd0", 20:03:21 INFO - "stage_platform": "linux64-pgo", 20:03:21 INFO - "builduid": "8e08e983ca394de9ad0933396bdbd64d", 20:03:21 INFO - "slavebuilddir": "test" 20:03:21 INFO - } 20:03:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:03:21 INFO - Running post-action listener: _resource_record_post_action 20:03:21 INFO - ##### 20:03:21 INFO - ##### Finished read-buildbot-config step (success) 20:03:21 INFO - ##### 20:03:21 INFO - ##### 20:03:21 INFO - ##### Running download-and-extract step. 20:03:21 INFO - ##### 20:03:21 INFO - Running pre-action listener: _resource_record_pre_action 20:03:21 INFO - Running main action method: download_and_extract 20:03:21 INFO - mkdir: /builds/slave/test/build/tests 20:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:21 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:03:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:03:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:03:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:03:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:03:24 INFO - Downloaded 1361 bytes. 20:03:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:03:24 INFO - Using the following test package requirements: 20:03:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:03:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:03:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:03:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'jsshell-linux-x86_64.zip'], 20:03:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:03:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:03:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:03:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:03:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:03:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:03:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:03:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:24 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:25 INFO - Downloaded 24279375 bytes. 20:03:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:03:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:03:26 INFO - Return code: 0 20:03:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:26 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:03:28 INFO - Downloaded 24279375 bytes. 20:03:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:03:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:03:29 INFO - Return code: 0 20:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:29 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:03:31 INFO - Downloaded 14405240 bytes. 20:03:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:03:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:03:31 INFO - Return code: 0 20:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:31 INFO - https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:03:34 INFO - Downloaded 60153265 bytes. 20:03:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:03:34 INFO - mkdir: /builds/slave/test/properties 20:03:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:34 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:34 INFO - Contents: 20:03:34 INFO - build_url:https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - Running post-action listener: set_extra_try_arguments 20:03:35 INFO - ##### 20:03:35 INFO - ##### Finished download-and-extract step (success) 20:03:35 INFO - ##### 20:03:35 INFO - ##### 20:03:35 INFO - ##### Running populate-webroot step. 20:03:35 INFO - ##### 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: populate_webroot 20:03:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:35 INFO - '--tppagecycles', 20:03:35 INFO - '7'], 20:03:35 INFO - 'tests': ['tsvgm']}}, 20:03:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['damp', 'tps']}, 20:03:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'tests': ['damp', 'tps']}, 20:03:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['dromaeo_dom']}, 20:03:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['basic_compositor_video']}, 20:03:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:03:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['a11yr', 20:03:35 INFO - 'ts_paint', 20:03:35 INFO - 'tpaint', 20:03:35 INFO - 'sessionrestore', 20:03:35 INFO - 'sessionrestore_no_auto_restore', 20:03:35 INFO - 'tabpaint']}, 20:03:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tsvgx', 20:03:35 INFO - 'tsvgr_opacity', 20:03:35 INFO - 'tart', 20:03:35 INFO - 'tscrollx', 20:03:35 INFO - 'cart']}, 20:03:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:35 INFO - 'tsvgr_opacity', 20:03:35 INFO - 'tart', 20:03:35 INFO - 'tscrollx', 20:03:35 INFO - 'cart']}, 20:03:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s'], 20:03:35 INFO - 'tests': ['tp5o']}, 20:03:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'tests': ['tp5o']}, 20:03:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'talos_options': ['--disable-e10s', 20:03:35 INFO - '--xperf_path', 20:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:35 INFO - 'tests': ['tp5n']}, 20:03:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:35 INFO - 'talos_options': ['--xperf_path', 20:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:35 INFO - 'tests': ['tp5n']}}, 20:03:35 INFO - 'talos.zip': {'path': '', 20:03:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - ##### 20:03:35 INFO - ##### Finished populate-webroot step (success) 20:03:35 INFO - ##### 20:03:35 INFO - ##### 20:03:35 INFO - ##### Running create-virtualenv step. 20:03:35 INFO - ##### 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: create_virtualenv 20:03:35 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:03:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:35 INFO - Using real prefix '/usr' 20:03:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:35 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:37 INFO - Installing pip.................done. 20:03:37 INFO - Return code: 0 20:03:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:37 INFO - Using env: {'DISPLAY': ':0', 20:03:37 INFO - 'HOME': '/home/cltbld', 20:03:37 INFO - 'LANG': 'en_US.UTF-8', 20:03:37 INFO - 'LANGUAGE': 'en_US:en', 20:03:37 INFO - 'LOGNAME': 'cltbld', 20:03:37 INFO - 'MAIL': '/var/mail/cltbld', 20:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:37 INFO - 'MOZ_NO_REMOTE': '1', 20:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:37 INFO - 'NO_EM_RESTART': '1', 20:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:37 INFO - 'PWD': '/builds/slave/test', 20:03:37 INFO - 'SHELL': '/bin/bash', 20:03:37 INFO - 'SHLVL': '1', 20:03:37 INFO - 'TERM': 'linux', 20:03:37 INFO - 'TMOUT': '86400', 20:03:37 INFO - 'USER': 'cltbld', 20:03:37 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:37 INFO - '_': '/tools/buildbot/bin/python'} 20:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:03:37 INFO - Cleaning up... 20:03:37 INFO - Return code: 0 20:03:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:03:37 INFO - Using env: {'DISPLAY': ':0', 20:03:37 INFO - 'HOME': '/home/cltbld', 20:03:37 INFO - 'LANG': 'en_US.UTF-8', 20:03:37 INFO - 'LANGUAGE': 'en_US:en', 20:03:37 INFO - 'LOGNAME': 'cltbld', 20:03:37 INFO - 'MAIL': '/var/mail/cltbld', 20:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:37 INFO - 'MOZ_NO_REMOTE': '1', 20:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:37 INFO - 'NO_EM_RESTART': '1', 20:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:37 INFO - 'PWD': '/builds/slave/test', 20:03:37 INFO - 'SHELL': '/bin/bash', 20:03:37 INFO - 'SHLVL': '1', 20:03:37 INFO - 'TERM': 'linux', 20:03:37 INFO - 'TMOUT': '86400', 20:03:37 INFO - 'USER': 'cltbld', 20:03:37 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:37 INFO - '_': '/tools/buildbot/bin/python'} 20:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:38 INFO - Downloading/unpacking psutil>=3.1.1 20:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:40 INFO - Installing collected packages: psutil 20:03:40 INFO - Running setup.py install for psutil 20:03:40 INFO - building 'psutil._psutil_linux' extension 20:03:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:03:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:03:40 INFO - building 'psutil._psutil_posix' extension 20:03:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:03:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:40 INFO - Successfully installed psutil 20:03:40 INFO - Cleaning up... 20:03:40 INFO - Return code: 0 20:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:03:40 INFO - Using env: {'DISPLAY': ':0', 20:03:40 INFO - 'HOME': '/home/cltbld', 20:03:40 INFO - 'LANG': 'en_US.UTF-8', 20:03:40 INFO - 'LANGUAGE': 'en_US:en', 20:03:40 INFO - 'LOGNAME': 'cltbld', 20:03:40 INFO - 'MAIL': '/var/mail/cltbld', 20:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:40 INFO - 'MOZ_NO_REMOTE': '1', 20:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:40 INFO - 'NO_EM_RESTART': '1', 20:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:40 INFO - 'PWD': '/builds/slave/test', 20:03:40 INFO - 'SHELL': '/bin/bash', 20:03:40 INFO - 'SHLVL': '1', 20:03:40 INFO - 'TERM': 'linux', 20:03:40 INFO - 'TMOUT': '86400', 20:03:40 INFO - 'USER': 'cltbld', 20:03:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:40 INFO - '_': '/tools/buildbot/bin/python'} 20:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:03:42 INFO - Installing collected packages: mozsystemmonitor 20:03:42 INFO - Running setup.py install for mozsystemmonitor 20:03:42 INFO - Successfully installed mozsystemmonitor 20:03:42 INFO - Cleaning up... 20:03:42 INFO - Return code: 0 20:03:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:42 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:42 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==2.5.1'] in /builds/slave/test/build 20:03:42 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==2.5.1 20:03:42 INFO - Using env: {'DISPLAY': ':0', 20:03:42 INFO - 'HOME': '/home/cltbld', 20:03:42 INFO - 'LANG': 'en_US.UTF-8', 20:03:42 INFO - 'LANGUAGE': 'en_US:en', 20:03:42 INFO - 'LOGNAME': 'cltbld', 20:03:42 INFO - 'MAIL': '/var/mail/cltbld', 20:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:42 INFO - 'MOZ_NO_REMOTE': '1', 20:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:42 INFO - 'NO_EM_RESTART': '1', 20:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:42 INFO - 'PWD': '/builds/slave/test', 20:03:42 INFO - 'SHELL': '/bin/bash', 20:03:42 INFO - 'SHLVL': '1', 20:03:42 INFO - 'TERM': 'linux', 20:03:42 INFO - 'TMOUT': '86400', 20:03:42 INFO - 'USER': 'cltbld', 20:03:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:42 INFO - '_': '/tools/buildbot/bin/python'} 20:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:43 INFO - Downloading/unpacking jsonschema==2.5.1 20:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:45 INFO - warning: no files found matching '*.txt' 20:03:45 INFO - no previously-included directories found matching 'build' 20:03:45 INFO - no previously-included directories found matching 'dist' 20:03:45 INFO - no previously-included directories found matching '.git*' 20:03:45 INFO - Installing collected packages: jsonschema, functools32 20:03:45 INFO - Running setup.py install for functools32 20:03:45 INFO - warning: no files found matching '*.txt' 20:03:45 INFO - no previously-included directories found matching 'build' 20:03:45 INFO - no previously-included directories found matching 'dist' 20:03:45 INFO - no previously-included directories found matching '.git*' 20:03:45 INFO - Successfully installed jsonschema functools32 20:03:45 INFO - Cleaning up... 20:03:45 INFO - Return code: 0 20:03:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 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 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:03:45 INFO - Using env: {'DISPLAY': ':0', 20:03:45 INFO - 'HOME': '/home/cltbld', 20:03:45 INFO - 'LANG': 'en_US.UTF-8', 20:03:45 INFO - 'LANGUAGE': 'en_US:en', 20:03:45 INFO - 'LOGNAME': 'cltbld', 20:03:45 INFO - 'MAIL': '/var/mail/cltbld', 20:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:45 INFO - 'MOZ_NO_REMOTE': '1', 20:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:45 INFO - 'NO_EM_RESTART': '1', 20:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:45 INFO - 'PWD': '/builds/slave/test', 20:03:45 INFO - 'SHELL': '/bin/bash', 20:03:45 INFO - 'SHLVL': '1', 20:03:45 INFO - 'TERM': 'linux', 20:03:45 INFO - 'TMOUT': '86400', 20:03:45 INFO - 'USER': 'cltbld', 20:03:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:45 INFO - '_': '/tools/buildbot/bin/python'} 20:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:47 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:48 INFO - Downloading docopt-0.6.1.tar.gz 20:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:48 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:48 INFO - Running setup.py install for blobuploader 20:03:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:48 INFO - Running setup.py install for requests 20:03:48 INFO - Running setup.py install for docopt 20:03:48 INFO - Successfully installed blobuploader requests docopt 20:03:48 INFO - Cleaning up... 20:03:49 INFO - Return code: 0 20:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:49 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 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:49 INFO - Using env: {'DISPLAY': ':0', 20:03:49 INFO - 'HOME': '/home/cltbld', 20:03:49 INFO - 'LANG': 'en_US.UTF-8', 20:03:49 INFO - 'LANGUAGE': 'en_US:en', 20:03:49 INFO - 'LOGNAME': 'cltbld', 20:03:49 INFO - 'MAIL': '/var/mail/cltbld', 20:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:49 INFO - 'MOZ_NO_REMOTE': '1', 20:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:49 INFO - 'NO_EM_RESTART': '1', 20:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:49 INFO - 'PWD': '/builds/slave/test', 20:03:49 INFO - 'SHELL': '/bin/bash', 20:03:49 INFO - 'SHLVL': '1', 20:03:49 INFO - 'TERM': 'linux', 20:03:49 INFO - 'TMOUT': '86400', 20:03:49 INFO - 'USER': 'cltbld', 20:03:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:49 INFO - '_': '/tools/buildbot/bin/python'} 20:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:49 INFO - Running setup.py (path:/tmp/pip-O3ADKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:49 INFO - Running setup.py (path:/tmp/pip-5uITzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:49 INFO - Running setup.py (path:/tmp/pip-XunKT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:49 INFO - Running setup.py (path:/tmp/pip-XcO537-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:49 INFO - Running setup.py (path:/tmp/pip-lPDTvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:49 INFO - Running setup.py (path:/tmp/pip-84rctQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:49 INFO - Running setup.py (path:/tmp/pip-lKJND_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:49 INFO - Running setup.py (path:/tmp/pip-CWB1wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:49 INFO - Running setup.py (path:/tmp/pip-EGFOkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:49 INFO - Running setup.py (path:/tmp/pip-7K5RlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:49 INFO - Running setup.py (path:/tmp/pip-t6PUsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:50 INFO - Running setup.py (path:/tmp/pip-FqkKpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:50 INFO - Running setup.py (path:/tmp/pip-63uAE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:50 INFO - Running setup.py (path:/tmp/pip-ETHHWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:50 INFO - Running setup.py (path:/tmp/pip-HJh50e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:50 INFO - Running setup.py (path:/tmp/pip-M9JszC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:50 INFO - Running setup.py (path:/tmp/pip-_pHDBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:50 INFO - Running setup.py install for manifestparser 20:03:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:50 INFO - Running setup.py install for mozcrash 20:03:50 INFO - Running setup.py install for mozdebug 20:03:50 INFO - Running setup.py install for mozdevice 20:03:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:03:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:50 INFO - Running setup.py install for mozfile 20:03:50 INFO - Running setup.py install for mozhttpd 20:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozinfo 20:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozInstall 20:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozleak 20:03:51 INFO - Running setup.py install for mozlog 20:03:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for moznetwork 20:03:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozprocess 20:03:51 INFO - Running setup.py install for mozprofile 20:03:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozrunner 20:03:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:51 INFO - Running setup.py install for mozscreenshot 20:03:52 INFO - Running setup.py install for moztest 20:03:52 INFO - Running setup.py install for mozversion 20:03:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:03:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:52 INFO - Cleaning up... 20:03:52 INFO - Return code: 0 20:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03: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')]} 20:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:52 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 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:52 INFO - Using env: {'DISPLAY': ':0', 20:03:52 INFO - 'HOME': '/home/cltbld', 20:03:52 INFO - 'LANG': 'en_US.UTF-8', 20:03:52 INFO - 'LANGUAGE': 'en_US:en', 20:03:52 INFO - 'LOGNAME': 'cltbld', 20:03:52 INFO - 'MAIL': '/var/mail/cltbld', 20:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:52 INFO - 'MOZ_NO_REMOTE': '1', 20:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:52 INFO - 'NO_EM_RESTART': '1', 20:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:52 INFO - 'PWD': '/builds/slave/test', 20:03:52 INFO - 'SHELL': '/bin/bash', 20:03:52 INFO - 'SHLVL': '1', 20:03:52 INFO - 'TERM': 'linux', 20:03:52 INFO - 'TMOUT': '86400', 20:03:52 INFO - 'USER': 'cltbld', 20:03:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:52 INFO - '_': '/tools/buildbot/bin/python'} 20:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:52 INFO - Running setup.py (path:/tmp/pip-kQGd_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:52 INFO - Running setup.py (path:/tmp/pip-icNn8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:52 INFO - Running setup.py (path:/tmp/pip-tib4mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:52 INFO - Running setup.py (path:/tmp/pip-ld4Wzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:52 INFO - Running setup.py (path:/tmp/pip-Am8Uoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:52 INFO - Running setup.py (path:/tmp/pip-xxiDKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:52 INFO - Running setup.py (path:/tmp/pip-yhHsM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:52 INFO - Running setup.py (path:/tmp/pip-wKFn_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:53 INFO - Running setup.py (path:/tmp/pip-ZIgvvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:53 INFO - Running setup.py (path:/tmp/pip-gGllSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:53 INFO - Running setup.py (path:/tmp/pip-P87kWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:53 INFO - Running setup.py (path:/tmp/pip-8ZSI5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:53 INFO - Running setup.py (path:/tmp/pip-A4PBYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:53 INFO - Running setup.py (path:/tmp/pip-GSWaG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:53 INFO - Running setup.py (path:/tmp/pip-uTArsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:53 INFO - Running setup.py (path:/tmp/pip-TWd4Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:53 INFO - Running setup.py (path:/tmp/pip-ueFGwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:55 INFO - Downloading blessings-1.6.tar.gz 20:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:55 INFO - Installing collected packages: blessings 20:03:55 INFO - Running setup.py install for blessings 20:03:55 INFO - Successfully installed blessings 20:03:55 INFO - Cleaning up... 20:03:55 INFO - Return code: 0 20:03:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:56 INFO - Reading from file tmpfile_stdout 20:03:56 INFO - Current package versions: 20:03:56 INFO - argparse == 1.2.1 20:03:56 INFO - blessings == 1.6 20:03:56 INFO - blobuploader == 1.2.4 20:03:56 INFO - docopt == 0.6.1 20:03:56 INFO - functools32 == 3.2.3-2 20:03:56 INFO - jsonschema == 2.5.1 20:03:56 INFO - manifestparser == 1.1 20:03:56 INFO - mozInstall == 1.12 20:03:56 INFO - mozcrash == 0.17 20:03:56 INFO - mozdebug == 0.1 20:03:56 INFO - mozdevice == 0.48 20:03:56 INFO - mozfile == 1.2 20:03:56 INFO - mozhttpd == 0.7 20:03:56 INFO - mozinfo == 0.9 20:03:56 INFO - mozleak == 0.1 20:03:56 INFO - mozlog == 3.2 20:03:56 INFO - moznetwork == 0.27 20:03:56 INFO - mozprocess == 0.22 20:03:56 INFO - mozprofile == 0.28 20:03:56 INFO - mozrunner == 6.11 20:03:56 INFO - mozscreenshot == 0.1 20:03:56 INFO - mozsystemmonitor == 0.3 20:03:56 INFO - moztest == 0.7 20:03:56 INFO - mozversion == 1.4 20:03:56 INFO - psutil == 3.1.1 20:03:56 INFO - requests == 1.2.3 20:03:56 INFO - wsgiref == 0.1.2 20:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 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 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd54946ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2174590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, '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': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:56 INFO - Downloading/unpacking flake8 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:59 INFO - no previously-included directories found matching 'docs/_build' 20:03:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:59 INFO - Running setup.py install for pep8 20:03:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:59 INFO - no previously-included directories found matching 'docs/_build' 20:03:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:59 INFO - Cleaning up... 20:03:59 INFO - Return code: 0 20:03:59 INFO - Running post-action listener: _resource_record_post_action 20:03:59 INFO - Running post-action listener: _start_resource_monitoring 20:03:59 INFO - Starting resource monitoring. 20:03:59 INFO - ##### 20:03:59 INFO - ##### Finished create-virtualenv step (success) 20:03:59 INFO - ##### 20:03:59 INFO - ##### 20:03:59 INFO - ##### Running install step. 20:03:59 INFO - ##### 20:03:59 INFO - Running pre-action listener: _resource_record_pre_action 20:03:59 INFO - Running main action method: install 20:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:59 INFO - Reading from file tmpfile_stdout 20:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:03:59 INFO - Reading from file tmpfile_stdout 20:03:59 INFO - Output received: 20:03:59 INFO - Usage: mozinstall [options] installer 20:03:59 INFO - Options: 20:03:59 INFO - -h, --help show this help message and exit 20:03:59 INFO - -d DEST, --destination=DEST 20:03:59 INFO - Directory to install application into. [default: 20:03:59 INFO - "/builds/slave/test"] 20:03:59 INFO - --app=APP Application being installed. [default: firefox] 20:03:59 INFO - mkdir: /builds/slave/test/build/application 20:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:04:16 INFO - Reading from file tmpfile_stdout 20:04:16 INFO - Output received: 20:04:16 INFO - /builds/slave/test/build/application/firefox/firefox 20:04:16 INFO - Running post-action listener: _resource_record_post_action 20:04:16 INFO - ##### 20:04:16 INFO - ##### Finished install step (success) 20:04:16 INFO - ##### 20:04:16 INFO - ##### 20:04:16 INFO - ##### Running run-tests step. 20:04:16 INFO - ##### 20:04:16 INFO - Running pre-action listener: _resource_record_pre_action 20:04:16 INFO - Running main action method: run_tests 20:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:16 INFO - Python 2.7.3 20:04:16 INFO - Return code: 0 20:04:16 INFO - grabbing minidump binary from tooltool 20:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203570>, '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 0x2204470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2204920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:04:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:04:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:04:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:17 INFO - Return code: 0 20:04:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:04:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:04:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:04:17 INFO - Return code: 0 20:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:04:17 INFO - Using env: {'DISPLAY': ':0', 20:04:17 INFO - 'HOME': '/home/cltbld', 20:04:17 INFO - 'LANG': 'en_US.UTF-8', 20:04:17 INFO - 'LANGUAGE': 'en_US:en', 20:04:17 INFO - 'LOGNAME': 'cltbld', 20:04:17 INFO - 'MAIL': '/var/mail/cltbld', 20:04:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:17 INFO - 'MOZ_NO_REMOTE': '1', 20:04:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:17 INFO - 'NO_EM_RESTART': '1', 20:04:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:17 INFO - 'PWD': '/builds/slave/test', 20:04:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:17 INFO - 'SHELL': '/bin/bash', 20:04:17 INFO - 'SHLVL': '1', 20:04:17 INFO - 'TERM': 'linux', 20:04:17 INFO - 'TMOUT': '86400', 20:04:17 INFO - 'USER': 'cltbld', 20:04:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588', 20:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:17 INFO - '_': '/tools/buildbot/bin/python'} 20:04:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:04:18 INFO - mozversion application_buildid: 20160625173005 20:04:18 INFO - mozversion application_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 20:04:18 INFO - mozversion application_display_name: Nightly 20:04:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:18 INFO - mozversion application_name: Firefox 20:04:18 INFO - mozversion application_remotingname: firefox 20:04:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:04:18 INFO - mozversion application_vendor: Mozilla 20:04:18 INFO - mozversion application_version: 50.0a1 20:04:18 INFO - mozversion platform_buildid: 20160625173005 20:04:18 INFO - mozversion platform_changeset: 076e176ce22e2602f63781027b0b18c1977cddd0 20:04:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:04:18 INFO - mozversion platform_version: 50.0a1 20:04:18 INFO - using testdate: 1466910258 20:04:18 INFO - actual date: 1466910258 20:04:18 INFO - starting webserver on 'localhost:49540' 20:04:18 INFO - SUITE-START | Running 2 tests 20:04:18 INFO - TEST-START | dromaeo_css 20:04:18 INFO - operating with platform_type : linux_ 20:04:18 INFO - Initialising browser for dromaeo_css test... 20:04:18 INFO - TEST-INFO | started process 26042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi_DhNQ/profile http://localhost:49540/getInfo.html) 20:04:21 INFO - PROCESS | 26042 | __metrics Screen width/height:1600/1200 20:04:21 INFO - PROCESS | 26042 | colorDepth:24 20:04:21 INFO - PROCESS | 26042 | Browser inner width/height: 1024/697 20:04:21 INFO - PROCESS | 26042 | __metrics 20:04:22 INFO - PROCESS | 26042 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:04:23 INFO - TEST-INFO | 26042: exit 0 20:04:23 INFO - Browser initialized. 20:04:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:23 INFO - TEST-INFO | started process 26121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi_DhNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:35 INFO - PROCESS | 26121 | RSS: Main: 173588480 20:04:35 INFO - PROCESS | 26121 | 20:05:26 INFO - PROCESS | 26121 | 1466910326985 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:07:34 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49540/tests/dromaeo/cssquery-ext.html) 20:07:35 INFO - PROCESS | 26121 | RSS: Main: 276172800 20:07:35 INFO - PROCESS | 26121 | 20:10:38 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-ext.html (next: http://localhost:49540/tests/dromaeo/cssquery-jquery.html) 20:10:38 INFO - PROCESS | 26121 | RSS: Main: 258441216 20:10:38 INFO - PROCESS | 26121 | 20:13:40 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49540/tests/dromaeo/cssquery-mootools.html) 20:13:41 INFO - PROCESS | 26121 | RSS: Main: 257445888 20:13:41 INFO - PROCESS | 26121 | 20:16:43 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49540/tests/dromaeo/cssquery-prototype.html) 20:16:43 INFO - PROCESS | 26121 | RSS: Main: 248336384 20:16:43 INFO - PROCESS | 26121 | 20:19:46 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49540/tests/dromaeo/cssquery-yui.html) 20:19:47 INFO - PROCESS | 26121 | RSS: Main: 240803840 20:19:47 INFO - PROCESS | 26121 | 20:22:49 INFO - PROCESS | 26121 | Cycle 1(1): loaded http://localhost:49540/tests/dromaeo/cssquery-yui.html (next: http://localhost:49540/tests/dromaeo/cssquery-dojo.html) 20:22:50 INFO - PROCESS | 26121 | RSS: Main: 286633984 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | __start_tp_report 20:22:50 INFO - PROCESS | 26121 | _x_x_mozilla_page_load 20:22:50 INFO - PROCESS | 26121 | _x_x_mozilla_page_load_details 20:22:50 INFO - PROCESS | 26121 | |i|pagename|runs| 20:22:50 INFO - PROCESS | 26121 | |0;dojo.html;3046.4668682980478;3055.5569442430833;3061.020473448497;3062.2956719954395;3108.4404807134706;5272.314599102111;5276.736163191839;5334.253204551356;5411.485908838659;5435.320584926879;5372.301600791891;5388.488093631108;5412.512873841353;5454.809081682132;5509.035918714219;4843.564079232869;4904.681195722275;4923.55687988081;4925.926111108336;5027.296178535008;4914.287428322891;4925.408950925894;4953.331300274471;4975.477574854643;4984;4779.259214821708;4815.614750819926;4835.443923948738;4845.927311090337;4892.6575139740235;4832.806687732486;4839.612830973549;4853.587445067174;4866.732329721864;4902.411710594716;4739.549742774431;4812.7352995585225;4838.177509823338;4838.879028024292;4881.34101896243;5299.4435584263865;5363.490468405495;5375.381831089436;5419.729013549346;5428.782848686048;5733.741981610838;5801.622894511843;5810.854728631776;5811.709414529257;5812.389699081577;5600.803971860965;5793.768249270024;5853.941460585383;5863.208466857005;5868.03177475716;5448.56411487084;5464.0711079116645;5464.590155738336;5468.6171967962255;5471.781128754845;5947.940520594825;5954.85112872173;5955.940440595538;5959.225300710967;5959.761609535657;5516.503514683698;5611.046122159243;5657.20799088128;5714.457126572969;5720.914186287209;5771.94228057714;5776.220210271559;5815.360310365856;5824.155497452845;5827.825165244964;5693.9430605693415;5748;5751.942480575224;5757.424257574293;5763.337216220105;5517.034518959166;5613.859653508695;5647.407022262685;5651.124075768263;5752.050911599539;4315.935260971088;4320.265554855682;4325.653947684178;4332.653387728974;4361.3676016978;3848.3842585186794;3873.903152421212;3884.1066554692015;3894.883153505399;3897.0452239201577;5293.602979776532;5302.681839089667;5397;5402.6758394496455;5440.782368705208;5788.160716696056;5793.681347525842;5813.941860581424;5814.3313518945015;5852.678102704393;5318.760655770499;5460.290162278879;5460.5085542301385;5464.426235245242;5474.972625136849;4888.877778055506;4905.754712264373;4929.285253638202;4974;4979.153543897546;5960.433758792908;5970.432808883149;5970.880582388328;5971.820845374646;5974.61165024272;5576.86057848557;5697.601167918206;5803.332616749128;5813.186153938367;5817.360090390139;5908.054711246352;5964.9105263420215;5972.910406343995;5976.073708575178;6029.758809647565;5652.802151924663;5691.77232910679;5698.344690360662;5700.771969121189;5703.971480142573;5600.8879822402505;5696.0316746154085;5704.172894930295;5782.45066718661;5808.6805225711305;5624.493795558419;5635.577331700057;5637.577181711306;5645.689487078086;5690.9430905690415;5577.96807590597;5605.551555875439;5615.8876822464135;5621.5221706155435;5627.127795191752;5354.651947623392;5481.643693159932;5522.447755224445;5532.585056120726;5536.612437129363;5669.092945128925;5696.088625820014;5713.657180569013;5720.141978703228;5743.224664670216;5577.386487486292;5589.55283577321;5591.524720398812;5591.692456914909;5593.664380137205 20:22:50 INFO - PROCESS | 26121 | |1;ext.html;586.5835256967553;609.2049874913238;621.97512099516;636.9935501906986;641.0448431836559;33098.66901330986;41825.58174418255;42257.78871105644;42524.36213456801;46391.76804115975;44983.550164498345;45069.323960140624;45081.77459112708;45514.31728524075;45574;8865.86701199481;9042;9061.22979546736;9078.636854525812;9080.8637870432;8933.240674542672;9066.77333066672;9068.727938161866;9069.138431848964;9071.863922041175;9086.22767064797;9087;9113.407628504126;9127.452352858849;9129.68046118386;9051.502167380791;9089.863652045224;9092.136247056518;9100.499472529009;9101.908980910206;8960.55197240142;9021.142991415805;9044.09559044097;9049.3665443419;9053.68312109073;43188.35217471709;43697.563024369665;43725.562744372466;43748.3437748434;43781.78109109466;3650.543682039745;3730.794806285653;3752.043228976621;3859.4210868369687;4234.237837189305;32536.511952320736;32828;33263.002109936744;33275;33679.15802104942;4427.5572442755465;4427.933580996288;4452.332150177467;4465.553444655541;4472.105578884204;349999;350100;353543;353659;353764.99999999744;54592;54812.725936370065;54895.72552137214;54931.45068549343;54968.72515637396;57804.976825810896;61684.38315616876;62969;62996;63072.68463657744;17302;17477.300907963538;17511.562210944827;17525.211365488583;17527.91236043837;12066.638000859988;12071.094667899766;12073.33596652175;12079.516819327304;12090.153689241668;16547.917260413622;16954.745678814827;18155.45533633993;18595.535111622048;19147.32984345569;6902.413294869993;6956.130483689539;6966.3730264276455;7074.893876591856;7226;970.1656575345197;1019.7756493571402;1032.8140934631838;1077.3159044006954;1104.1608377633056;32127.79323341977;32129.35741285208;32155.839220803748;32582;33259.66740332566;1062.9627963021258;1071.8767341755797;1116.1349953785882;1129.1192869561755;1179.162794415957;17029.48911532656;17478.951262924264;17496;17497.300107995794;17504.387346442814;497872;502596;504783;507604;510529;58294.708526457944;59490.70254648785;59536.404635953084;59728;59866;1253.5111306590436;1331.7269959658247;1386.2929905748142;1388.430743395203;1392.3455975691409;30482.695173047985;33166;33226.833865830515;33233.33533329368;34171.82914085413;50713.492865070875;51329.48670513247;51449.48550514447;51471.74264128655;51513.484865150866;372554;379977;381189;381569;382282;36382.27235455223;37435;37481.250374992895;38757;42047.789761051;48970.755146224044;49171;49186.26220606765;49944;50067.74966125146;41408;42233.57766422296;42518;42561;42698.57301426946;41709;41833.79083104687;42272.365914510694;42279.57720422879;43159;40947;41211.1757764837;41675.16649667051;41690.37464437975;42351.78824105983;35308.64691353054;36262;36893.81553092218;37556;37956.430653540774;28134.577981330705;28623;28636.14091577256;28666.570001449578;29022.27444313909 20:22:50 INFO - PROCESS | 26121 | |2;jquery.html;385.6097884052141;386.48404380152505;392.8526802449082;394.7631421147311;411.91555731075135;14423.278836058207;17512.82487175128;18556;20107.497312567175;20120;18143.818561814376;18556.17539439745;19149.234030638792;19186.520336991583;19284.614307713873;5659.801906933259;5673.8297851064535;5739.684317362543;5766.336871259817;5769.480746732793;3957.98021009896;5649.576281778863;5726.885462290752;5754.856128596777;6033.27600687918;6341.809745707613;6364.745410183587;6445.1621289232335;6446.645434501101;6454.483641308708;6172.598781079238;6352.174217351738;6429.324920883287;6438.227412710457;6440.484761219114;5676.858078548028;5681.8068205676445;5688.4311568843195;5689.231953686241;5690.3456102548325;21116.894415527822;22084.88957555218;22136.778632213794;23308;23689.17087901915;2276.943076423086;2288.8512246704076;2327.3483424641126;2339.5671800716923;2434.926952191437;9817.90182098177;10265.127464165555;10274.229432792496;10693.518791654395;10751.623693170779;1953.687410014391;2012.315812623715;2049.6822992436196;2066.059942726056;2083.812456878873;76377.61811190909;81320;83176;84353.57823210907;86215.56892215561;10724.302920310154;10816.567337306577;10887.83668244977;11013.724656883482;11071.228603423413;13306.46774129024;14347.56957291283;15339.463118790789;15363.385464581515;15364.923175384052;7887.881681774778;7924.960375198087;7972;8023.277904988579;8217.34261259098;7769.145394006655;7788.454808163374;7808.843823123506;7827.334676552557;7961.920380796234;4665.6734028617675;4709.858704238878;4713.78787954536;4799.088173247072;4823.541763532458;1964.361582485698;1965.9213631454581;1995.5410255641284;1997.670384386589;2051.4256008317693;881.4094556647062;922.4649703172144;929.6235024814961;950.9239260859115;981.9705408837747;18246.543836404195;18307.35924242645;18973;19211.231550737815;19468.902655486632;983.8475036369374;1003.2375394700081;1028.3932479836783;1030.2891005206384;1077.66053693088;10347.586096556053;10538.683839484827;10730.463476826128;10812;10861.511231994422;448120;458880;460366;460524;461613;83152;86900;87343;89413.55293223492;89594.55202723945;936.8969413364524;951.129716309569;965.82615129276;966.0966995858895;996.6661168508485;16737.414190503274;16775.832241677916;17013.74479382835;17223.65552688964;17620.91189544044;30220.84889575538;32074.6792532081;38570.228595427376;41255.58744412517;42956;57927.131093034484;58451.70774146102;58905.41094588999;59219.703901480214;59269.11096333645;5939.584229103922;7591.316781489692;7962.283394494523;7971.12317645047;8113.391495637733;11070.290236418894;13264.734705306033;13426.932865336;13566.118202316818;13818.516351927634;11636.709082273012;11991.700207494883;12098.092643051983;12121.515139394325;12154.331511766584;11057.723556911142;11140.108791296514;11795.587154449553;11820.940895295469;11936.761264774483;11709.414529273672;11984.64046078619;12018;12219.26684398939;12320.303908827495;8820.426672266281;9026.548672566476;9056.456612603264;9211.447313161232;9263.953680231825;11581;11875.643730688093;12125.090618203847;12159.756804863677;12221.938890305491 20:22:50 INFO - PROCESS | 26121 | |3;mootools.html;1324.7416753733025;1462.2469428244456;1507.6984603079386;1633.3303345628294;1781.4566557200048;8315.293200077993;8727.91272087279;8750.124987501247;8926.062763409846;8954.37319387643;8966.730998070052;9129;9150.679726209584;9156.359054866161;9165.037671044527;2044.5808609235146;2308.7691230876944;2369.1589485732575;2385.5109702510945;2401.1235898896866;2389.9880500597474;2401.6037353836596;2406.133791834938;2406.7713567211085;2407.723111842143;2305.538892221554;2335.486193037529;2338.543983923136;2340.8595484271;2362.9881850590723;1994.1923520974028;2217.3347995601416;2299.2642354446584;2317.7682231776857;2321.1643808229023;2302.033146078651;2302.1827251325703;2315.455867871049;2322.11759531377;2322.825788065885;9051.321150913707;9162;9202;9204.539773011322;9211.355205135644;5393.6763794172475;5537.501624853742;5544.944550554484;5548.472895074961;5550.167474878801;3443.8794642187404;3603.621619729917;3646.5441819772527;3672.779633222015;3690.870819521304;1162.7674465107013;1183.1363104933446;1193.1767080714367;1241.118805647991;1243.2167734327406;12625.368731563385;12713.42789574462;12748.553800616934;12801.231926084465;12811.935940320333;4622.260438329851;4654.743989080633;4721.8347357842995;4766.094442056067;4794.976025119852;9939.80120397588;9969.950150249202;9971.202303815677;9975.351602145982;9981.550830212658;5384.461553844584;5388.595855310868;5390.51485366319;5393.298871146726;5395.271638328775;4129.91740165195;4914.827981020647;5030.993801239693;5038.445770965191;5112.130937740593;3854.5181852268465;3919.490466239428;3968.940465893014;3971.860984865516;4035.6973227008093;1174.4069245031376;1177.128924595793;1185.3184418959133;1185.6561597136733;1200.429795846983;832.4713806732768;903.6295119001178;973.9074787895139;976.5751897924425;1007.2848277722899;6039.577229593974;6280.937190628127;6332.651704156316;6379.776707815297;6521.217453905561;452.46834968911395;459.7011942237506;461.71373748276284;469.03847113417356;476.04552871493127;4250.723702959298;4405.251107311765;4423.51341352451;4438.933415998763;4445.133199026159;10838.295510791773;11273.887261127447;11301;11334.319940803578;11345;11160.553577856957;11199.66401007971;11202;11204.15968802343;11207.327560346243;7962.442629016029;8307.08622051574;8310.584470776437;8462.957685211535;8464.999999999876;6169.876602467836;6462.967685161544;6512.251091124582;6556.082148499309;6590.604563726191;10492.108170805566;10596.629117980834;10615.946920265349;10630.468476576294;10731.087857532197;10581.788364232827;10640.787184256425;10894.564217431214;11001.284916480403;11047.447627618747;7141.85716285661;7657;7659.961700191463;8192;8340.457870238415;8969.10308969124;9041.638334466548;9054.502002389932;9093.136152065543;9112.271018318386;7911.367090632851;8138.552379618941;8176.67293308261;8217.712380066669;8264.338852891875;7669.424793140648;7899.289063984269;7902;7989.680412783656;8196.877046844183;7357.668904899399;7422.127922381831;7455.739049133254;7512.248775122444;7529.962350188214;5200.921986170135;5255.500727430888;5405.378381486179;5407.134858422633;5452.7546260417585;5228.738563071907;5284.920726189033;5376.7580458878665;5480.068388374066;5551.8889622208135 20:22:50 INFO - PROCESS | 26121 | |4;prototype.html;334.93971085204663;335.0735217124651;340.181862620398;341.41106591130296;342.7908975524931;5267.183586544087;5312.893742125155;5313.415524292334;5319.813806516772;5326.254324394578;5222.294990176325;5225.764840582174;5257.395399529055;5263;5272.630915835893;3972.602739726033;4027.939580906289;4154.086101057763;4154.792260386984;4205.726627769201;4134.235166494193;4154.792260386968;4163.354680024586;4166.520850102232;4184.4141820145205;3907.7655340679507;4095.6313931746135;4100.2209580179815;4124.566920473352;4127.112670775783;4033.757974521538;4064.1871625674985;4077.4903137107863;4080.6327430531246;4103.989045367778;3588.6770190682964;3604.5133906922492;3616.963830361689;3618.855245790165;3635.4001589737663;5097.23541468779;5107.923381149286;5123.564497017758;5128.589712822965;5129.435762066207;4525.366448697185;4728.172569800271;4728.290756386536;4737.218358970766;4748.240281554935;5413.188021796723;5483.862903427406;5484.232207490954;5485.286912701324;5497.202905578709;4035.9798201008807;4036.1524079943247;4039.3133167361325;4039.7172197946156;4052.4326594276827;5541.168824676331;5579.609427340088;5644.3508996465525;5704.458076482728;5715.199872017921;4080.6123418275215;4084.4281800547947;4105.117399759066;4115.8971025724595;4134.152498737752;4135.77253251068;4136.503619565611;4138.544760076389;4146;4148.958510414917;4511.751853648016;4652.208674795096;4703.95296047042;4794.688345257617;4814.374131362901;5567.19066303453;5568.44315568448;5584.6090773646265;5592.384837667853;5617.494425501643;1433.4481224728554;1459.6350912271932;1463.5170393770031;1463.5463006468028;1469.4563011685532;950.8716323296405;958.4201558057414;985.8915519292872;1000.314784372707;1004.5985849739573;5306;5306.151015837448;5326.7869285228935;5345.3852806926925;5345.545628621533;5537.031019571559;5543.944560554423;5576.414476479992;5641.576881733887;5659.915101273484;4993.300937868701;5246.478521228877;5265.315508983807;5298.7350632469;5301.587777561201;2951.5867778511024;2966.6143401357685;2968.614080169564;2978.9275860690136;2995.6405231372373;5547.2511210986;5700.800471983461;5733.967885780599;5749.3963133871175;5783.739731712083;5761.193432919395;5762.913556296575;5777.768889244468;5783.71081445926;5783.884322313615;5785.392533783976;5833.308340581354;5847.26909136358;5860.619059761102;5897.756234071244;5506.329430226417;5662.915056274077;5716.256886604715;5762.510186634016;5771.278590176228;5692.430756924275;5715.31416230055;5718.428157184248;5719.370869204301;5723.542116630576;5569.944300556943;5883.294004719461;5901.380355062656;5909.6158749681135;5918.23063001807;4020.8086592807576;4047.9190416190922;4056.3307054335705;4062.1266427718183;4067.4508941292547;5653.604247702621;5670.546356291405;5672.319321681424;5685.374608793112;5707.914381284201;5395.541378982831;5539.310510294399;5570.5543556516195;5585.69278689676;5598.32820061579;5558.49920521465;5561.499465048165;5562.303497433321;5567.218490083134;5575.526080283222;5228.424873264014;5319.38827034896;5443.156310771837;5482.0406428875585;5490.835274941758;5532.1701744737;5563;5578.665280083208;5582.720863956704;5601.327840659147;5474.808381706621;5490.6980116094;5490.945090549043;5498.45015498463;5524.309461317335 20:22:50 INFO - PROCESS | 26121 | |5;yui.html;747.0661672908864;777.1761932351708;792.7542461836829;811.209439528024;853.0871966995315;13805.861941380583;14967.850321496782;14977.176255305967;14991.400343986228;15041.849581504182;14938.850611493881;15585.532434026969;15649.45226917058;16157.757633635476;16191.109488978102;656.4125108028312;811.5942028985522;815.0993152566388;817.5707753429438;818.9918100818975;778.2489897249153;804.1877703519458;808.7412028150994;808.8827120067587;809.7368355284526;855.9229669329759;856.2507805670039;858.4891989266376;858.8282343531288;859.7334826203866;691.0394551573318;815.2377527012262;858.3219256787131;858.8539948208819;859.4757198109118;613.4356392119261;614.5022531749297;615.7752420366579;615.8645098078416;616.9969150154266;13847.723045539033;13952.511662091778;13981.860181398259;14035.578932632037;14053.859461405358;13487;13837.584872453743;13968.580942571638;14333.42666293347;14542.636434089232;13622.795658065137;13798.310084495735;13840.723185536233;13996.370163342674;14233.644158896006;4557.361969324297;4582.702124361939;4589.311603259504;4654.883627909296;4758.452777930548;85741.57129214314;86216;88166;90113.54943225307;90581.09418905793;11263.254195599531;11273.887261127447;11339.036181924464;11552.249103808394;11585.246958947642;21758.891205544187;21813.67279490809;21829.781702183092;21853.235136770138;21886.671699924515;8359;8400.201980811813;8496.405251632326;8630.39587228888;8852.778680533038;4807.735574543433;4826.203676393356;4892.706437613754;4949.133901567211;5096.770645320969;3617.638236176414;3888.105735680753;4039.3537034074407;4044.7775372354213;4101;684.3430306905327;697.1251079894801;697.6058526932267;698.228457554395;703.8345988692755;612.301975747648;671.6071098407486;697.1634039153037;740.1414359343136;748.221849276757;8886.822263554823;9364.531773411301;9484.715458536255;9494.810103798023;9549.9045009549;655.88194125057;679.2392520377209;691.989620155698;709.5423451873513;722.259683824074;4811.27830825372;5015.297858299841;5024.296598476216;5057.494250574987;5074.822381216713;108733;111121.44439277751;112961.43519282516;113593;114031;101968.49015755022;102190.48904755578;102835;103473;104379;89387;90015;91289.99999999868;91947.54026229827;92498.53750731204;8898.110188981309;8910.108989101298;9062.818743625223;9073.274138068806;9227.44635321856;50937;52181;53266.73366633142;53812;54170;74301;78705;79340.60329698314;79806.6009669948;84379;11803.350815705218;12248.632541023784;12325.568605098779;12345.135840491439;12548.18436801605;13258.522840020576;13496.003030121678;13860.861391386361;14118.78821817653;14339.641508962359;11256.718582035515;11618.535258589562;11951.223170494239;12026.158168928441;13282.070255082437;13805.79291310611;13984.930075349557;14056.718865622835;14075.296235187994;14423.711525769635;13823.101498402571;14203;14203.64490887736;14237.857621423653;15232.23838808033;9727.951360243154;9759.12167904892;9962.601495940371;10499.527521261714;10666.57333706674;10634.840477393;10985.340879547253;11008.39453830047;11834.408279585814;12293.262404255773 20:22:50 INFO - PROCESS | 26121 | __end_tp_report 20:22:50 INFO - PROCESS | 26121 | __start_cc_report 20:22:50 INFO - PROCESS | 26121 | _x_x_mozilla_cycle_collect,858 20:22:50 INFO - PROCESS | 26121 | __end_cc_report 20:22:50 INFO - PROCESS | 26121 | __startTimestamp1466911370231__endTimestamp 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | ------- Summary: start ------- 20:22:50 INFO - PROCESS | 26121 | Number of tests: 6 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#0] dojo.html Cycles:165 Average:5343.46 Median:5576.86 stddev:625.86 (11.2%) stddev-sans-first:601.28 20:22:50 INFO - PROCESS | 26121 | Values: 3046.5 3055.6 3061.0 3062.3 3108.4 5272.3 5276.7 5334.3 5411.5 5435.3 5372.3 5388.5 5412.5 5454.8 5509.0 4843.6 4904.7 4923.6 4925.9 5027.3 4914.3 4925.4 4953.3 4975.5 4984.0 4779.3 4815.6 4835.4 4845.9 4892.7 4832.8 4839.6 4853.6 4866.7 4902.4 4739.5 4812.7 4838.2 4838.9 4881.3 5299.4 5363.5 5375.4 5419.7 5428.8 5733.7 5801.6 5810.9 5811.7 5812.4 5600.8 5793.8 5853.9 5863.2 5868.0 5448.6 5464.1 5464.6 5468.6 5471.8 5947.9 5954.9 5955.9 5959.2 5959.8 5516.5 5611.0 5657.2 5714.5 5720.9 5771.9 5776.2 5815.4 5824.2 5827.8 5693.9 5748.0 5751.9 5757.4 5763.3 5517.0 5613.9 5647.4 5651.1 5752.1 4315.9 4320.3 4325.7 4332.7 4361.4 3848.4 3873.9 3884.1 3894.9 3897.0 5293.6 5302.7 5397.0 5402.7 5440.8 5788.2 5793.7 5813.9 5814.3 5852.7 5318.8 5460.3 5460.5 5464.4 5475.0 4888.9 4905.8 4929.3 4974.0 4979.2 5960.4 5970.4 5970.9 5971.8 5974.6 5576.9 5697.6 5803.3 5813.2 5817.4 5908.1 5964.9 5972.9 5976.1 6029.8 5652.8 5691.8 5698.3 5700.8 5704.0 5600.9 5696.0 5704.2 5782.5 5808.7 5624.5 5635.6 5637.6 5645.7 5690.9 5578.0 5605.6 5615.9 5621.5 5627.1 5354.7 5481.6 5522.4 5532.6 5536.6 5669.1 5696.1 5713.7 5720.1 5743.2 5577.4 5589.6 5591.5 5591.7 5593.7 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#1] ext.html Cycles:180 Average:58364.23 Median:23256.91 stddev:110236.18 (474.0%) stddev-sans-first:110460.07 20:22:50 INFO - PROCESS | 26121 | Values: 586.6 609.2 622.0 637.0 641.0 33098.7 41825.6 42257.8 42524.4 46391.8 44983.6 45069.3 45081.8 45514.3 45574.0 8865.9 9042.0 9061.2 9078.6 9080.9 8933.2 9066.8 9068.7 9069.1 9071.9 9086.2 9087.0 9113.4 9127.5 9129.7 9051.5 9089.9 9092.1 9100.5 9101.9 8960.6 9021.1 9044.1 9049.4 9053.7 43188.4 43697.6 43725.6 43748.3 43781.8 3650.5 3730.8 3752.0 3859.4 4234.2 32536.5 32828.0 33263.0 33275.0 33679.2 4427.6 4427.9 4452.3 4465.6 4472.1 349999.0 350100.0 353543.0 353659.0 353765.0 54592.0 54812.7 54895.7 54931.5 54968.7 57805.0 61684.4 62969.0 62996.0 63072.7 17302.0 17477.3 17511.6 17525.2 17527.9 12066.6 12071.1 12073.3 12079.5 12090.2 16547.9 16954.7 18155.5 18595.5 19147.3 6902.4 6956.1 6966.4 7074.9 7226.0 970.2 1019.8 1032.8 1077.3 1104.2 32127.8 32129.4 32155.8 32582.0 33259.7 1063.0 1071.9 1116.1 1129.1 1179.2 17029.5 17479.0 17496.0 17497.3 17504.4 497872.0 502596.0 504783.0 507604.0 510529.0 58294.7 59490.7 59536.4 59728.0 59866.0 1253.5 1331.7 1386.3 1388.4 1392.3 30482.7 33166.0 33226.8 33233.3 34171.8 50713.5 51329.5 51449.5 51471.7 51513.5 372554.0 379977.0 381189.0 381569.0 382282.0 36382.3 37435.0 37481.3 38757.0 42047.8 48970.8 49171.0 49186.3 49944.0 50067.7 41408.0 42233.6 42518.0 42561.0 42698.6 41709.0 41833.8 42272.4 42279.6 43159.0 40947.0 41211.2 41675.2 41690.4 42351.8 35308.6 36262.0 36893.8 37556.0 37956.4 28134.6 28623.0 28636.1 28666.6 29022.3 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#2] jquery.html Cycles:180 Average:27843.76 Median:19477.92 stddev:75609.24 (388.2%) stddev-sans-first:75793.24 20:22:50 INFO - PROCESS | 26121 | Values: 385.6 386.5 392.9 394.8 411.9 14423.3 17512.8 18556.0 20107.5 20120.0 18143.8 18556.2 19149.2 19186.5 19284.6 5659.8 5673.8 5739.7 5766.3 5769.5 3958.0 5649.6 5726.9 5754.9 6033.3 6341.8 6364.7 6445.2 6446.6 6454.5 6172.6 6352.2 6429.3 6438.2 6440.5 5676.9 5681.8 5688.4 5689.2 5690.3 21116.9 22084.9 22136.8 23308.0 23689.2 2276.9 2288.9 2327.3 2339.6 2434.9 9817.9 10265.1 10274.2 10693.5 10751.6 1953.7 2012.3 2049.7 2066.1 2083.8 76377.6 81320.0 83176.0 84353.6 86215.6 10724.3 10816.6 10887.8 11013.7 11071.2 13306.5 14347.6 15339.5 15363.4 15364.9 7887.9 7925.0 7972.0 8023.3 8217.3 7769.1 7788.5 7808.8 7827.3 7961.9 4665.7 4709.9 4713.8 4799.1 4823.5 1964.4 1965.9 1995.5 1997.7 2051.4 881.4 922.5 929.6 950.9 982.0 18246.5 18307.4 18973.0 19211.2 19468.9 983.8 1003.2 1028.4 1030.3 1077.7 10347.6 10538.7 10730.5 10812.0 10861.5 448120.0 458880.0 460366.0 460524.0 461613.0 83152.0 86900.0 87343.0 89413.6 89594.6 936.9 951.1 965.8 966.1 996.7 16737.4 16775.8 17013.7 17223.7 17620.9 30220.8 32074.7 38570.2 41255.6 42956.0 57927.1 58451.7 58905.4 59219.7 59269.1 5939.6 7591.3 7962.3 7971.1 8113.4 11070.3 13264.7 13426.9 13566.1 13818.5 11636.7 11991.7 12098.1 12121.5 12154.3 11057.7 11140.1 11795.6 11820.9 11936.8 11709.4 11984.6 12018.0 12219.3 12320.3 8820.4 9026.5 9056.5 9211.4 9264.0 11581.0 11875.6 12125.1 12159.8 12221.9 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#3] mootools.html Cycles:180 Average:5974.92 Median:4780.54 stddev:3439.74 (72.0%) stddev-sans-first:3431.63 20:22:50 INFO - PROCESS | 26121 | Values: 1324.7 1462.2 1507.7 1633.3 1781.5 8315.3 8727.9 8750.1 8926.1 8954.4 8966.7 9129.0 9150.7 9156.4 9165.0 2044.6 2308.8 2369.2 2385.5 2401.1 2390.0 2401.6 2406.1 2406.8 2407.7 2305.5 2335.5 2338.5 2340.9 2363.0 1994.2 2217.3 2299.3 2317.8 2321.2 2302.0 2302.2 2315.5 2322.1 2322.8 9051.3 9162.0 9202.0 9204.5 9211.4 5393.7 5537.5 5544.9 5548.5 5550.2 3443.9 3603.6 3646.5 3672.8 3690.9 1162.8 1183.1 1193.2 1241.1 1243.2 12625.4 12713.4 12748.6 12801.2 12811.9 4622.3 4654.7 4721.8 4766.1 4795.0 9939.8 9970.0 9971.2 9975.4 9981.6 5384.5 5388.6 5390.5 5393.3 5395.3 4129.9 4914.8 5031.0 5038.4 5112.1 3854.5 3919.5 3968.9 3971.9 4035.7 1174.4 1177.1 1185.3 1185.7 1200.4 832.5 903.6 973.9 976.6 1007.3 6039.6 6280.9 6332.7 6379.8 6521.2 452.5 459.7 461.7 469.0 476.0 4250.7 4405.3 4423.5 4438.9 4445.1 10838.3 11273.9 11301.0 11334.3 11345.0 11160.6 11199.7 11202.0 11204.2 11207.3 7962.4 8307.1 8310.6 8463.0 8465.0 6169.9 6463.0 6512.3 6556.1 6590.6 10492.1 10596.6 10615.9 10630.5 10731.1 10581.8 10640.8 10894.6 11001.3 11047.4 7141.9 7657.0 7660.0 8192.0 8340.5 8969.1 9041.6 9054.5 9093.1 9112.3 7911.4 8138.6 8176.7 8217.7 8264.3 7669.4 7899.3 7902.0 7989.7 8196.9 7357.7 7422.1 7455.7 7512.2 7530.0 5200.9 5255.5 5405.4 5407.1 5452.8 5228.7 5284.9 5376.8 5480.1 5551.9 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#4] prototype.html Cycles:180 Average:4661.10 Median:5309.52 stddev:1359.37 (25.6%) stddev-sans-first:1323.83 20:22:50 INFO - PROCESS | 26121 | Values: 334.9 335.1 340.2 341.4 342.8 5267.2 5312.9 5313.4 5319.8 5326.3 5222.3 5225.8 5257.4 5263.0 5272.6 3972.6 4027.9 4154.1 4154.8 4205.7 4134.2 4154.8 4163.4 4166.5 4184.4 3907.8 4095.6 4100.2 4124.6 4127.1 4033.8 4064.2 4077.5 4080.6 4104.0 3588.7 3604.5 3617.0 3618.9 3635.4 5097.2 5107.9 5123.6 5128.6 5129.4 4525.4 4728.2 4728.3 4737.2 4748.2 5413.2 5483.9 5484.2 5485.3 5497.2 4036.0 4036.2 4039.3 4039.7 4052.4 5541.2 5579.6 5644.4 5704.5 5715.2 4080.6 4084.4 4105.1 4115.9 4134.2 4135.8 4136.5 4138.5 4146.0 4149.0 4511.8 4652.2 4704.0 4794.7 4814.4 5567.2 5568.4 5584.6 5592.4 5617.5 1433.4 1459.6 1463.5 1463.5 1469.5 950.9 958.4 985.9 1000.3 1004.6 5306.0 5306.2 5326.8 5345.4 5345.5 5537.0 5543.9 5576.4 5641.6 5659.9 4993.3 5246.5 5265.3 5298.7 5301.6 2951.6 2966.6 2968.6 2978.9 2995.6 5547.3 5700.8 5734.0 5749.4 5783.7 5761.2 5762.9 5777.8 5783.7 5783.9 5785.4 5833.3 5847.3 5860.6 5897.8 5506.3 5662.9 5716.3 5762.5 5771.3 5692.4 5715.3 5718.4 5719.4 5723.5 5569.9 5883.3 5901.4 5909.6 5918.2 4020.8 4047.9 4056.3 4062.1 4067.5 5653.6 5670.5 5672.3 5685.4 5707.9 5395.5 5539.3 5570.6 5585.7 5598.3 5558.5 5561.5 5562.3 5567.2 5575.5 5228.4 5319.4 5443.2 5482.0 5490.8 5532.2 5563.0 5578.7 5582.7 5601.3 5474.8 5490.7 5490.9 5498.5 5524.3 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - PROCESS | 26121 | [#5] yui.html Cycles:180 Average:21449.35 Median:4920.92 stddev:31214.54 (634.3%) stddev-sans-first:31263.40 20:22:50 INFO - PROCESS | 26121 | Values: 747.1 777.2 792.8 811.2 853.1 13805.9 14967.9 14977.2 14991.4 15041.8 14938.9 15585.5 15649.5 16157.8 16191.1 656.4 811.6 815.1 817.6 819.0 778.2 804.2 808.7 808.9 809.7 855.9 856.3 858.5 858.8 859.7 691.0 815.2 858.3 858.9 859.5 613.4 614.5 615.8 615.9 617.0 13847.7 13952.5 13981.9 14035.6 14053.9 13487.0 13837.6 13968.6 14333.4 14542.6 13622.8 13798.3 13840.7 13996.4 14233.6 4557.4 4582.7 4589.3 4654.9 4758.5 85741.6 86216.0 88166.0 90113.5 90581.1 11263.3 11273.9 11339.0 11552.2 11585.2 21758.9 21813.7 21829.8 21853.2 21886.7 8359.0 8400.2 8496.4 8630.4 8852.8 4807.7 4826.2 4892.7 4949.1 5096.8 3617.6 3888.1 4039.4 4044.8 4101.0 684.3 697.1 697.6 698.2 703.8 612.3 671.6 697.2 740.1 748.2 8886.8 9364.5 9484.7 9494.8 9549.9 655.9 679.2 692.0 709.5 722.3 4811.3 5015.3 5024.3 5057.5 5074.8 108733.0 111121.4 112961.4 113593.0 114031.0 101968.5 102190.5 102835.0 103473.0 104379.0 89387.0 90015.0 91290.0 91947.5 92498.5 8898.1 8910.1 9062.8 9073.3 9227.4 50937.0 52181.0 53266.7 53812.0 54170.0 74301.0 78705.0 79340.6 79806.6 84379.0 11803.4 12248.6 12325.6 12345.1 12548.2 13258.5 13496.0 13860.9 14118.8 14339.6 11256.7 11618.5 11951.2 12026.2 13282.1 13805.8 13984.9 14056.7 14075.3 14423.7 13823.1 14203.0 14203.6 14237.9 15232.2 9728.0 9759.1 9962.6 10499.5 10666.6 10634.8 10985.3 11008.4 11834.4 12293.3 20:22:50 INFO - PROCESS | 26121 | -------- Summary: end -------- 20:22:50 INFO - PROCESS | 26121 | 20:22:50 INFO - TEST-INFO | 26121: exit 0 20:22:50 INFO - TEST-OK | dromaeo_css | took 1112847ms 20:22:50 INFO - TEST-START | kraken 20:22:50 INFO - operating with platform_type : linux_ 20:22:50 INFO - Initialising browser for kraken test... 20:22:51 INFO - TEST-INFO | started process 26304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkZ1jg/profile http://localhost:49540/getInfo.html) 20:22:54 INFO - PROCESS | 26304 | __metrics Screen width/height:1600/1200 20:22:54 INFO - PROCESS | 26304 | colorDepth:24 20:22:54 INFO - PROCESS | 26304 | Browser inner width/height: 1024/697 20:22:54 INFO - PROCESS | 26304 | __metrics 20:22:55 INFO - PROCESS | 26304 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:56 INFO - TEST-INFO | 26304: exit 0 20:22:56 INFO - Browser initialized. 20:22:56 INFO - Running cycle 1/1 for kraken test... 20:22:56 INFO - TEST-INFO | started process 26385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZkZ1jg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:08 INFO - PROCESS | 26385 | RSS: Main: 173608960 20:23:08 INFO - PROCESS | 26385 | 20:23:10 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:11 INFO - PROCESS | 26385 | RSS: Main: 232341504 20:23:11 INFO - PROCESS | 26385 | 20:23:14 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-dft) 20:23:14 INFO - PROCESS | 26385 | RSS: Main: 219549696 20:23:14 INFO - PROCESS | 26385 | 20:23:18 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-fft) 20:23:18 INFO - PROCESS | 26385 | RSS: Main: 285896704 20:23:18 INFO - PROCESS | 26385 | 20:23:20 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49540/tests/kraken/driver.html?testName=audio-oscillator) 20:23:21 INFO - PROCESS | 26385 | RSS: Main: 196317184 20:23:21 INFO - PROCESS | 26385 | 20:23:23 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:24 INFO - PROCESS | 26385 | RSS: Main: 201412608 20:23:24 INFO - PROCESS | 26385 | 20:23:27 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:27 INFO - PROCESS | 26385 | RSS: Main: 237199360 20:23:27 INFO - PROCESS | 26385 | 20:23:31 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49540/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:31 INFO - PROCESS | 26385 | RSS: Main: 238034944 20:23:31 INFO - PROCESS | 26385 | 20:23:34 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49540/tests/kraken/driver.html?testName=json-parse-financial) 20:23:35 INFO - PROCESS | 26385 | RSS: Main: 237350912 20:23:35 INFO - PROCESS | 26385 | 20:23:36 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:37 INFO - PROCESS | 26385 | RSS: Main: 224268288 20:23:37 INFO - PROCESS | 26385 | 20:23:39 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:39 INFO - PROCESS | 26385 | RSS: Main: 228659200 20:23:39 INFO - PROCESS | 26385 | 20:23:41 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:42 INFO - PROCESS | 26385 | RSS: Main: 236150784 20:23:42 INFO - PROCESS | 26385 | 20:23:45 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:45 INFO - PROCESS | 26385 | RSS: Main: 239779840 20:23:45 INFO - PROCESS | 26385 | 20:23:48 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:49 INFO - PROCESS | 26385 | RSS: Main: 238739456 20:23:49 INFO - PROCESS | 26385 | 20:23:50 INFO - PROCESS | 26385 | Cycle 1(1): loaded http://localhost:49540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49540/tests/kraken/driver.html?testName=ai-astar) 20:23:51 INFO - PROCESS | 26385 | RSS: Main: 281939968 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | __start_tp_report 20:23:51 INFO - PROCESS | 26385 | _x_x_mozilla_page_load 20:23:51 INFO - PROCESS | 26385 | _x_x_mozilla_page_load_details 20:23:51 INFO - PROCESS | 26385 | |i|pagename|runs| 20:23:51 INFO - PROCESS | 26385 | |0;ai-astar;100;109;108;110;112;110;109;110;109;109 20:23:51 INFO - PROCESS | 26385 | |1;audio-beat-detection;148;123;130;199;136;124;152;124;158;124 20:23:51 INFO - PROCESS | 26385 | |2;audio-dft;162;161;161;162;163;161;164;162;160;162 20:23:51 INFO - PROCESS | 26385 | |3;audio-fft;73;75;76;120;76;75;76;76;105;74 20:23:51 INFO - PROCESS | 26385 | |4;audio-oscillator;85;84;118;85;84;86;121;86;85;125 20:23:51 INFO - PROCESS | 26385 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;118;117;118 20:23:51 INFO - PROCESS | 26385 | |6;imaging-darkroom;146;146;145;145;145;145;146;145;145;145 20:23:51 INFO - PROCESS | 26385 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 20:23:51 INFO - PROCESS | 26385 | |8;json-parse-financial;57;56;58;56;55;57;58;57;55;57 20:23:51 INFO - PROCESS | 26385 | |9;json-stringify-tinderbox;61;61;62;62;61;61;62;62;62;62 20:23:51 INFO - PROCESS | 26385 | |10;stanford-crypto-aes;84;85;78;79;80;80;83;81;112;82 20:23:51 INFO - PROCESS | 26385 | |11;stanford-crypto-ccm;129;125;129;118;119;120;127;120;133;133 20:23:51 INFO - PROCESS | 26385 | |12;stanford-crypto-pbkdf2;177;162;165;159;166;156;160;160;157;162 20:23:51 INFO - PROCESS | 26385 | |13;stanford-crypto-sha256-iterative;64;66;65;62;64;64;62;64;63;62 20:23:51 INFO - PROCESS | 26385 | __end_tp_report 20:23:51 INFO - PROCESS | 26385 | __start_cc_report 20:23:51 INFO - PROCESS | 26385 | _x_x_mozilla_cycle_collect,1629 20:23:51 INFO - PROCESS | 26385 | __end_cc_report 20:23:51 INFO - PROCESS | 26385 | __startTimestamp1466911431027__endTimestamp 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | ------- Summary: start ------- 20:23:51 INFO - PROCESS | 26385 | Number of tests: 14 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.50 stddev:3.20 (2.9%) stddev-sans-first:1.13 20:23:51 INFO - PROCESS | 26385 | Values: 100.0 109.0 108.0 110.0 112.0 110.0 109.0 110.0 109.0 109.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:142.00 stddev:23.93 (16.9%) stddev-sans-first:25.28 20:23:51 INFO - PROCESS | 26385 | Values: 148.0 123.0 130.0 199.0 136.0 124.0 152.0 124.0 158.0 124.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 20:23:51 INFO - PROCESS | 26385 | Values: 162.0 161.0 161.0 162.0 163.0 161.0 164.0 162.0 160.0 162.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:16.18 (21.4%) stddev-sans-first:16.79 20:23:51 INFO - PROCESS | 26385 | Values: 73.0 75.0 76.0 120.0 76.0 75.0 76.0 76.0 105.0 74.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.64 (20.8%) stddev-sans-first:18.27 20:23:51 INFO - PROCESS | 26385 | Values: 85.0 84.0 118.0 85.0 84.0 86.0 121.0 86.0 85.0 125.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:23:51 INFO - PROCESS | 26385 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 118.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:23:51 INFO - PROCESS | 26385 | Values: 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:23:51 INFO - PROCESS | 26385 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 20:23:51 INFO - PROCESS | 26385 | Values: 57.0 56.0 58.0 56.0 55.0 57.0 58.0 57.0 55.0 57.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:23:51 INFO - PROCESS | 26385 | Values: 61.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 62.0 62.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.50 stddev:9.95 (12.2%) stddev-sans-first:10.55 20:23:51 INFO - PROCESS | 26385 | Values: 84.0 85.0 78.0 79.0 80.0 80.0 83.0 81.0 112.0 82.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:128.00 stddev:5.76 (4.5%) stddev-sans-first:5.95 20:23:51 INFO - PROCESS | 26385 | Values: 129.0 125.0 129.0 118.0 119.0 120.0 127.0 120.0 133.0 133.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.00 stddev:6.02 (3.7%) stddev-sans-first:3.35 20:23:51 INFO - PROCESS | 26385 | Values: 177.0 162.0 165.0 159.0 166.0 156.0 160.0 160.0 157.0 162.0 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - PROCESS | 26385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 20:23:51 INFO - PROCESS | 26385 | Values: 64.0 66.0 65.0 62.0 64.0 64.0 62.0 64.0 63.0 62.0 20:23:51 INFO - PROCESS | 26385 | -------- Summary: end -------- 20:23:51 INFO - PROCESS | 26385 | 20:23:51 INFO - TEST-INFO | 26385: exit 0 20:23:52 INFO - TEST-OK | kraken | took 61010ms 20:23:52 INFO - SUITE-END | took 1173s 20:23:52 INFO - Completed test suite (00:19:34) 20:23:52 INFO - javascript benchmark 20:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.4668682980478, 3055.5569442430833, 3061.020473448497, 3062.2956719954395, 3108.4404807134706, 5272.314599102111, 5276.736163191839, 5334.253204551356, 5411.485908838659, 5435.320584926879, 5372.301600791891, 5388.488093631108, 5412.512873841353, 5454.809081682132, 5509.035918714219, 4843.564079232869, 4904.681195722275, 4923.55687988081, 4925.926111108336, 5027.296178535008, 4914.287428322891, 4925.408950925894, 4953.331300274471, 4975.477574854643, 4984.0, 4779.259214821708, 4815.614750819926, 4835.443923948738, 4845.927311090337, 4892.6575139740235, 4832.806687732486, 4839.612830973549, 4853.587445067174, 4866.732329721864, 4902.411710594716, 4739.549742774431, 4812.7352995585225, 4838.177509823338, 4838.879028024292, 4881.34101896243, 5299.4435584263865, 5363.490468405495, 5375.381831089436, 5419.729013549346, 5428.782848686048, 5733.741981610838, 5801.622894511843, 5810.854728631776, 5811.709414529257, 5812.389699081577, 5600.803971860965, 5793.768249270024, 5853.941460585383, 5863.208466857005, 5868.03177475716, 5448.56411487084, 5464.0711079116645, 5464.590155738336, 5468.6171967962255, 5471.781128754845, 5947.940520594825, 5954.85112872173, 5955.940440595538, 5959.225300710967, 5959.761609535657, 5516.503514683698, 5611.046122159243, 5657.20799088128, 5714.457126572969, 5720.914186287209, 5771.94228057714, 5776.220210271559, 5815.360310365856, 5824.155497452845, 5827.825165244964, 5693.9430605693415, 5748.0, 5751.942480575224, 5757.424257574293, 5763.337216220105, 5517.034518959166, 5613.859653508695, 5647.407022262685, 5651.124075768263, 5752.050911599539, 4315.935260971088, 4320.265554855682, 4325.653947684178, 4332.653387728974, 4361.3676016978, 3848.3842585186794, 3873.903152421212, 3884.1066554692015, 3894.883153505399, 3897.0452239201577, 5293.602979776532, 5302.681839089667, 5397.0, 5402.6758394496455, 5440.782368705208, 5788.160716696056, 5793.681347525842, 5813.941860581424, 5814.3313518945015, 5852.678102704393, 5318.760655770499, 5460.290162278879, 5460.5085542301385, 5464.426235245242, 5474.972625136849, 4888.877778055506, 4905.754712264373, 4929.285253638202, 4974.0, 4979.153543897546, 5960.433758792908, 5970.432808883149, 5970.880582388328, 5971.820845374646, 5974.61165024272, 5576.86057848557, 5697.601167918206, 5803.332616749128, 5813.186153938367, 5817.360090390139, 5908.054711246352, 5964.9105263420215, 5972.910406343995, 5976.073708575178, 6029.758809647565, 5652.802151924663, 5691.77232910679, 5698.344690360662, 5700.771969121189, 5703.971480142573, 5600.8879822402505, 5696.0316746154085, 5704.172894930295, 5782.45066718661, 5808.6805225711305, 5624.493795558419, 5635.577331700057, 5637.577181711306, 5645.689487078086, 5690.9430905690415, 5577.96807590597, 5605.551555875439, 5615.8876822464135, 5621.5221706155435, 5627.127795191752, 5354.651947623392, 5481.643693159932, 5522.447755224445, 5532.585056120726, 5536.612437129363, 5669.092945128925, 5696.088625820014, 5713.657180569013, 5720.141978703228, 5743.224664670216, 5577.386487486292, 5589.55283577321, 5591.524720398812, 5591.692456914909, 5593.664380137205], "value": 5299.651412305823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.5835256967553, 609.2049874913238, 621.97512099516, 636.9935501906986, 641.0448431836559, 33098.66901330986, 41825.58174418255, 42257.78871105644, 42524.36213456801, 46391.76804115975, 44983.550164498345, 45069.323960140624, 45081.77459112708, 45514.31728524075, 45574.0, 8865.86701199481, 9042.0, 9061.22979546736, 9078.636854525812, 9080.8637870432, 8933.240674542672, 9066.77333066672, 9068.727938161866, 9069.138431848964, 9071.863922041175, 9086.22767064797, 9087.0, 9113.407628504126, 9127.452352858849, 9129.68046118386, 9051.502167380791, 9089.863652045224, 9092.136247056518, 9100.499472529009, 9101.908980910206, 8960.55197240142, 9021.142991415805, 9044.09559044097, 9049.3665443419, 9053.68312109073, 43188.35217471709, 43697.563024369665, 43725.562744372466, 43748.3437748434, 43781.78109109466, 3650.543682039745, 3730.794806285653, 3752.043228976621, 3859.4210868369687, 4234.237837189305, 32536.511952320736, 32828.0, 33263.002109936744, 33275.0, 33679.15802104942, 4427.5572442755465, 4427.933580996288, 4452.332150177467, 4465.553444655541, 4472.105578884204, 349999.0, 350100.0, 353543.0, 353659.0, 353764.99999999744, 54592.0, 54812.725936370065, 54895.72552137214, 54931.45068549343, 54968.72515637396, 57804.976825810896, 61684.38315616876, 62969.0, 62996.0, 63072.68463657744, 17302.0, 17477.300907963538, 17511.562210944827, 17525.211365488583, 17527.91236043837, 12066.638000859988, 12071.094667899766, 12073.33596652175, 12079.516819327304, 12090.153689241668, 16547.917260413622, 16954.745678814827, 18155.45533633993, 18595.535111622048, 19147.32984345569, 6902.413294869993, 6956.130483689539, 6966.3730264276455, 7074.893876591856, 7226.0, 970.1656575345197, 1019.7756493571402, 1032.8140934631838, 1077.3159044006954, 1104.1608377633056, 32127.79323341977, 32129.35741285208, 32155.839220803748, 32582.0, 33259.66740332566, 1062.9627963021258, 1071.8767341755797, 1116.1349953785882, 1129.1192869561755, 1179.162794415957, 17029.48911532656, 17478.951262924264, 17496.0, 17497.300107995794, 17504.387346442814, 497872.0, 502596.0, 504783.0, 507604.0, 510529.0, 58294.708526457944, 59490.70254648785, 59536.404635953084, 59728.0, 59866.0, 1253.5111306590436, 1331.7269959658247, 1386.2929905748142, 1388.430743395203, 1392.3455975691409, 30482.695173047985, 33166.0, 33226.833865830515, 33233.33533329368, 34171.82914085413, 50713.492865070875, 51329.48670513247, 51449.48550514447, 51471.74264128655, 51513.484865150866, 372554.0, 379977.0, 381189.0, 381569.0, 382282.0, 36382.27235455223, 37435.0, 37481.250374992895, 38757.0, 42047.789761051, 48970.755146224044, 49171.0, 49186.26220606765, 49944.0, 50067.74966125146, 41408.0, 42233.57766422296, 42518.0, 42561.0, 42698.57301426946, 41709.0, 41833.79083104687, 42272.365914510694, 42279.57720422879, 43159.0, 40947.0, 41211.1757764837, 41675.16649667051, 41690.37464437975, 42351.78824105983, 35308.64691353054, 36262.0, 36893.81553092218, 37556.0, 37956.430653540774, 28134.577981330705, 28623.0, 28636.14091577256, 28666.570001449578, 29022.27444313909], "value": 20394.40052794144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6097884052141, 386.48404380152505, 392.8526802449082, 394.7631421147311, 411.91555731075135, 14423.278836058207, 17512.82487175128, 18556.0, 20107.497312567175, 20120.0, 18143.818561814376, 18556.17539439745, 19149.234030638792, 19186.520336991583, 19284.614307713873, 5659.801906933259, 5673.8297851064535, 5739.684317362543, 5766.336871259817, 5769.480746732793, 3957.98021009896, 5649.576281778863, 5726.885462290752, 5754.856128596777, 6033.27600687918, 6341.809745707613, 6364.745410183587, 6445.1621289232335, 6446.645434501101, 6454.483641308708, 6172.598781079238, 6352.174217351738, 6429.324920883287, 6438.227412710457, 6440.484761219114, 5676.858078548028, 5681.8068205676445, 5688.4311568843195, 5689.231953686241, 5690.3456102548325, 21116.894415527822, 22084.88957555218, 22136.778632213794, 23308.0, 23689.17087901915, 2276.943076423086, 2288.8512246704076, 2327.3483424641126, 2339.5671800716923, 2434.926952191437, 9817.90182098177, 10265.127464165555, 10274.229432792496, 10693.518791654395, 10751.623693170779, 1953.687410014391, 2012.315812623715, 2049.6822992436196, 2066.059942726056, 2083.812456878873, 76377.61811190909, 81320.0, 83176.0, 84353.57823210907, 86215.56892215561, 10724.302920310154, 10816.567337306577, 10887.83668244977, 11013.724656883482, 11071.228603423413, 13306.46774129024, 14347.56957291283, 15339.463118790789, 15363.385464581515, 15364.923175384052, 7887.881681774778, 7924.960375198087, 7972.0, 8023.277904988579, 8217.34261259098, 7769.145394006655, 7788.454808163374, 7808.843823123506, 7827.334676552557, 7961.920380796234, 4665.6734028617675, 4709.858704238878, 4713.78787954536, 4799.088173247072, 4823.541763532458, 1964.361582485698, 1965.9213631454581, 1995.5410255641284, 1997.670384386589, 2051.4256008317693, 881.4094556647062, 922.4649703172144, 929.6235024814961, 950.9239260859115, 981.9705408837747, 18246.543836404195, 18307.35924242645, 18973.0, 19211.231550737815, 19468.902655486632, 983.8475036369374, 1003.2375394700081, 1028.3932479836783, 1030.2891005206384, 1077.66053693088, 10347.586096556053, 10538.683839484827, 10730.463476826128, 10812.0, 10861.511231994422, 448120.0, 458880.0, 460366.0, 460524.0, 461613.0, 83152.0, 86900.0, 87343.0, 89413.55293223492, 89594.55202723945, 936.8969413364524, 951.129716309569, 965.82615129276, 966.0966995858895, 996.6661168508485, 16737.414190503274, 16775.832241677916, 17013.74479382835, 17223.65552688964, 17620.91189544044, 30220.84889575538, 32074.6792532081, 38570.228595427376, 41255.58744412517, 42956.0, 57927.131093034484, 58451.70774146102, 58905.41094588999, 59219.703901480214, 59269.11096333645, 5939.584229103922, 7591.316781489692, 7962.283394494523, 7971.12317645047, 8113.391495637733, 11070.290236418894, 13264.734705306033, 13426.932865336, 13566.118202316818, 13818.516351927634, 11636.709082273012, 11991.700207494883, 12098.092643051983, 12121.515139394325, 12154.331511766584, 11057.723556911142, 11140.108791296514, 11795.587154449553, 11820.940895295469, 11936.761264774483, 11709.414529273672, 11984.64046078619, 12018.0, 12219.26684398939, 12320.303908827495, 8820.426672266281, 9026.548672566476, 9056.456612603264, 9211.447313161232, 9263.953680231825, 11581.0, 11875.643730688093, 12125.090618203847, 12159.756804863677, 12221.938890305491], "value": 9153.416744804465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.7416753733025, 1462.2469428244456, 1507.6984603079386, 1633.3303345628294, 1781.4566557200048, 8315.293200077993, 8727.91272087279, 8750.124987501247, 8926.062763409846, 8954.37319387643, 8966.730998070052, 9129.0, 9150.679726209584, 9156.359054866161, 9165.037671044527, 2044.5808609235146, 2308.7691230876944, 2369.1589485732575, 2385.5109702510945, 2401.1235898896866, 2389.9880500597474, 2401.6037353836596, 2406.133791834938, 2406.7713567211085, 2407.723111842143, 2305.538892221554, 2335.486193037529, 2338.543983923136, 2340.8595484271, 2362.9881850590723, 1994.1923520974028, 2217.3347995601416, 2299.2642354446584, 2317.7682231776857, 2321.1643808229023, 2302.033146078651, 2302.1827251325703, 2315.455867871049, 2322.11759531377, 2322.825788065885, 9051.321150913707, 9162.0, 9202.0, 9204.539773011322, 9211.355205135644, 5393.6763794172475, 5537.501624853742, 5544.944550554484, 5548.472895074961, 5550.167474878801, 3443.8794642187404, 3603.621619729917, 3646.5441819772527, 3672.779633222015, 3690.870819521304, 1162.7674465107013, 1183.1363104933446, 1193.1767080714367, 1241.118805647991, 1243.2167734327406, 12625.368731563385, 12713.42789574462, 12748.553800616934, 12801.231926084465, 12811.935940320333, 4622.260438329851, 4654.743989080633, 4721.8347357842995, 4766.094442056067, 4794.976025119852, 9939.80120397588, 9969.950150249202, 9971.202303815677, 9975.351602145982, 9981.550830212658, 5384.461553844584, 5388.595855310868, 5390.51485366319, 5393.298871146726, 5395.271638328775, 4129.91740165195, 4914.827981020647, 5030.993801239693, 5038.445770965191, 5112.130937740593, 3854.5181852268465, 3919.490466239428, 3968.940465893014, 3971.860984865516, 4035.6973227008093, 1174.4069245031376, 1177.128924595793, 1185.3184418959133, 1185.6561597136733, 1200.429795846983, 832.4713806732768, 903.6295119001178, 973.9074787895139, 976.5751897924425, 1007.2848277722899, 6039.577229593974, 6280.937190628127, 6332.651704156316, 6379.776707815297, 6521.217453905561, 452.46834968911395, 459.7011942237506, 461.71373748276284, 469.03847113417356, 476.04552871493127, 4250.723702959298, 4405.251107311765, 4423.51341352451, 4438.933415998763, 4445.133199026159, 10838.295510791773, 11273.887261127447, 11301.0, 11334.319940803578, 11345.0, 11160.553577856957, 11199.66401007971, 11202.0, 11204.15968802343, 11207.327560346243, 7962.442629016029, 8307.08622051574, 8310.584470776437, 8462.957685211535, 8464.999999999876, 6169.876602467836, 6462.967685161544, 6512.251091124582, 6556.082148499309, 6590.604563726191, 10492.108170805566, 10596.629117980834, 10615.946920265349, 10630.468476576294, 10731.087857532197, 10581.788364232827, 10640.787184256425, 10894.564217431214, 11001.284916480403, 11047.447627618747, 7141.85716285661, 7657.0, 7659.961700191463, 8192.0, 8340.457870238415, 8969.10308969124, 9041.638334466548, 9054.502002389932, 9093.136152065543, 9112.271018318386, 7911.367090632851, 8138.552379618941, 8176.67293308261, 8217.712380066669, 8264.338852891875, 7669.424793140648, 7899.289063984269, 7902.0, 7989.680412783656, 8196.877046844183, 7357.668904899399, 7422.127922381831, 7455.739049133254, 7512.248775122444, 7529.962350188214, 5200.921986170135, 5255.500727430888, 5405.378381486179, 5407.134858422633, 5452.7546260417585, 5228.738563071907, 5284.920726189033, 5376.7580458878665, 5480.068388374066, 5551.8889622208135], "value": 4665.935085097947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.93971085204663, 335.0735217124651, 340.181862620398, 341.41106591130296, 342.7908975524931, 5267.183586544087, 5312.893742125155, 5313.415524292334, 5319.813806516772, 5326.254324394578, 5222.294990176325, 5225.764840582174, 5257.395399529055, 5263.0, 5272.630915835893, 3972.602739726033, 4027.939580906289, 4154.086101057763, 4154.792260386984, 4205.726627769201, 4134.235166494193, 4154.792260386968, 4163.354680024586, 4166.520850102232, 4184.4141820145205, 3907.7655340679507, 4095.6313931746135, 4100.2209580179815, 4124.566920473352, 4127.112670775783, 4033.757974521538, 4064.1871625674985, 4077.4903137107863, 4080.6327430531246, 4103.989045367778, 3588.6770190682964, 3604.5133906922492, 3616.963830361689, 3618.855245790165, 3635.4001589737663, 5097.23541468779, 5107.923381149286, 5123.564497017758, 5128.589712822965, 5129.435762066207, 4525.366448697185, 4728.172569800271, 4728.290756386536, 4737.218358970766, 4748.240281554935, 5413.188021796723, 5483.862903427406, 5484.232207490954, 5485.286912701324, 5497.202905578709, 4035.9798201008807, 4036.1524079943247, 4039.3133167361325, 4039.7172197946156, 4052.4326594276827, 5541.168824676331, 5579.609427340088, 5644.3508996465525, 5704.458076482728, 5715.199872017921, 4080.6123418275215, 4084.4281800547947, 4105.117399759066, 4115.8971025724595, 4134.152498737752, 4135.77253251068, 4136.503619565611, 4138.544760076389, 4146.0, 4148.958510414917, 4511.751853648016, 4652.208674795096, 4703.95296047042, 4794.688345257617, 4814.374131362901, 5567.19066303453, 5568.44315568448, 5584.6090773646265, 5592.384837667853, 5617.494425501643, 1433.4481224728554, 1459.6350912271932, 1463.5170393770031, 1463.5463006468028, 1469.4563011685532, 950.8716323296405, 958.4201558057414, 985.8915519292872, 1000.314784372707, 1004.5985849739573, 5306.0, 5306.151015837448, 5326.7869285228935, 5345.3852806926925, 5345.545628621533, 5537.031019571559, 5543.944560554423, 5576.414476479992, 5641.576881733887, 5659.915101273484, 4993.300937868701, 5246.478521228877, 5265.315508983807, 5298.7350632469, 5301.587777561201, 2951.5867778511024, 2966.6143401357685, 2968.614080169564, 2978.9275860690136, 2995.6405231372373, 5547.2511210986, 5700.800471983461, 5733.967885780599, 5749.3963133871175, 5783.739731712083, 5761.193432919395, 5762.913556296575, 5777.768889244468, 5783.71081445926, 5783.884322313615, 5785.392533783976, 5833.308340581354, 5847.26909136358, 5860.619059761102, 5897.756234071244, 5506.329430226417, 5662.915056274077, 5716.256886604715, 5762.510186634016, 5771.278590176228, 5692.430756924275, 5715.31416230055, 5718.428157184248, 5719.370869204301, 5723.542116630576, 5569.944300556943, 5883.294004719461, 5901.380355062656, 5909.6158749681135, 5918.23063001807, 4020.8086592807576, 4047.9190416190922, 4056.3307054335705, 4062.1266427718183, 4067.4508941292547, 5653.604247702621, 5670.546356291405, 5672.319321681424, 5685.374608793112, 5707.914381284201, 5395.541378982831, 5539.310510294399, 5570.5543556516195, 5585.69278689676, 5598.32820061579, 5558.49920521465, 5561.499465048165, 5562.303497433321, 5567.218490083134, 5575.526080283222, 5228.424873264014, 5319.38827034896, 5443.156310771837, 5482.0406428875585, 5490.835274941758, 5532.1701744737, 5563.0, 5578.665280083208, 5582.720863956704, 5601.327840659147, 5474.808381706621, 5490.6980116094, 5490.945090549043, 5498.45015498463, 5524.309461317335], "value": 4233.577052032144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.0661672908864, 777.1761932351708, 792.7542461836829, 811.209439528024, 853.0871966995315, 13805.861941380583, 14967.850321496782, 14977.176255305967, 14991.400343986228, 15041.849581504182, 14938.850611493881, 15585.532434026969, 15649.45226917058, 16157.757633635476, 16191.109488978102, 656.4125108028312, 811.5942028985522, 815.0993152566388, 817.5707753429438, 818.9918100818975, 778.2489897249153, 804.1877703519458, 808.7412028150994, 808.8827120067587, 809.7368355284526, 855.9229669329759, 856.2507805670039, 858.4891989266376, 858.8282343531288, 859.7334826203866, 691.0394551573318, 815.2377527012262, 858.3219256787131, 858.8539948208819, 859.4757198109118, 613.4356392119261, 614.5022531749297, 615.7752420366579, 615.8645098078416, 616.9969150154266, 13847.723045539033, 13952.511662091778, 13981.860181398259, 14035.578932632037, 14053.859461405358, 13487.0, 13837.584872453743, 13968.580942571638, 14333.42666293347, 14542.636434089232, 13622.795658065137, 13798.310084495735, 13840.723185536233, 13996.370163342674, 14233.644158896006, 4557.361969324297, 4582.702124361939, 4589.311603259504, 4654.883627909296, 4758.452777930548, 85741.57129214314, 86216.0, 88166.0, 90113.54943225307, 90581.09418905793, 11263.254195599531, 11273.887261127447, 11339.036181924464, 11552.249103808394, 11585.246958947642, 21758.891205544187, 21813.67279490809, 21829.781702183092, 21853.235136770138, 21886.671699924515, 8359.0, 8400.201980811813, 8496.405251632326, 8630.39587228888, 8852.778680533038, 4807.735574543433, 4826.203676393356, 4892.706437613754, 4949.133901567211, 5096.770645320969, 3617.638236176414, 3888.105735680753, 4039.3537034074407, 4044.7775372354213, 4101.0, 684.3430306905327, 697.1251079894801, 697.6058526932267, 698.228457554395, 703.8345988692755, 612.301975747648, 671.6071098407486, 697.1634039153037, 740.1414359343136, 748.221849276757, 8886.822263554823, 9364.531773411301, 9484.715458536255, 9494.810103798023, 9549.9045009549, 655.88194125057, 679.2392520377209, 691.989620155698, 709.5423451873513, 722.259683824074, 4811.27830825372, 5015.297858299841, 5024.296598476216, 5057.494250574987, 5074.822381216713, 108733.0, 111121.44439277751, 112961.43519282516, 113593.0, 114031.0, 101968.49015755022, 102190.48904755578, 102835.0, 103473.0, 104379.0, 89387.0, 90015.0, 91289.99999999868, 91947.54026229827, 92498.53750731204, 8898.110188981309, 8910.108989101298, 9062.818743625223, 9073.274138068806, 9227.44635321856, 50937.0, 52181.0, 53266.73366633142, 53812.0, 54170.0, 74301.0, 78705.0, 79340.60329698314, 79806.6009669948, 84379.0, 11803.350815705218, 12248.632541023784, 12325.568605098779, 12345.135840491439, 12548.18436801605, 13258.522840020576, 13496.003030121678, 13860.861391386361, 14118.78821817653, 14339.641508962359, 11256.718582035515, 11618.535258589562, 11951.223170494239, 12026.158168928441, 13282.070255082437, 13805.79291310611, 13984.930075349557, 14056.718865622835, 14075.296235187994, 14423.711525769635, 13823.101498402571, 14203.0, 14203.64490887736, 14237.857621423653, 15232.23838808033, 9727.951360243154, 9759.12167904892, 9962.601495940371, 10499.527521261714, 10666.57333706674, 10634.840477393, 10985.340879547253, 11008.39453830047, 11834.408279585814, 12293.262404255773], "value": 7659.753675043207, "unit": "score"}], "name": "dromaeo_css", "value": 7286.874915226148, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 108.0, 110.0, 112.0, 110.0, 109.0, 110.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 130.0, 199.0, 136.0, 124.0, 152.0, 124.0, 158.0, 124.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 161.0, 164.0, 162.0, 160.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 120.0, 76.0, 75.0, 76.0, 76.0, 105.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 118.0, 85.0, 84.0, 86.0, 121.0, 86.0, 85.0, 125.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 56.0, 55.0, 57.0, 58.0, 57.0, 55.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 78.0, 79.0, 80.0, 80.0, 83.0, 81.0, 112.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 125.0, 129.0, 118.0, 119.0, 120.0, 127.0, 120.0, 133.0, 133.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 162.0, 165.0, 159.0, 166.0, 156.0, 160.0, 160.0, 157.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 62.0, 64.0, 64.0, 62.0, 64.0, 63.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1501.8, "alertThreshold": 2.0}]} 20:23:52 INFO - Return code: 0 20:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:23:52 INFO - # TBPL SUCCESS # 20:23:52 INFO - Running post-action listener: _resource_record_post_action 20:23:52 INFO - ##### 20:23:52 INFO - ##### Finished run-tests step (success) 20:23:52 INFO - ##### 20:23:52 INFO - Running post-run listener: _resource_record_post_run 20:23:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552861696; Read time: 12; Write time: 426120 20:23:52 INFO - TinderboxPrint: CPU usage
13.1% 20:23:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:23:52 INFO - TinderboxPrint: I/O write bytes / time
552,861,696 / 426,120 20:23:52 INFO - TinderboxPrint: CPU idle
8,264.9 (86.9%) 20:23:52 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 20:23:52 INFO - TinderboxPrint: Swap in / out
0 / 0 20:23:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 140513280; Read time: 0; Write time: 146580 20:23:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295948288; Read time: 12; Write time: 189884 20:23:52 INFO - Running post-run listener: _upload_blobber_files 20:23:52 INFO - Blob upload gear active. 20:23:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:23:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:54 INFO - (blobuploader) - INFO - Done attempting. 20:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:54 INFO - (blobuploader) - INFO - Done attempting. 20:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:58 INFO - (blobuploader) - INFO - Done attempting. 20:23:58 INFO - (blobuploader) - INFO - Iteration through files over. 20:23:58 INFO - Return code: 0 20:23:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:23:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:23:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/329862efeb3caf74db4980811810702f871f22dd12484a5cdb5f8cf0781032341efb1bd1cbc1c0bfb46033e811fa397219dd7de0577598d02b5e9fa5dc80e6d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b630fc5aa7f465ba6af601dd21f792f6ff77485660245c987fd8ab8666cc89ea4c3ee5f21b14643ca1c0418ab21942701fa32a72520c2dfdc381be90394af90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db0c057327c295f25b00592c8707673d9e7181af843c83582c8878b43c9175d97edc05e6ab61cd6370d3c14b363803c939a939cd69a19d25e4b4976f84d24c4"} 20:23:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:23:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:23:58 INFO - Contents: 20:23:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/329862efeb3caf74db4980811810702f871f22dd12484a5cdb5f8cf0781032341efb1bd1cbc1c0bfb46033e811fa397219dd7de0577598d02b5e9fa5dc80e6d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b630fc5aa7f465ba6af601dd21f792f6ff77485660245c987fd8ab8666cc89ea4c3ee5f21b14643ca1c0418ab21942701fa32a72520c2dfdc381be90394af90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db0c057327c295f25b00592c8707673d9e7181af843c83582c8878b43c9175d97edc05e6ab61cd6370d3c14b363803c939a939cd69a19d25e4b4976f84d24c4"} 20:23:58 INFO - Running post-run listener: copy_logs_to_upload_dir 20:23:58 INFO - Copying logs to upload dir... 20:23:58 INFO - mkdir: /builds/slave/test/build/upload/logs 20:23:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.731478 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-25 20:23:58.127407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 20:23:58.130997) ========= 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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 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/329862efeb3caf74db4980811810702f871f22dd12484a5cdb5f8cf0781032341efb1bd1cbc1c0bfb46033e811fa397219dd7de0577598d02b5e9fa5dc80e6d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b630fc5aa7f465ba6af601dd21f792f6ff77485660245c987fd8ab8666cc89ea4c3ee5f21b14643ca1c0418ab21942701fa32a72520c2dfdc381be90394af90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db0c057327c295f25b00592c8707673d9e7181af843c83582c8878b43c9175d97edc05e6ab61cd6370d3c14b363803c939a939cd69a19d25e4b4976f84d24c4"} build_url:https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/CGM-fRLGTymoqZL75wuP-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/329862efeb3caf74db4980811810702f871f22dd12484a5cdb5f8cf0781032341efb1bd1cbc1c0bfb46033e811fa397219dd7de0577598d02b5e9fa5dc80e6d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b630fc5aa7f465ba6af601dd21f792f6ff77485660245c987fd8ab8666cc89ea4c3ee5f21b14643ca1c0418ab21942701fa32a72520c2dfdc381be90394af90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db0c057327c295f25b00592c8707673d9e7181af843c83582c8878b43c9175d97edc05e6ab61cd6370d3c14b363803c939a939cd69a19d25e4b4976f84d24c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 20:23:58.161617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:23:58.162305) ========= 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=0333a256a5e4f052382dd180000001b1-1466910031.618607-1242290588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 20:23:58.244451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 20:23:58.244973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 20:23:58.245455) ========= ========= Total master_lag: 0.18 =========