builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1465647339.02 results: success (0) buildid: 20160611023005 builduid: c495368f2dc34a9aa9b6e4cb1351b203 revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.022453) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.022849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.023127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.063243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.063512) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-11 05:15:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-06-11 05:15:39 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.160616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.160892) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.209886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.210193) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9694e371363590c8dace6629dc4d57f1af7206f2 --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 9694e371363590c8dace6629dc4d57f1af7206f2 --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=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-11 05:15:40,082 truncating revision to first 12 chars 2016-06-11 05:15:40,082 Setting DEBUG logging. 2016-06-11 05:15:40,082 attempt 1/10 2016-06-11 05:15:40,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9694e3713635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-11 05:15:40,394 unpacking tar archive at: fx-team-9694e3713635/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.882169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.882590) ========= script_repo_revision: 9694e371363590c8dace6629dc4d57f1af7206f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.883033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.883337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-11 05:15:39.895723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-11 05:15:39.896043) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:40 INFO - MultiFileLogger online at 20160611 05:15:40 in /builds/slave/test 05:15:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:40 INFO - {'append_to_log': False, 05:15:40 INFO - 'base_work_dir': '/builds/slave/test', 05:15:40 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:40 INFO - 'branch': 'Fx-Team', 05:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:40 INFO - 'config_files': ('talos/linux_config.py',), 05:15:40 INFO - 'default_actions': ('clobber', 05:15:40 INFO - 'read-buildbot-config', 05:15:40 INFO - 'download-and-extract', 05:15:40 INFO - 'populate-webroot', 05:15:40 INFO - 'create-virtualenv', 05:15:40 INFO - 'install', 05:15:40 INFO - 'run-tests'), 05:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:40 INFO - 'download_minidump_stackwalk': True, 05:15:40 INFO - 'download_symbols': 'ondemand', 05:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:40 INFO - 'installer_path': 'installer.exe', 05:15:40 INFO - 'log_level': 'info', 05:15:40 INFO - 'log_name': 'talos', 05:15:40 INFO - 'log_to_console': True, 05:15:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:40 INFO - 'opt_config_files': (), 05:15:40 INFO - 'pip_index': False, 05:15:40 INFO - 'sps_profile': False, 05:15:40 INFO - 'sps_profile_interval': 0, 05:15:40 INFO - 'suite': 'dromaeojs-e10s', 05:15:40 INFO - 'system_bits': '32', 05:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:40 INFO - 'title': 'talos-linux64-ix-011', 05:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:40 INFO - 'use_talos_json': True, 05:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:40 INFO - 'work_dir': 'build'} 05:15:40 INFO - ##### 05:15:40 INFO - ##### Running clobber step. 05:15:40 INFO - ##### 05:15:40 INFO - Running pre-action listener: _resource_record_pre_action 05:15:40 INFO - Running main action method: clobber 05:15:40 INFO - rmtree: /builds/slave/test/build 05:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:41 INFO - Running post-action listener: _resource_record_post_action 05:15:41 INFO - ##### 05:15:41 INFO - ##### Finished clobber step (success) 05:15:41 INFO - ##### 05:15:41 INFO - ##### 05:15:41 INFO - ##### Running read-buildbot-config step. 05:15:41 INFO - ##### 05:15:41 INFO - Running pre-action listener: _resource_record_pre_action 05:15:41 INFO - Running main action method: read_buildbot_config 05:15:41 INFO - Using buildbot properties: 05:15:41 INFO - { 05:15:41 INFO - "project": "", 05:15:41 INFO - "product": "firefox", 05:15:41 INFO - "script_repo_revision": "production", 05:15:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:15:41 INFO - "repository": "", 05:15:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:15:41 INFO - "buildid": "20160611023005", 05:15:41 INFO - "pgo_build": "True", 05:15:41 INFO - "basedir": "/builds/slave/test", 05:15:41 INFO - "buildnumber": 831, 05:15:41 INFO - "slavename": "talos-linux64-ix-011", 05:15:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:41 INFO - "platform": "ubuntu64_hw", 05:15:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:15:41 INFO - "branch": "fx-team", 05:15:41 INFO - "repo_path": "integration/fx-team", 05:15:41 INFO - "revision": "9694e371363590c8dace6629dc4d57f1af7206f2", 05:15:41 INFO - "stage_platform": "linux64-pgo", 05:15:41 INFO - "builduid": "c495368f2dc34a9aa9b6e4cb1351b203", 05:15:41 INFO - "slavebuilddir": "test" 05:15:41 INFO - } 05:15:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:15:41 INFO - Running post-action listener: _resource_record_post_action 05:15:41 INFO - ##### 05:15:41 INFO - ##### Finished read-buildbot-config step (success) 05:15:41 INFO - ##### 05:15:41 INFO - ##### 05:15:41 INFO - ##### Running download-and-extract step. 05:15:41 INFO - ##### 05:15:41 INFO - Running pre-action listener: _resource_record_pre_action 05:15:41 INFO - Running main action method: download_and_extract 05:15:41 INFO - mkdir: /builds/slave/test/build/tests 05:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:41 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:42 INFO - Downloaded 1361 bytes. 05:15:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:15:42 INFO - Using the following test package requirements: 05:15:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:15:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:15:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'jsshell-linux-x86_64.zip'], 05:15:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:15:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:15:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:15:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:15:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:15:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:15:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:15:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:15: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')]} 05:15:42 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:43 INFO - Downloaded 24464076 bytes. 05:15:43 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'] 05:15:43 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 05:15:44 INFO - Return code: 0 05:15:44 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 05:15:44 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')]} 05:15:44 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:45 INFO - Downloaded 24464076 bytes. 05:15:45 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'] 05:15:45 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 05:15:47 INFO - Return code: 0 05:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:47 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:15:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:15:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:49 INFO - Downloaded 10833377 bytes. 05:15:49 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'] 05:15:49 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 05:15:50 INFO - Return code: 0 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:50 INFO - https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SCGZxjF1TlOmibT9CXdxKw/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 05:15:54 INFO - Downloaded 59360225 bytes. 05:15:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:54 INFO - mkdir: /builds/slave/test/properties 05:15:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:54 INFO - Contents: 05:15:54 INFO - build_url:https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:15:55 INFO - Running post-action listener: _resource_record_post_action 05:15:55 INFO - Running post-action listener: set_extra_try_arguments 05:15:55 INFO - ##### 05:15:55 INFO - ##### Finished download-and-extract step (success) 05:15:55 INFO - ##### 05:15:55 INFO - ##### 05:15:55 INFO - ##### Running populate-webroot step. 05:15:55 INFO - ##### 05:15:55 INFO - Running pre-action listener: _resource_record_pre_action 05:15:55 INFO - Running main action method: populate_webroot 05:15:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:55 INFO - '--tppagecycles', 05:15:55 INFO - '7'], 05:15:55 INFO - 'tests': ['tsvgm']}}, 05:15:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['damp', 'tps']}, 05:15:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'tests': ['damp', 'tps']}, 05:15:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['dromaeo_dom']}, 05:15:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['a11yr', 05:15:55 INFO - 'ts_paint', 05:15:55 INFO - 'tpaint', 05:15:55 INFO - 'sessionrestore', 05:15:55 INFO - 'sessionrestore_no_auto_restore', 05:15:55 INFO - 'tabpaint']}, 05:15:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['tsvgx', 05:15:55 INFO - 'tsvgr_opacity', 05:15:55 INFO - 'tart', 05:15:55 INFO - 'tscrollx', 05:15:55 INFO - 'cart']}, 05:15:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:55 INFO - 'tsvgr_opacity', 05:15:55 INFO - 'tart', 05:15:55 INFO - 'tscrollx', 05:15:55 INFO - 'cart']}, 05:15:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'talos_options': ['--disable-e10s'], 05:15:55 INFO - 'tests': ['tp5o']}, 05:15:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'tests': ['tp5o']}, 05:15:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'talos_options': ['--disable-e10s', 05:15:55 INFO - '--xperf_path', 05:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:55 INFO - 'tests': ['tp5n']}, 05:15:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:55 INFO - 'talos_options': ['--xperf_path', 05:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:55 INFO - 'tests': ['tp5n']}}, 05:15:55 INFO - 'talos.zip': {'path': '', 05:15:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:55 INFO - Running post-action listener: _resource_record_post_action 05:15:55 INFO - ##### 05:15:55 INFO - ##### Finished populate-webroot step (success) 05:15:55 INFO - ##### 05:15:55 INFO - ##### 05:15:55 INFO - ##### Running create-virtualenv step. 05:15:55 INFO - ##### 05:15:55 INFO - Running pre-action listener: _resource_record_pre_action 05:15:55 INFO - Running main action method: create_virtualenv 05:15:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:55 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 05:15:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:55 INFO - Using real prefix '/usr' 05:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:57 INFO - Installing pip.................done. 05:15:57 INFO - Return code: 0 05:15:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:57 INFO - Using env: {'DISPLAY': ':0', 05:15:57 INFO - 'HOME': '/home/cltbld', 05:15:57 INFO - 'LANG': 'en_US.UTF-8', 05:15:57 INFO - 'LANGUAGE': 'en_US:en', 05:15:57 INFO - 'LOGNAME': 'cltbld', 05:15:57 INFO - 'MAIL': '/var/mail/cltbld', 05:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:57 INFO - 'MOZ_NO_REMOTE': '1', 05:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:57 INFO - 'NO_EM_RESTART': '1', 05:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:57 INFO - 'PWD': '/builds/slave/test', 05:15:57 INFO - 'SHELL': '/bin/bash', 05:15:57 INFO - 'SHLVL': '1', 05:15:57 INFO - 'TERM': 'linux', 05:15:57 INFO - 'TMOUT': '86400', 05:15:57 INFO - 'USER': 'cltbld', 05:15:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:57 INFO - '_': '/tools/buildbot/bin/python'} 05:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:57 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 05:15:57 INFO - Cleaning up... 05:15:57 INFO - Return code: 0 05:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:57 INFO - Using env: {'DISPLAY': ':0', 05:15:57 INFO - 'HOME': '/home/cltbld', 05:15:57 INFO - 'LANG': 'en_US.UTF-8', 05:15:57 INFO - 'LANGUAGE': 'en_US:en', 05:15:57 INFO - 'LOGNAME': 'cltbld', 05:15:57 INFO - 'MAIL': '/var/mail/cltbld', 05:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:57 INFO - 'MOZ_NO_REMOTE': '1', 05:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:57 INFO - 'NO_EM_RESTART': '1', 05:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:57 INFO - 'PWD': '/builds/slave/test', 05:15:57 INFO - 'SHELL': '/bin/bash', 05:15:57 INFO - 'SHLVL': '1', 05:15:57 INFO - 'TERM': 'linux', 05:15:57 INFO - 'TMOUT': '86400', 05:15:57 INFO - 'USER': 'cltbld', 05:15:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:57 INFO - '_': '/tools/buildbot/bin/python'} 05:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:58 INFO - Downloading/unpacking psutil>=3.1.1 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:00 INFO - Installing collected packages: psutil 05:16:00 INFO - Running setup.py install for psutil 05:16:00 INFO - building 'psutil._psutil_linux' extension 05:16:00 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 05:16:00 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 05:16:00 INFO - building 'psutil._psutil_posix' extension 05:16:00 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 05:16:00 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 05:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:00 INFO - Successfully installed psutil 05:16:00 INFO - Cleaning up... 05:16:00 INFO - Return code: 0 05:16:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:00 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')]} 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 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')]} 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:00 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:00 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 05:16:00 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 05:16:00 INFO - Using env: {'DISPLAY': ':0', 05:16:00 INFO - 'HOME': '/home/cltbld', 05:16:00 INFO - 'LANG': 'en_US.UTF-8', 05:16:00 INFO - 'LANGUAGE': 'en_US:en', 05:16:00 INFO - 'LOGNAME': 'cltbld', 05:16:00 INFO - 'MAIL': '/var/mail/cltbld', 05:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:00 INFO - 'MOZ_NO_REMOTE': '1', 05:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:00 INFO - 'NO_EM_RESTART': '1', 05:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:00 INFO - 'PWD': '/builds/slave/test', 05:16:00 INFO - 'SHELL': '/bin/bash', 05:16:00 INFO - 'SHLVL': '1', 05:16:00 INFO - 'TERM': 'linux', 05:16:00 INFO - 'TMOUT': '86400', 05:16:00 INFO - 'USER': 'cltbld', 05:16:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:00 INFO - '_': '/tools/buildbot/bin/python'} 05:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:02 INFO - Installing collected packages: mozsystemmonitor 05:16:02 INFO - Running setup.py install for mozsystemmonitor 05:16:02 INFO - Successfully installed mozsystemmonitor 05:16:02 INFO - Cleaning up... 05:16:02 INFO - Return code: 0 05:16:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:02 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:02 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 05:16:02 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 05:16:02 INFO - Using env: {'DISPLAY': ':0', 05:16:02 INFO - 'HOME': '/home/cltbld', 05:16:02 INFO - 'LANG': 'en_US.UTF-8', 05:16:02 INFO - 'LANGUAGE': 'en_US:en', 05:16:02 INFO - 'LOGNAME': 'cltbld', 05:16:02 INFO - 'MAIL': '/var/mail/cltbld', 05:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:02 INFO - 'MOZ_NO_REMOTE': '1', 05:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:02 INFO - 'NO_EM_RESTART': '1', 05:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:02 INFO - 'PWD': '/builds/slave/test', 05:16:02 INFO - 'SHELL': '/bin/bash', 05:16:02 INFO - 'SHLVL': '1', 05:16:02 INFO - 'TERM': 'linux', 05:16:02 INFO - 'TMOUT': '86400', 05:16:02 INFO - 'USER': 'cltbld', 05:16:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:02 INFO - '_': '/tools/buildbot/bin/python'} 05:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:03 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 05:16:03 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 05:16:03 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 05:16:03 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 05:16:03 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 05:16:03 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 05:16:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:05 INFO - warning: no files found matching '*.txt' 05:16:05 INFO - no previously-included directories found matching 'build' 05:16:05 INFO - no previously-included directories found matching 'dist' 05:16:05 INFO - no previously-included directories found matching '.git*' 05:16:05 INFO - Installing collected packages: jsonschema, functools32 05:16:05 INFO - Running setup.py install for functools32 05:16:05 INFO - warning: no files found matching '*.txt' 05:16:05 INFO - no previously-included directories found matching 'build' 05:16:05 INFO - no previously-included directories found matching 'dist' 05:16:05 INFO - no previously-included directories found matching '.git*' 05:16:05 INFO - Successfully installed jsonschema functools32 05:16:05 INFO - Cleaning up... 05:16:05 INFO - Return code: 0 05:16:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:05 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:05 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 05:16:05 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 05:16:05 INFO - Using env: {'DISPLAY': ':0', 05:16:05 INFO - 'HOME': '/home/cltbld', 05:16:05 INFO - 'LANG': 'en_US.UTF-8', 05:16:05 INFO - 'LANGUAGE': 'en_US:en', 05:16:05 INFO - 'LOGNAME': 'cltbld', 05:16:05 INFO - 'MAIL': '/var/mail/cltbld', 05:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:05 INFO - 'MOZ_NO_REMOTE': '1', 05:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:05 INFO - 'NO_EM_RESTART': '1', 05:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:05 INFO - 'PWD': '/builds/slave/test', 05:16:05 INFO - 'SHELL': '/bin/bash', 05:16:05 INFO - 'SHLVL': '1', 05:16:05 INFO - 'TERM': 'linux', 05:16:05 INFO - 'TMOUT': '86400', 05:16:05 INFO - 'USER': 'cltbld', 05:16:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:05 INFO - '_': '/tools/buildbot/bin/python'} 05:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:05 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 05:16:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:07 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 05:16:07 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 05:16:07 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 05:16:07 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 05:16:07 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 05:16:07 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 05:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 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 05:16:08 INFO - Downloading docopt-0.6.1.tar.gz 05:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:08 INFO - Running setup.py install for blobuploader 05:16:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:08 INFO - Running setup.py install for requests 05:16:08 INFO - Running setup.py install for docopt 05:16:08 INFO - Successfully installed blobuploader requests docopt 05:16:08 INFO - Cleaning up... 05:16:08 INFO - Return code: 0 05:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:08 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:08 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 05:16:08 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 05:16:08 INFO - Using env: {'DISPLAY': ':0', 05:16:08 INFO - 'HOME': '/home/cltbld', 05:16:08 INFO - 'LANG': 'en_US.UTF-8', 05:16:08 INFO - 'LANGUAGE': 'en_US:en', 05:16:08 INFO - 'LOGNAME': 'cltbld', 05:16:08 INFO - 'MAIL': '/var/mail/cltbld', 05:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:08 INFO - 'MOZ_NO_REMOTE': '1', 05:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:08 INFO - 'NO_EM_RESTART': '1', 05:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:08 INFO - 'PWD': '/builds/slave/test', 05:16:08 INFO - 'SHELL': '/bin/bash', 05:16:08 INFO - 'SHLVL': '1', 05:16:08 INFO - 'TERM': 'linux', 05:16:08 INFO - 'TMOUT': '86400', 05:16:08 INFO - 'USER': 'cltbld', 05:16:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:08 INFO - '_': '/tools/buildbot/bin/python'} 05:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:09 INFO - Running setup.py (path:/tmp/pip-slSnCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:09 INFO - Running setup.py (path:/tmp/pip-n3JWEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:09 INFO - Running setup.py (path:/tmp/pip-tIVbqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:09 INFO - Running setup.py (path:/tmp/pip-hVHuHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:09 INFO - Running setup.py (path:/tmp/pip-0gRGLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:09 INFO - Running setup.py (path:/tmp/pip-eFPLCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:09 INFO - Running setup.py (path:/tmp/pip-_roz4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:09 INFO - Running setup.py (path:/tmp/pip-PvtBF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:09 INFO - Running setup.py (path:/tmp/pip-ocsjsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:09 INFO - Running setup.py (path:/tmp/pip-Akck6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:09 INFO - Running setup.py (path:/tmp/pip-EWghDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:09 INFO - Running setup.py (path:/tmp/pip-9fczhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:10 INFO - Running setup.py (path:/tmp/pip-yukUId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:10 INFO - Running setup.py (path:/tmp/pip-_LOFKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:10 INFO - Running setup.py (path:/tmp/pip-NFME_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:10 INFO - Running setup.py (path:/tmp/pip-UMwkk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:10 INFO - Running setup.py (path:/tmp/pip-tKDLON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:10 INFO - Running setup.py install for manifestparser 05:16:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:10 INFO - Running setup.py install for mozcrash 05:16:10 INFO - Running setup.py install for mozdebug 05:16:10 INFO - Running setup.py install for mozdevice 05:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:10 INFO - Running setup.py install for mozfile 05:16:10 INFO - Running setup.py install for mozhttpd 05:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:10 INFO - Running setup.py install for mozinfo 05:16:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for mozInstall 05:16:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for mozleak 05:16:11 INFO - Running setup.py install for mozlog 05:16:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for moznetwork 05:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for mozprocess 05:16:11 INFO - Running setup.py install for mozprofile 05:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for mozrunner 05:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:11 INFO - Running setup.py install for mozscreenshot 05:16:11 INFO - Running setup.py install for moztest 05:16:12 INFO - Running setup.py install for mozversion 05:16:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:12 INFO - Cleaning up... 05:16:12 INFO - Return code: 0 05:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:12 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 05:16:12 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 05:16:12 INFO - Using env: {'DISPLAY': ':0', 05:16:12 INFO - 'HOME': '/home/cltbld', 05:16:12 INFO - 'LANG': 'en_US.UTF-8', 05:16:12 INFO - 'LANGUAGE': 'en_US:en', 05:16:12 INFO - 'LOGNAME': 'cltbld', 05:16:12 INFO - 'MAIL': '/var/mail/cltbld', 05:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:12 INFO - 'MOZ_NO_REMOTE': '1', 05:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:12 INFO - 'NO_EM_RESTART': '1', 05:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:12 INFO - 'PWD': '/builds/slave/test', 05:16:12 INFO - 'SHELL': '/bin/bash', 05:16:12 INFO - 'SHLVL': '1', 05:16:12 INFO - 'TERM': 'linux', 05:16:12 INFO - 'TMOUT': '86400', 05:16:12 INFO - 'USER': 'cltbld', 05:16:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:12 INFO - '_': '/tools/buildbot/bin/python'} 05:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:12 INFO - Running setup.py (path:/tmp/pip-U7t3gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:12 INFO - Running setup.py (path:/tmp/pip-bJ8fHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:12 INFO - Running setup.py (path:/tmp/pip-zNHjoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:12 INFO - Running setup.py (path:/tmp/pip-w0pVSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:12 INFO - Running setup.py (path:/tmp/pip-1gp9hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:12 INFO - Running setup.py (path:/tmp/pip-J9GWPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:12 INFO - Running setup.py (path:/tmp/pip-h8td52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:12 INFO - Running setup.py (path:/tmp/pip-8FkWpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:12 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)) 05:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:12 INFO - Running setup.py (path:/tmp/pip-fL71kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:13 INFO - Running setup.py (path:/tmp/pip-rTydVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:13 INFO - Running setup.py (path:/tmp/pip-Dd05xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:13 INFO - Running setup.py (path:/tmp/pip-afQMeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:13 INFO - Running setup.py (path:/tmp/pip-tMA7uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:13 INFO - Running setup.py (path:/tmp/pip-QlbzYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:13 INFO - Running setup.py (path:/tmp/pip-c0h0IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:13 INFO - Running setup.py (path:/tmp/pip-AzNHMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:13 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)) 05:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:13 INFO - Running setup.py (path:/tmp/pip-Sc2YR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:13 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)) 05:16:13 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)) 05:16:13 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)) 05:16:13 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)) 05:16:13 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)) 05:16:13 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)) 05:16:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:15 INFO - Downloading blessings-1.6.tar.gz 05:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:15 INFO - Installing collected packages: blessings 05:16:15 INFO - Running setup.py install for blessings 05:16:15 INFO - Successfully installed blessings 05:16:15 INFO - Cleaning up... 05:16:15 INFO - Return code: 0 05:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:15 INFO - Reading from file tmpfile_stdout 05:16:15 INFO - Current package versions: 05:16:15 INFO - argparse == 1.2.1 05:16:15 INFO - blessings == 1.6 05:16:15 INFO - blobuploader == 1.2.4 05:16:15 INFO - docopt == 0.6.1 05:16:15 INFO - functools32 == 3.2.3-2 05:16:15 INFO - jsonschema == 2.5.1 05:16:15 INFO - manifestparser == 1.1 05:16:15 INFO - mozInstall == 1.12 05:16:15 INFO - mozcrash == 0.17 05:16:15 INFO - mozdebug == 0.1 05:16:15 INFO - mozdevice == 0.48 05:16:15 INFO - mozfile == 1.2 05:16:15 INFO - mozhttpd == 0.7 05:16:15 INFO - mozinfo == 0.9 05:16:15 INFO - mozleak == 0.1 05:16:15 INFO - mozlog == 3.2 05:16:15 INFO - moznetwork == 0.27 05:16:15 INFO - mozprocess == 0.22 05:16:15 INFO - mozprofile == 0.28 05:16:15 INFO - mozrunner == 6.11 05:16:15 INFO - mozscreenshot == 0.1 05:16:15 INFO - mozsystemmonitor == 0.3 05:16:15 INFO - moztest == 0.7 05:16:15 INFO - mozversion == 1.4 05:16:15 INFO - psutil == 3.1.1 05:16:15 INFO - requests == 1.2.3 05:16:15 INFO - wsgiref == 0.1.2 05:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:15 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 05:16:15 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 05:16:15 INFO - Using env: {'DISPLAY': ':0', 05:16:15 INFO - 'HOME': '/home/cltbld', 05:16:15 INFO - 'LANG': 'en_US.UTF-8', 05:16:15 INFO - 'LANGUAGE': 'en_US:en', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MAIL': '/var/mail/cltbld', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SHLVL': '1', 05:16:15 INFO - 'TERM': 'linux', 05:16:15 INFO - 'TMOUT': '86400', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - '_': '/tools/buildbot/bin/python'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 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)) 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:16 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 05:16:16 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 05:16:16 INFO - Using env: {'DISPLAY': ':0', 05:16:16 INFO - 'HOME': '/home/cltbld', 05:16:16 INFO - 'LANG': 'en_US.UTF-8', 05:16:16 INFO - 'LANGUAGE': 'en_US:en', 05:16:16 INFO - 'LOGNAME': 'cltbld', 05:16:16 INFO - 'MAIL': '/var/mail/cltbld', 05:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:16 INFO - 'MOZ_NO_REMOTE': '1', 05:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:16 INFO - 'NO_EM_RESTART': '1', 05:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:16 INFO - 'PWD': '/builds/slave/test', 05:16:16 INFO - 'SHELL': '/bin/bash', 05:16:16 INFO - 'SHLVL': '1', 05:16:16 INFO - 'TERM': 'linux', 05:16:16 INFO - 'TMOUT': '86400', 05:16:16 INFO - 'USER': 'cltbld', 05:16:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:16 INFO - '_': '/tools/buildbot/bin/python'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 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 0x7fc8da851f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', '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 05:16:16 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 05:16:16 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 05:16:16 INFO - Using env: {'DISPLAY': ':0', 05:16:16 INFO - 'HOME': '/home/cltbld', 05:16:16 INFO - 'LANG': 'en_US.UTF-8', 05:16:16 INFO - 'LANGUAGE': 'en_US:en', 05:16:16 INFO - 'LOGNAME': 'cltbld', 05:16:16 INFO - 'MAIL': '/var/mail/cltbld', 05:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:16 INFO - 'MOZ_NO_REMOTE': '1', 05:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:16 INFO - 'NO_EM_RESTART': '1', 05:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:16 INFO - 'PWD': '/builds/slave/test', 05:16:16 INFO - 'SHELL': '/bin/bash', 05:16:16 INFO - 'SHLVL': '1', 05:16:16 INFO - 'TERM': 'linux', 05:16:16 INFO - 'TMOUT': '86400', 05:16:16 INFO - 'USER': 'cltbld', 05:16:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:16 INFO - '_': '/tools/buildbot/bin/python'} 05:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Downloading/unpacking flake8 05:16:16 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 05:16:16 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 05:16:16 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 05:16:16 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 05:16:16 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 05:16:16 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 05:16:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:18 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 05:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:19 INFO - no previously-included directories found matching 'docs/_build' 05:16:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:19 INFO - Running setup.py install for pep8 05:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:19 INFO - no previously-included directories found matching 'docs/_build' 05:16:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:19 INFO - Cleaning up... 05:16:19 INFO - Return code: 0 05:16:19 INFO - Running post-action listener: _resource_record_post_action 05:16:19 INFO - Running post-action listener: _start_resource_monitoring 05:16:19 INFO - Starting resource monitoring. 05:16:19 INFO - ##### 05:16:19 INFO - ##### Finished create-virtualenv step (success) 05:16:19 INFO - ##### 05:16:19 INFO - ##### 05:16:19 INFO - ##### Running install step. 05:16:19 INFO - ##### 05:16:19 INFO - Running pre-action listener: _resource_record_pre_action 05:16:19 INFO - Running main action method: install 05:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:19 INFO - Reading from file tmpfile_stdout 05:16:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:19 INFO - Reading from file tmpfile_stdout 05:16:19 INFO - Output received: 05:16:19 INFO - Usage: mozinstall [options] installer 05:16:19 INFO - Options: 05:16:19 INFO - -h, --help show this help message and exit 05:16:19 INFO - -d DEST, --destination=DEST 05:16:19 INFO - Directory to install application into. [default: 05:16:19 INFO - "/builds/slave/test"] 05:16:19 INFO - --app=APP Application being installed. [default: firefox] 05:16:19 INFO - mkdir: /builds/slave/test/build/application 05:16:19 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'] 05:16:19 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 05:16:36 INFO - Reading from file tmpfile_stdout 05:16:36 INFO - Output received: 05:16:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:36 INFO - Running post-action listener: _resource_record_post_action 05:16:36 INFO - ##### 05:16:36 INFO - ##### Finished install step (success) 05:16:36 INFO - ##### 05:16:36 INFO - ##### 05:16:36 INFO - ##### Running run-tests step. 05:16:36 INFO - ##### 05:16:36 INFO - Running pre-action listener: _resource_record_pre_action 05:16:36 INFO - Running main action method: run_tests 05:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:36 INFO - Python 2.7.3 05:16:36 INFO - Return code: 0 05:16:36 INFO - grabbing minidump binary from tooltool 05:16:36 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')]} 05:16:36 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 0x246e110>, '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 0x23da230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23da6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:36 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 05:16:36 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 05:16:36 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 05:16:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:36 INFO - Return code: 0 05:16:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:37 INFO - Return code: 0 05:16:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:16:37 INFO - Using env: {'DISPLAY': ':0', 05:16:37 INFO - 'HOME': '/home/cltbld', 05:16:37 INFO - 'LANG': 'en_US.UTF-8', 05:16:37 INFO - 'LANGUAGE': 'en_US:en', 05:16:37 INFO - 'LOGNAME': 'cltbld', 05:16:37 INFO - 'MAIL': '/var/mail/cltbld', 05:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:37 INFO - 'MOZ_NO_REMOTE': '1', 05:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:37 INFO - 'NO_EM_RESTART': '1', 05:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:37 INFO - 'PWD': '/builds/slave/test', 05:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:37 INFO - 'SHELL': '/bin/bash', 05:16:37 INFO - 'SHLVL': '1', 05:16:37 INFO - 'TERM': 'linux', 05:16:37 INFO - 'TMOUT': '86400', 05:16:37 INFO - 'USER': 'cltbld', 05:16:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699', 05:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:37 INFO - '_': '/tools/buildbot/bin/python'} 05:16:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:16:37 INFO - mozversion application_buildid: 20160611023005 05:16:37 INFO - mozversion application_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 05:16:37 INFO - mozversion application_display_name: Nightly 05:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:37 INFO - mozversion application_name: Firefox 05:16:37 INFO - mozversion application_remotingname: firefox 05:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:37 INFO - mozversion application_vendor: Mozilla 05:16:37 INFO - mozversion application_version: 50.0a1 05:16:37 INFO - mozversion platform_buildid: 20160611023005 05:16:37 INFO - mozversion platform_changeset: 9694e371363590c8dace6629dc4d57f1af7206f2 05:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:37 INFO - mozversion platform_version: 50.0a1 05:16:37 INFO - using testdate: 1465647397 05:16:37 INFO - actual date: 1465647397 05:16:37 INFO - starting webserver on 'localhost:54500' 05:16:37 INFO - SUITE-START | Running 2 tests 05:16:37 INFO - TEST-START | dromaeo_css 05:16:37 INFO - operating with platform_type : linux_ 05:16:37 INFO - Initialising browser for dromaeo_css test... 05:16:37 INFO - TEST-INFO | started process 15493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0CC2e/profile http://localhost:54500/getInfo.html) 05:16:43 INFO - PROCESS | 15493 | __metrics Screen width/height:1600/1200 05:16:43 INFO - PROCESS | 15493 | colorDepth:24 05:16:43 INFO - PROCESS | 15493 | Browser inner width/height: 1024/697 05:16:43 INFO - PROCESS | 15493 | __metrics 05:16:45 ERROR - PROCESS | 15493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:16:46 INFO - TEST-INFO | 15493: exit 0 05:16:46 INFO - Browser initialized. 05:16:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:46 INFO - TEST-INFO | started process 15614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0CC2e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:58 INFO - PROCESS | 15614 | RSS: Main: 185106432 05:16:58 INFO - PROCESS | 15614 | 05:17:47 INFO - PROCESS | 15614 | 1465647467901 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] 05:19:56 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54500/tests/dromaeo/cssquery-ext.html) 05:19:57 INFO - PROCESS | 15614 | RSS: Main: 189308928 05:19:57 INFO - PROCESS | 15614 | 05:22:59 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-ext.html (next: http://localhost:54500/tests/dromaeo/cssquery-jquery.html) 05:22:59 INFO - PROCESS | 15614 | RSS: Main: 188076032 05:22:59 INFO - PROCESS | 15614 | 05:26:01 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54500/tests/dromaeo/cssquery-mootools.html) 05:26:02 INFO - PROCESS | 15614 | RSS: Main: 188968960 05:26:02 INFO - PROCESS | 15614 | 05:29:04 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54500/tests/dromaeo/cssquery-prototype.html) 05:29:04 INFO - PROCESS | 15614 | RSS: Main: 186585088 05:29:04 INFO - PROCESS | 15614 | 05:32:07 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54500/tests/dromaeo/cssquery-yui.html) 05:32:07 INFO - PROCESS | 15614 | RSS: Main: 189054976 05:32:07 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-yui.html (next: http://localhost:54500/tests/dromaeo/cssquery-dojo.html) 05:35:10 INFO - PROCESS | 15614 | RSS: Main: 189976576 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | __start_tp_report 05:35:10 INFO - PROCESS | 15614 | _x_x_mozilla_page_load 05:35:10 INFO - PROCESS | 15614 | _x_x_mozilla_page_load_details 05:35:10 INFO - PROCESS | 15614 | |i|pagename|runs| 05:35:10 INFO - PROCESS | 15614 | |0;dojo.html;3074;3108;3132.530120481928;3137.513685378766;3144.3868445653106;5307.495787900153;5346.866328341794;5386.245925570418;5416.729163541827;5422.674639521631;5203.427622961472;5335.573154147669;5349;5351.946480535194;5437.891242175154;4778.68938518996;4797.7121372717575;4893.877653058684;4981.651284410093;4996;826.6782890992724;4809.254565542346;4933.284673722326;4946.629002824785;4946.653734238605;4885.755712214411;4886.071646387193;4893.8531844044555;4925.75371231437;4959.752012399365;4855.975720121377;4910;4913.361263035782;4940.925886111711;4980.128477516457;4829.589484893788;4852.708837469728;4864.5621894029355;4866.270059491105;4874.731889746098;5365.7853685852515;5417.214503896952;5441.455854414567;5476.096444086721;5517.393086760453;5683.346415162227;5721.427857214287;5843.590948633598;5850.3564607893095;5853.736581853785;5759.856003599902;5783.537317014629;5818.389069147764;5818.44724751148;5865.120231965197;5402.648827826218;5424.484673955928;5432.809851655252;5439.156930675752;5441.619086663935;5825.679587622637;5894.616849904743;5904.409559044061;5931.703414829241;5957.165996760457;5713.885722285614;5718.228039214653;5718.828435146952;5737.913931291034;5741.282339707536;5817.243758311392;5824.475797178275;5824.534037277008;5829.183914252008;5842.152887831241;5508.421615730371;5652.0391533439415;5680.091185410314;5736.368999410061;5778.8266352009505;5611.915821262684;5714.857128571736;5752.597318187771;5758.395368486333;5769.105788602773;4389.100234451929;4393.780310984438;4395.802188901507;4398.73607583546;4429.047754732748;3828.693704503633;3856.402257650069;3868.903277418031;3899.707521935866;3946.8223929923224;5435;5467.835964920979;5477.808276710296;5504.2018907258225;5520.779168833282;5689.516391106802;5713.74288157034;5730.656160630376;5734.713264336767;5745.569082318759;5425.697832520245;5468.699221542854;5472.644278121909;5487.314085739283;5493.862653433616;4875.561199492063;4880.194767863334;4896.95103048972;4898.804047838118;4942;5937.465628093492;5937.792177273861;5938.554608404387;5939.70301484924;5951.583389162717;5651.463111004448;5740;5761.596688231783;5773.91339129905;5808.825735227865;5929.970350148222;5945.554083443845;5961.582689211714;5970.432808883149;5998.760049597967;5703.486686198262;5705.771769129355;5712.514436272963;5722.055860782924;5729.026065568946;5622;5675.375708672125;5724.4561766632105;5743.597948143757;5773.134029895549;5554.91667624994;5592.69240191777;5619.662820230636;5640.182173584725;5652.039153343859;5508.366537848199;5578.888422231614;5595.384507704068;5601.29983752031;5607.859803504945;5335.839924802262;5416.377116631637;5432.7555260012605;5437.13005919051;5438.809641662523;5499.4775496329385;5545.944540554704;5561.527270181918;5607.943920560742;5656.660600363992;5474.288342515448;5488.231647569263;5495.505404513453;5506.559475242051;5510.0632892409185 05:35:10 INFO - PROCESS | 15614 | |1;ext.html;575.9712014399281;607.8662694207272;615.7690865925277;633.8573820890304;647.6664517773347;40700.18599628006;41578.37632435516;42239.577604223945;42385.57614423855;43961;42533.7873310633;42536.787316063375;42808.143837123316;42984;43177.35233971493;8923.19691227791;9014.14365635267;9053;9069.818603627957;9074.228690561311;8878.42290251135;8911.866322005142;8947.373683842101;8948.015718270985;8973.10268973104;8985.955070224672;9001.009888912215;9001.414908030989;9006.819863602757;9032.548372581345;8838.911610883873;8927.687530936419;8976.326775491832;8981.416207946528;8989.95505022474;8705.956470217672;8769.517676527788;8772.385932984693;8790.252828509585;8851.424657397312;40693.79653101716;40809.183816323806;40884.795576022225;40955.69965153646;41218.587814122075;3347.8807311304486;3370.140614143402;3395.2021275000357;3422.640622734602;3439.4235248639616;30002.099937001924;31725.11575795434;32415.6758432415;32575;32612;4343.109662519176;4386.605205531486;4529.886752831173;4588.541145885418;4592.816287348502;330375;330834;331374;331510;331845.340773297;59184.70407647934;59711;60278;60330;60337;59060.409395906354;59206.63173473099;59659.70170149121;59959;59983;14910.925445372704;15758;15792.052476851426;16163.676726465404;16218.432354867758;10465.058144767008;10527.420991845369;10542.631007914839;10558.947205264078;10586;18474.722879156823;18651.440456786317;18665.16006779671;18894.449249351437;19376.903115484612;7053.153621565342;7160.785176444715;7267.963660181771;7525.736599219001;7527.322540971339;1011.367895065584;1034.5086084110137;1113.5412609481605;1139.5270962550615;1143.2854465958776;33002.17494562655;33130.66869331324;33279.36031984008;33464.49803252953;33646.663533364845;1133.2690414682647;1140.7547377313917;1141.1612464838338;1163.8545181852269;1166.2943918928927;17008.149592520323;17227;17295.91352043257;17423.21595528204;17500;525535;525702;532922;533200;533588;56871.146932796044;58182;58556.70721646365;58642.533936651926;58666.706666467246;1336.5054929675887;1340.477213886585;1341.8859396951173;1347.5957212836306;1354.6681063139595;30838.53742193824;32364.35271294514;32424.837875811412;32572.674273256966;32803.50794738129;48468.5153148464;48560;48583.51416485931;48690;48821.75589122032;454712;454907;456131;456297;456589;27507.449851003268;27733.168004959884;28742.137735867957;28847.56728649114;30290.545641814948;47977.5202247987;48158.75920620515;48163.277550836065;48976.755116224194;49205;41008.79495602622;41101.79449102735;41946.7902660497;41997;42512;41377.586224137376;41562.1687566253;41671.16657666769;41906;41947.37078943757;40937.795311023256;41306.793466032475;41976;42492.362614561425;44881;35330;38864.61135388723;39087.41368879412;39217.60782392254;39590.208195835345;28441.43117137687;28660;28730.71269287364;28851.422971540873;28933.85533072321 05:35:10 INFO - PROCESS | 15614 | |2;jquery.html;388.8775035863704;389.36727817296895;389.8128898128898;391.63969148383484;407.5069166308766;14275.357608907598;17851.196696148672;19410.805891941094;19414.90292548537;19965.700514492295;18150.72773908389;18392.44822655319;18507.16717747701;18519.62960740788;18527.16627751751;5547.583931205156;5573.4147914469;5789.334226563957;5807.2450581424355;5808.448197421239;5598.58010649203;5690.2887139107615;5693.231413759131;5695.316562012565;5695.629784064023;5523.309586301712;5615.736459296646;5718.771249150029;5718.885622287552;5722.856928576777;5468;5635.408282130399;5672.149177623369;5673.546116310706;5699.430056994309;5104.668196567211;5108.64239503235;5122.436531981479;5143.8456846294675;5150.330457040598;21199.894000530054;21869.562608747896;22143.557128857334;22385.440363990867;22453;2335.6029474989123;2361.2798096580536;2388.4148383645943;2990.4916164251913;3072.2319420144963;14057.367418466194;14156.716865662733;14224.217668028254;14716.632084197874;14811.111333319928;1806.692862213427;1855.9628807423776;1901.9714704279447;1969.350114462224;1977.3968939473455;73374.63312683455;76572;76969;77194;77829.61085194538;9140.131687489678;10139.391636501834;10401.895981040245;10609.310394824312;10617.55796166886;10622.309549879234;11223.494942727597;11240.156988225915;14746.11523308605;14760.48338308154;5702.429757024264;5907.084401917709;6581.835454113685;7472.775816725398;7575.280348366897;7401;7473.813154671068;7491.737789177353;7518.28576285252;7699.345555627834;3677.1542545214215;3686.336459437327;3797.7531460454984;3872.0707030312524;3902.7658340499092;1857.1735577668078;1893.403577872993;1900.5723712164652;1905.1712505060343;1919.7504324438014;922.7877588154762;977.8044391121662;1019.1795604538418;1026.9127124194526;1076.6769969009265;18065.909670451827;18310.176042077874;18515.35196268124;18669.253229870654;18745.531361716065;1030.217035053365;1048.5386429970788;1075.978480430387;1117.0672488472217;1146.2262972493534;9987.800243995225;10555.577776888838;10572.735681607868;10605.204609654307;10610.469476526298;487493;501761;504473;510269;512012;96421;98265.50867245761;98601;99511;100256;981.8134554434635;1004.1314263162458;1010.0959641121156;1050.5587653185528;1058.275081569143;17116.400925967533;17194.914025430295;17660.32226938439;17679.646407072043;17708.557286067953;42280.365794513724;42474.575254248295;42575.7871210642;43905;44264.12283201582;53285.4671453296;53968.73015634897;56123.43876561182;59050.40949590449;60808.695956521704;7816.257455541714;7818.452708310591;7887.132415434183;7919.12889582134;8092.271695547429;12290.262584244974;13128.934355328161;13143.802842957171;13286.80069798973;13379.264140472367;11474.655760327203;11572.305661660328;11832.112591555495;11891.762164756483;12023.63929082129;9578.377405468622;11629.534818607499;11633.767324653629;11786.410679466164;12009.099317551394;11736.119791015537;11860.584879529175;11977.700557486132;12018.75962480763;12479.438425270702;7773.533587984739;7777.500124943911;7929.801754955942;7962.562059086806;8158.184181582032;10112.342697724624;10238.692839214835;10794.460276985963;11361.602343917923;11834.171607987702 05:35:10 INFO - PROCESS | 15614 | |3;mootools.html;1439.0574173916086;1466.691994681117;1560;1709.9914500427496;1717.6049508613012;7647.082350117979;8295.294899933499;8484.19400156985;8807.91192088079;8810.16303451172;8438.620262088205;8680.435771674836;8709.346798990086;8751.824963500727;8766.649334026632;2161.319184456895;2211.6903633491324;2216.091402524965;2216.445888527868;2221.2114699281765;2163.145557504785;2192.6382146945734;2205.658122990939;2217.623004089309;2218.134927378324;2155.5365596396773;2181.291080398869;2184.4866456382815;2199;2205.426589086841;2075.802798734118;2089.6969939358783;2096.716943212662;2097.328854766475;2102.8738275703354;2032.034783477851;2074.201432448518;2077.2937201351615;2118.650422680256;2121.448423409909;8778.868316975251;8794.472331660121;8805.735827925173;8841.38110332277;8868.556572171366;4820.542048505386;4896.975515122402;4947.158982972904;4967.205247160437;4976.328195693572;3082.2910730532103;3174.7301479374282;3264.9183770405693;3283.7865538739907;3290.802551846873;1061.936283822973;1063.500154927183;1071.5071067309048;1093.8960798724108;1119.3899324867884;11933;11963.700907477296;12044.81932771009;12050.216735912225;12060.939695301555;4176.83292668296;4177.540470548237;4205.9789701051295;4219.135077309144;4231.344141658048;10127.544260508295;10143.442110683984;10145.985401459795;10159.695209143738;10236.590536378462;4796.352492413549;4805.519448055166;4827.734474603931;4856.902861942742;4858.416989961227;4016.6585840203325;4423.579759922803;4431.268840641323;4458.152950939311;4581.450225972904;3737.4206997915367;3756.6619004289746;3775.86784462548;3840.3663395539984;3865.8453661853773;1122.9045531129782;1149.0692539043403;1158.472894832849;1171.9062475001979;1187.9703007424885;945.5555888732284;957.4446820843893;971.4317124482257;973.454865275448;1002;5923.229980102559;5958.6722730249385;6037.758489660452;6115.480184184395;6143.1706719592285;917.8898532176181;967.8790151231096;971.6404930175739;976.2873102635116;1003.9598416063276;4060.7360521566;4146.564610715892;4157.459530261047;4158.521769996429;4187.748735075906;10444.843327350096;10652;10669.733256668645;10707.250492465453;10835.349879007284;10509.789804203872;10579.682609521727;10620.575176992988;10627.84058239127;10637.893621063846;7737.574433406104;7903.762887113396;7945.562994035384;8065.677372905136;8179.631916563888;5987.34139244674;6037.094435834484;6144.8771024580155;6185.6907154641185;6228.439440450381;9695.127438530566;9993;10114.29199955996;10232.795344093225;10240.692779216635;10216.59133634676;10268.948655256676;10318.690439286833;10330.070293673605;10359.63741269052;7006.334398232159;7609.619519023916;7649.349805266392;7866.646000930086;7890.250426209501;8565;8603.569821509025;8615.741527754177;8633.740987770378;8658.220760131619;7689.192634773492;7763.456558040883;7876.251756083163;7876.803079923047;8011.3190378816125;7649.694012239448;7686.500377475446;7712.421568382281;7810.140884502814;7826.843463130592;6783.660816959034;6859.211190712932;6889.586624802528;6912.758053468105;6914.9308506914285;5284.260203571426;5342.813001544927;5359.651622644516;5452.127659574608;5487.341519017744;5369.919451208313;5456.672599644034;5509.669419834822;5539.723013849372;5578.721063946705 05:35:10 INFO - PROCESS | 15614 | |4;prototype.html;311.79421581756037;314.3367494586424;317.8712621388338;328.625367081527;332.28227029616016;5428.61999660024;5530.723463826813;5556.9444305556935;5584.4136365681625;5595.272614560102;5504.972475137629;5546.362168350641;5561.944380556193;5584.692841893694;5593.356763972144;4291.828326866929;4295.463067116611;4311.073119279355;4330.501992270898;4340.327249276352;4101.733387329829;4326.437563116806;4335.5881191286935;4336.674749393792;4347.3261644445165;4237.957620423787;4253.532111467736;4257.212415703089;4258.6380157686635;4275.358696195564;4248.978755106235;4260.723053001545;4276.358546218061;4282.571742825692;4291.828326866922;3667.504886840296;3735.514383130203;3741.5136032315895;3754.6808521275725;3763.1184407796104;5395;5403.540699040586;5406.324209473816;5446.673199608036;5475.342958844924;4864.854054378375;4897.926531102036;4902.950970490285;4920.384951881015;4921.901561968776;5612.214289999403;5845.649261044351;5880.235569375996;5889.322727886305;5920;4116.341385378325;4149.170165966819;4151.3150330195485;4153.314703074019;4153.6677065834665;6109.969450152721;6119.082137679339;6120.1737765401995;6128.571000030044;6146.323904370515;3970.285348637273;4218.620324170839;4218.915621687549;4219.240536703423;4237.25847976609;4251.59609837065;4255.5957184067465;4265.722728022669;4267.487901451846;4274.2092712848225;4885.951140488621;4913.852584422473;4918.5981995131215;4939.580135688435;4946.183879659816;5329.600279978939;5883.294004719461;5922.407759224129;5935.812837432531;5939.673317967467;1402.901796874209;1412.1103704665995;1418.9216195691142;1419.5457453614745;1425.9287035648176;900.4102312985005;910.6175406329226;921.2721949659827;926.536731634183;945.6217512994857;4994.950050499521;5004.047611908991;5015.01906746833;5035.82374616894;5037.800996367333;5232.953409318152;5285.119609812585;5345.358556973188;5357.598180136505;5363.490468405495;4968.975155124273;4974.502549744997;5007.248912663057;5283.260343551906;5787.7395517200985;3206.695363940422;3232.951505727416;3234.175285302233;3262.8531716072835;3271.247613049012;5976.252968378953;6295.496360291166;6297.4962003039645;6328.873422531616;6338.161933039367;6224.190855188796;6239.251289845157;6244.968775156095;6254.9687251563455;6277.112528236971;6165.691715414211;6229.688515574294;6230.813075607648;6252.812415627538;6279.277883043417;5869.970650146722;6062.878742425215;6069.575129740876;6074.3318234994995;6086.7260973255425;5844.947909376353;5987.700614969322;6005.549583781147;6028.306744724237;6045.909311360421;5927.2590926134235;6183.752649893954;6188.938110619017;6202.689865506797;6296.84257893538;4077.06227567667;4116.5060192777055;4137.8965525862095;4141.7722025288895;4182.477190351206;5937.6843031216995;6015;6039;6060.393960603904;6116.217121209927;5873.177755114202;5885.646861188342;5910.438508341701;5919.6152250103605;5928.288605367384;5872.823815285548;5877.823665289877;5911.728978269693;5964.284285885721;5979.4618484336615;5632.493075623213;5846.473817356458;5862.618929769551;5903.409659034062;5904.143899134516;5876.324222714272;5910.049683604486;5953.315368732651;5969.194158788681;5977.193078934288;5701.686407247641;5830.62100963436;5843.386444423274;5856.297244330707;5865 05:35:10 INFO - PROCESS | 15614 | |5;yui.html;694.1080711285996;763.435058057038;785.1089013969145;789.6091434739805;800.5516910530101;13835.861641383595;14345.856541434583;14371.496997605085;14457.277136143177;16402;14770;15007.774883376758;15046.774298385533;15078.54764357071;15143.167125808104;662.6123717625195;782.2724865874762;807.555844285642;818.4557269415832;822.042320696388;797.8922845415882;807.6325272001226;812.175641723651;815.9347252219837;817.9386546009043;837.7486753973814;844.9831003379928;847.3094428041157;851.7189327521934;853.9829203415928;837.6356285016037;844.936629752771;845.5222799118478;846.551327796269;846.7840700621364;616.488314698799;617.3147805935408;617.3517806303408;619.0281258424276;619.5879739972912;14761.483348082766;14965.92517037408;15028.474003409938;15061.096334219872;15092.094474331576;14062.507812226626;14321.928390358085;14357.497487587885;14375.424983000667;14560.781588276184;11855.644330670093;11995.820062699066;12026;12037.699057523545;12724.109312348139;3827.2728181645675;3833.463315135883;3999.6400323970984;4047.534533528623;4053.148838743867;75444.62277688576;75891.24108758898;76095.23904760992;76112;77142.84285735774;11275.154363422776;11350.09199264057;11591.710207244887;11686.357250351311;11868.88131118695;21645.458863528536;21764.347069587937;21971.231006915;22051.11795528161;22516.32451026472;8455.408121431441;8600.0109987351;8605.225529702357;8840.911590884009;8992.121435472418;4761.928571071437;4872.317875497433;4886.511348865156;4889.902201955941;4981.153203955337;3457.3258214648404;3487;3548.3435564420665;3551.911202219965;3569.161247106928;590.6574186971546;598.1984141250745;601.6330038676404;603.1977469964936;619.102301662591;670.808819486444;682.5017737051979;735.724103461202;747.4618274842105;749.5952185819706;9201.447913125234;9493.715188544216;9494.477803720862;9507.33448658601;9559.569819358145;602.6293829294953;723.1358526560709;727.294524311417;742.858856817203;744.7691215723144;4548.454185497695;4699.718016918996;4700.976495117503;4763.928541071887;4782.139214941274;67582.66208669024;107424;111247;113167.43416283031;115446.42276788563;59735.40264597299;61952.38047619556;62048.37951620516;62136;64106.6794666033;56153.7192314044;63673;74391.62804185944;74424.25575744173;76891;9926.553305101143;10079.848802268118;10215.795684086424;10286.279960402999;10471.738206544896;38083.809580951915;50143.498565013884;53453;53920.73039634777;54680.45319546753;44960;46166;57571;75562;76772.61613691896;12488.875111249135;13226.140300880412;13235.338233088114;13349.799753003907;13412.262325572186;14056;14174.165166966854;14271.215083170526;14485.275736212936;14673.339699713752;13648.65878353049;13957;14156.362963666454;14865.033772805165;14874.925625371803;13842.792358114837;14103.647408814863;14139.434422623392;14333.140011599337;14537.92731036338;13520.661983450493;13546.661333466742;13573.457061717421;13608.319584020957;13689.247091410069;10431.94784026075;10511.421871797125;10741.570337186426;10808.567657293936;11512.712182195512;11266.718332041764;11626.53493860236;11636.360000199731;11733.237339572901;11857.229280096766 05:35:10 INFO - PROCESS | 15614 | __end_tp_report 05:35:10 INFO - PROCESS | 15614 | __start_cc_report 05:35:10 INFO - PROCESS | 15614 | _x_x_mozilla_cycle_collect,352 05:35:10 INFO - PROCESS | 15614 | __end_cc_report 05:35:10 INFO - PROCESS | 15614 | __startTimestamp1465648510567__endTimestamp 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | ------- Summary: start ------- 05:35:10 INFO - PROCESS | 15614 | Number of tests: 6 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#0] dojo.html Cycles:165 Average:5315.70 Median:5508.37 stddev:702.55 (12.8%) stddev-sans-first:682.34 05:35:10 INFO - PROCESS | 15614 | Values: 3074.0 3108.0 3132.5 3137.5 3144.4 5307.5 5346.9 5386.2 5416.7 5422.7 5203.4 5335.6 5349.0 5351.9 5437.9 4778.7 4797.7 4893.9 4981.7 4996.0 826.7 4809.3 4933.3 4946.6 4946.7 4885.8 4886.1 4893.9 4925.8 4959.8 4856.0 4910.0 4913.4 4940.9 4980.1 4829.6 4852.7 4864.6 4866.3 4874.7 5365.8 5417.2 5441.5 5476.1 5517.4 5683.3 5721.4 5843.6 5850.4 5853.7 5759.9 5783.5 5818.4 5818.4 5865.1 5402.6 5424.5 5432.8 5439.2 5441.6 5825.7 5894.6 5904.4 5931.7 5957.2 5713.9 5718.2 5718.8 5737.9 5741.3 5817.2 5824.5 5824.5 5829.2 5842.2 5508.4 5652.0 5680.1 5736.4 5778.8 5611.9 5714.9 5752.6 5758.4 5769.1 4389.1 4393.8 4395.8 4398.7 4429.0 3828.7 3856.4 3868.9 3899.7 3946.8 5435.0 5467.8 5477.8 5504.2 5520.8 5689.5 5713.7 5730.7 5734.7 5745.6 5425.7 5468.7 5472.6 5487.3 5493.9 4875.6 4880.2 4897.0 4898.8 4942.0 5937.5 5937.8 5938.6 5939.7 5951.6 5651.5 5740.0 5761.6 5773.9 5808.8 5930.0 5945.6 5961.6 5970.4 5998.8 5703.5 5705.8 5712.5 5722.1 5729.0 5622.0 5675.4 5724.5 5743.6 5773.1 5554.9 5592.7 5619.7 5640.2 5652.0 5508.4 5578.9 5595.4 5601.3 5607.9 5335.8 5416.4 5432.8 5437.1 5438.8 5499.5 5545.9 5561.5 5607.9 5656.7 5474.3 5488.2 5495.5 5506.6 5510.1 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#1] ext.html Cycles:180 Average:60088.54 Median:41947.08 stddev:118427.76 (282.3%) stddev-sans-first:118675.69 05:35:10 INFO - PROCESS | 15614 | Values: 576.0 607.9 615.8 633.9 647.7 40700.2 41578.4 42239.6 42385.6 43961.0 42533.8 42536.8 42808.1 42984.0 43177.4 8923.2 9014.1 9053.0 9069.8 9074.2 8878.4 8911.9 8947.4 8948.0 8973.1 8986.0 9001.0 9001.4 9006.8 9032.5 8838.9 8927.7 8976.3 8981.4 8990.0 8706.0 8769.5 8772.4 8790.3 8851.4 40693.8 40809.2 40884.8 40955.7 41218.6 3347.9 3370.1 3395.2 3422.6 3439.4 30002.1 31725.1 32415.7 32575.0 32612.0 4343.1 4386.6 4529.9 4588.5 4592.8 330375.0 330834.0 331374.0 331510.0 331845.3 59184.7 59711.0 60278.0 60330.0 60337.0 59060.4 59206.6 59659.7 59959.0 59983.0 14910.9 15758.0 15792.1 16163.7 16218.4 10465.1 10527.4 10542.6 10558.9 10586.0 18474.7 18651.4 18665.2 18894.4 19376.9 7053.2 7160.8 7268.0 7525.7 7527.3 1011.4 1034.5 1113.5 1139.5 1143.3 33002.2 33130.7 33279.4 33464.5 33646.7 1133.3 1140.8 1141.2 1163.9 1166.3 17008.1 17227.0 17295.9 17423.2 17500.0 525535.0 525702.0 532922.0 533200.0 533588.0 56871.1 58182.0 58556.7 58642.5 58666.7 1336.5 1340.5 1341.9 1347.6 1354.7 30838.5 32364.4 32424.8 32572.7 32803.5 48468.5 48560.0 48583.5 48690.0 48821.8 454712.0 454907.0 456131.0 456297.0 456589.0 27507.4 27733.2 28742.1 28847.6 30290.5 47977.5 48158.8 48163.3 48976.8 49205.0 41008.8 41101.8 41946.8 41997.0 42512.0 41377.6 41562.2 41671.2 41906.0 41947.4 40937.8 41306.8 41976.0 42492.4 44881.0 35330.0 38864.6 39087.4 39217.6 39590.2 28441.4 28660.0 28730.7 28851.4 28933.9 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#2] jquery.html Cycles:180 Average:29182.58 Median:2348.44 stddev:83023.86 (3535.3%) stddev-sans-first:83228.62 05:35:10 INFO - PROCESS | 15614 | Values: 388.9 389.4 389.8 391.6 407.5 14275.4 17851.2 19410.8 19414.9 19965.7 18150.7 18392.4 18507.2 18519.6 18527.2 5547.6 5573.4 5789.3 5807.2 5808.4 5598.6 5690.3 5693.2 5695.3 5695.6 5523.3 5615.7 5718.8 5718.9 5722.9 5468.0 5635.4 5672.1 5673.5 5699.4 5104.7 5108.6 5122.4 5143.8 5150.3 21199.9 21869.6 22143.6 22385.4 22453.0 2335.6 2361.3 2388.4 2990.5 3072.2 14057.4 14156.7 14224.2 14716.6 14811.1 1806.7 1856.0 1902.0 1969.4 1977.4 73374.6 76572.0 76969.0 77194.0 77829.6 9140.1 10139.4 10401.9 10609.3 10617.6 10622.3 11223.5 11240.2 14746.1 14760.5 5702.4 5907.1 6581.8 7472.8 7575.3 7401.0 7473.8 7491.7 7518.3 7699.3 3677.2 3686.3 3797.8 3872.1 3902.8 1857.2 1893.4 1900.6 1905.2 1919.8 922.8 977.8 1019.2 1026.9 1076.7 18065.9 18310.2 18515.4 18669.3 18745.5 1030.2 1048.5 1076.0 1117.1 1146.2 9987.8 10555.6 10572.7 10605.2 10610.5 487493.0 501761.0 504473.0 510269.0 512012.0 96421.0 98265.5 98601.0 99511.0 100256.0 981.8 1004.1 1010.1 1050.6 1058.3 17116.4 17194.9 17660.3 17679.6 17708.6 42280.4 42474.6 42575.8 43905.0 44264.1 53285.5 53968.7 56123.4 59050.4 60808.7 7816.3 7818.5 7887.1 7919.1 8092.3 12290.3 13128.9 13143.8 13286.8 13379.3 11474.7 11572.3 11832.1 11891.8 12023.6 9578.4 11629.5 11633.8 11786.4 12009.1 11736.1 11860.6 11977.7 12018.8 12479.4 7773.5 7777.5 7929.8 7962.6 8158.2 10112.3 10238.7 10794.5 11361.6 11834.2 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#3] mootools.html Cycles:180 Average:5704.52 Median:4327.46 stddev:3286.99 (76.0%) stddev-sans-first:3280.59 05:35:10 INFO - PROCESS | 15614 | Values: 1439.1 1466.7 1560.0 1710.0 1717.6 7647.1 8295.3 8484.2 8807.9 8810.2 8438.6 8680.4 8709.3 8751.8 8766.6 2161.3 2211.7 2216.1 2216.4 2221.2 2163.1 2192.6 2205.7 2217.6 2218.1 2155.5 2181.3 2184.5 2199.0 2205.4 2075.8 2089.7 2096.7 2097.3 2102.9 2032.0 2074.2 2077.3 2118.7 2121.4 8778.9 8794.5 8805.7 8841.4 8868.6 4820.5 4897.0 4947.2 4967.2 4976.3 3082.3 3174.7 3264.9 3283.8 3290.8 1061.9 1063.5 1071.5 1093.9 1119.4 11933.0 11963.7 12044.8 12050.2 12060.9 4176.8 4177.5 4206.0 4219.1 4231.3 10127.5 10143.4 10146.0 10159.7 10236.6 4796.4 4805.5 4827.7 4856.9 4858.4 4016.7 4423.6 4431.3 4458.2 4581.5 3737.4 3756.7 3775.9 3840.4 3865.8 1122.9 1149.1 1158.5 1171.9 1188.0 945.6 957.4 971.4 973.5 1002.0 5923.2 5958.7 6037.8 6115.5 6143.2 917.9 967.9 971.6 976.3 1004.0 4060.7 4146.6 4157.5 4158.5 4187.7 10444.8 10652.0 10669.7 10707.3 10835.3 10509.8 10579.7 10620.6 10627.8 10637.9 7737.6 7903.8 7945.6 8065.7 8179.6 5987.3 6037.1 6144.9 6185.7 6228.4 9695.1 9993.0 10114.3 10232.8 10240.7 10216.6 10268.9 10318.7 10330.1 10359.6 7006.3 7609.6 7649.3 7866.6 7890.3 8565.0 8603.6 8615.7 8633.7 8658.2 7689.2 7763.5 7876.3 7876.8 8011.3 7649.7 7686.5 7712.4 7810.1 7826.8 6783.7 6859.2 6889.6 6912.8 6914.9 5284.3 5342.8 5359.7 5452.1 5487.3 5369.9 5456.7 5509.7 5539.7 5578.7 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#4] prototype.html Cycles:180 Average:4873.97 Median:5490.16 stddev:1467.18 (26.7%) stddev-sans-first:1430.77 05:35:10 INFO - PROCESS | 15614 | Values: 311.8 314.3 317.9 328.6 332.3 5428.6 5530.7 5556.9 5584.4 5595.3 5505.0 5546.4 5561.9 5584.7 5593.4 4291.8 4295.5 4311.1 4330.5 4340.3 4101.7 4326.4 4335.6 4336.7 4347.3 4238.0 4253.5 4257.2 4258.6 4275.4 4249.0 4260.7 4276.4 4282.6 4291.8 3667.5 3735.5 3741.5 3754.7 3763.1 5395.0 5403.5 5406.3 5446.7 5475.3 4864.9 4897.9 4903.0 4920.4 4921.9 5612.2 5845.6 5880.2 5889.3 5920.0 4116.3 4149.2 4151.3 4153.3 4153.7 6110.0 6119.1 6120.2 6128.6 6146.3 3970.3 4218.6 4218.9 4219.2 4237.3 4251.6 4255.6 4265.7 4267.5 4274.2 4886.0 4913.9 4918.6 4939.6 4946.2 5329.6 5883.3 5922.4 5935.8 5939.7 1402.9 1412.1 1418.9 1419.5 1425.9 900.4 910.6 921.3 926.5 945.6 4995.0 5004.0 5015.0 5035.8 5037.8 5233.0 5285.1 5345.4 5357.6 5363.5 4969.0 4974.5 5007.2 5283.3 5787.7 3206.7 3233.0 3234.2 3262.9 3271.2 5976.3 6295.5 6297.5 6328.9 6338.2 6224.2 6239.3 6245.0 6255.0 6277.1 6165.7 6229.7 6230.8 6252.8 6279.3 5870.0 6062.9 6069.6 6074.3 6086.7 5844.9 5987.7 6005.5 6028.3 6045.9 5927.3 6183.8 6188.9 6202.7 6296.8 4077.1 4116.5 4137.9 4141.8 4182.5 5937.7 6015.0 6039.0 6060.4 6116.2 5873.2 5885.6 5910.4 5919.6 5928.3 5872.8 5877.8 5911.7 5964.3 5979.5 5632.5 5846.5 5862.6 5903.4 5904.1 5876.3 5910.0 5953.3 5969.2 5977.2 5701.7 5830.6 5843.4 5856.3 5865.0 05:35:10 INFO - PROCESS | 15614 | 05:35:10 INFO - PROCESS | 15614 | [#5] yui.html Cycles:180 Average:18589.65 Median:25357.23 stddev:25084.88 (98.9%) stddev-sans-first:25119.26 05:35:10 INFO - PROCESS | 15614 | Values: 694.1 763.4 785.1 789.6 800.6 13835.9 14345.9 14371.5 14457.3 16402.0 14770.0 15007.8 15046.8 15078.5 15143.2 662.6 782.3 807.6 818.5 822.0 797.9 807.6 812.2 815.9 817.9 837.7 845.0 847.3 851.7 854.0 837.6 844.9 845.5 846.6 846.8 616.5 617.3 617.4 619.0 619.6 14761.5 14965.9 15028.5 15061.1 15092.1 14062.5 14321.9 14357.5 14375.4 14560.8 11855.6 11995.8 12026.0 12037.7 12724.1 3827.3 3833.5 3999.6 4047.5 4053.1 75444.6 75891.2 76095.2 76112.0 77142.8 11275.2 11350.1 11591.7 11686.4 11868.9 21645.5 21764.3 21971.2 22051.1 22516.3 8455.4 8600.0 8605.2 8840.9 8992.1 4761.9 4872.3 4886.5 4889.9 4981.2 3457.3 3487.0 3548.3 3551.9 3569.2 590.7 598.2 601.6 603.2 619.1 670.8 682.5 735.7 747.5 749.6 9201.4 9493.7 9494.5 9507.3 9559.6 602.6 723.1 727.3 742.9 744.8 4548.5 4699.7 4701.0 4763.9 4782.1 67582.7 107424.0 111247.0 113167.4 115446.4 59735.4 61952.4 62048.4 62136.0 64106.7 56153.7 63673.0 74391.6 74424.3 76891.0 9926.6 10079.8 10215.8 10286.3 10471.7 38083.8 50143.5 53453.0 53920.7 54680.5 44960.0 46166.0 57571.0 75562.0 76772.6 12488.9 13226.1 13235.3 13349.8 13412.3 14056.0 14174.2 14271.2 14485.3 14673.3 13648.7 13957.0 14156.4 14865.0 14874.9 13842.8 14103.6 14139.4 14333.1 14537.9 13520.7 13546.7 13573.5 13608.3 13689.2 10431.9 10511.4 10741.6 10808.6 11512.7 11266.7 11626.5 11636.4 11733.2 11857.2 05:35:10 INFO - PROCESS | 15614 | -------- Summary: end -------- 05:35:10 INFO - PROCESS | 15614 | 05:35:11 INFO - TEST-INFO | 15614: exit 0 05:35:11 INFO - TEST-OK | dromaeo_css | took 1113476ms 05:35:11 INFO - TEST-START | kraken 05:35:11 INFO - operating with platform_type : linux_ 05:35:11 INFO - Initialising browser for kraken test... 05:35:11 INFO - TEST-INFO | started process 15853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahimQa/profile http://localhost:54500/getInfo.html) 05:35:17 INFO - PROCESS | 15853 | __metrics Screen width/height:1600/1200 05:35:17 INFO - PROCESS | 15853 | colorDepth:24 05:35:17 INFO - PROCESS | 15853 | Browser inner width/height: 1024/697 05:35:17 INFO - PROCESS | 15853 | __metrics 05:35:18 ERROR - PROCESS | 15853 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:35:19 INFO - TEST-INFO | 15853: exit 0 05:35:19 INFO - Browser initialized. 05:35:19 INFO - Running cycle 1/1 for kraken test... 05:35:19 INFO - TEST-INFO | started process 15969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahimQa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:31 INFO - PROCESS | 15969 | RSS: Main: 185376768 05:35:31 INFO - PROCESS | 15969 | 05:35:33 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:34 INFO - PROCESS | 15969 | RSS: Main: 191746048 05:35:34 INFO - PROCESS | 15969 | 05:35:37 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-dft) 05:35:37 INFO - PROCESS | 15969 | RSS: Main: 190316544 05:35:37 INFO - PROCESS | 15969 | 05:35:40 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-fft) 05:35:41 INFO - PROCESS | 15969 | RSS: Main: 185159680 05:35:41 INFO - PROCESS | 15969 | 05:35:43 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-oscillator) 05:35:44 INFO - PROCESS | 15969 | RSS: Main: 186019840 05:35:44 INFO - PROCESS | 15969 | 05:35:46 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:47 INFO - PROCESS | 15969 | RSS: Main: 186425344 05:35:47 INFO - PROCESS | 15969 | 05:35:50 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:50 INFO - PROCESS | 15969 | RSS: Main: 186822656 05:35:50 INFO - PROCESS | 15969 | 05:35:54 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:55 INFO - PROCESS | 15969 | RSS: Main: 183611392 05:35:55 INFO - PROCESS | 15969 | 05:35:57 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54500/tests/kraken/driver.html?testName=json-parse-financial) 05:35:58 INFO - PROCESS | 15969 | RSS: Main: 185446400 05:35:58 INFO - PROCESS | 15969 | 05:36:00 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:00 INFO - PROCESS | 15969 | RSS: Main: 186372096 05:36:00 INFO - PROCESS | 15969 | 05:36:02 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:03 INFO - PROCESS | 15969 | RSS: Main: 186650624 05:36:03 INFO - PROCESS | 15969 | 05:36:05 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:05 INFO - PROCESS | 15969 | RSS: Main: 186761216 05:36:05 INFO - PROCESS | 15969 | 05:36:08 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:09 INFO - PROCESS | 15969 | RSS: Main: 186900480 05:36:09 INFO - PROCESS | 15969 | 05:36:11 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:12 INFO - PROCESS | 15969 | RSS: Main: 186515456 05:36:12 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54500/tests/kraken/driver.html?testName=ai-astar) 05:36:14 INFO - PROCESS | 15969 | RSS: Main: 187240448 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | __start_tp_report 05:36:14 INFO - PROCESS | 15969 | _x_x_mozilla_page_load 05:36:14 INFO - PROCESS | 15969 | _x_x_mozilla_page_load_details 05:36:14 INFO - PROCESS | 15969 | |i|pagename|runs| 05:36:14 INFO - PROCESS | 15969 | |0;ai-astar;112;106;113;114;112;112;112;113;113;111 05:36:14 INFO - PROCESS | 15969 | |1;audio-beat-detection;161;125;160;177;126;152;159;127;184;126 05:36:14 INFO - PROCESS | 15969 | |2;audio-dft;162;162;161;162;165;174;164;166;163;163 05:36:14 INFO - PROCESS | 15969 | |3;audio-fft;76;76;76;160;78;77;75;78;174;73 05:36:14 INFO - PROCESS | 15969 | |4;audio-oscillator;85;86;146;85;85;88;140;85;85;139 05:36:14 INFO - PROCESS | 15969 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;118;118 05:36:14 INFO - PROCESS | 15969 | |6;imaging-darkroom;147;147;151;148;147;147;147;148;146;147 05:36:14 INFO - PROCESS | 15969 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;96 05:36:14 INFO - PROCESS | 15969 | |8;json-parse-financial;53;54;55;54;61;59;54;58;53;60 05:36:14 INFO - PROCESS | 15969 | |9;json-stringify-tinderbox;62;64;65;63;64;63;64;62;72;63 05:36:14 INFO - PROCESS | 15969 | |10;stanford-crypto-aes;83;86;81;81;82;81;89;81;110;80 05:36:14 INFO - PROCESS | 15969 | |11;stanford-crypto-ccm;127;133;122;123;123;131;121;124;136;133 05:36:14 INFO - PROCESS | 15969 | |12;stanford-crypto-pbkdf2;161;162;166;160;167;161;167;161;160;166 05:36:14 INFO - PROCESS | 15969 | |13;stanford-crypto-sha256-iterative;74;64;66;70;65;62;66;71;63;68 05:36:14 INFO - PROCESS | 15969 | __end_tp_report 05:36:14 INFO - PROCESS | 15969 | __start_cc_report 05:36:14 INFO - PROCESS | 15969 | _x_x_mozilla_cycle_collect,885 05:36:14 INFO - PROCESS | 15969 | __end_cc_report 05:36:14 INFO - PROCESS | 15969 | __startTimestamp1465648574478__endTimestamp 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | ------- Summary: start ------- 05:36:14 INFO - PROCESS | 15969 | Number of tests: 14 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:2.20 (2.0%) stddev-sans-first:2.33 05:36:14 INFO - PROCESS | 15969 | Values: 112.0 106.0 113.0 114.0 112.0 112.0 112.0 113.0 113.0 111.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:159.50 stddev:22.35 (14.0%) stddev-sans-first:23.33 05:36:14 INFO - PROCESS | 15969 | Values: 161.0 125.0 160.0 177.0 126.0 152.0 159.0 127.0 184.0 126.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.77 (2.3%) stddev-sans-first:3.91 05:36:14 INFO - PROCESS | 15969 | Values: 162.0 162.0 161.0 162.0 165.0 174.0 164.0 166.0 163.0 163.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.49 (50.6%) stddev-sans-first:40.25 05:36:14 INFO - PROCESS | 15969 | Values: 76.0 76.0 76.0 160.0 78.0 77.0 75.0 78.0 174.0 73.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.00 stddev:27.17 (32.0%) stddev-sans-first:28.08 05:36:14 INFO - PROCESS | 15969 | Values: 85.0 86.0 146.0 85.0 85.0 88.0 140.0 85.0 85.0 139.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:36:14 INFO - PROCESS | 15969 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 05:36:14 INFO - PROCESS | 15969 | Values: 147.0 147.0 151.0 148.0 147.0 147.0 147.0 148.0 146.0 147.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:36:14 INFO - PROCESS | 15969 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:3.07 (5.4%) stddev-sans-first:3.05 05:36:14 INFO - PROCESS | 15969 | Values: 53.0 54.0 55.0 54.0 61.0 59.0 54.0 58.0 53.0 60.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:2.90 (4.5%) stddev-sans-first:2.96 05:36:14 INFO - PROCESS | 15969 | Values: 62.0 64.0 65.0 63.0 64.0 63.0 64.0 62.0 72.0 63.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:81.50 stddev:9.08 (11.1%) stddev-sans-first:9.59 05:36:14 INFO - PROCESS | 15969 | Values: 83.0 86.0 81.0 81.0 82.0 81.0 89.0 81.0 110.0 80.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:129.00 stddev:5.48 (4.2%) stddev-sans-first:5.81 05:36:14 INFO - PROCESS | 15969 | Values: 127.0 133.0 122.0 123.0 123.0 131.0 121.0 124.0 136.0 133.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:3.00 (1.8%) stddev-sans-first:3.08 05:36:14 INFO - PROCESS | 15969 | Values: 161.0 162.0 166.0 160.0 167.0 161.0 167.0 161.0 160.0 166.0 05:36:14 INFO - PROCESS | 15969 | 05:36:14 INFO - PROCESS | 15969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:3.81 (5.7%) stddev-sans-first:3.06 05:36:14 INFO - PROCESS | 15969 | Values: 74.0 64.0 66.0 70.0 65.0 62.0 66.0 71.0 63.0 68.0 05:36:14 INFO - PROCESS | 15969 | -------- Summary: end -------- 05:36:14 INFO - PROCESS | 15969 | 05:36:15 INFO - TEST-INFO | 15969: exit 0 05:36:15 INFO - TEST-OK | kraken | took 64263ms 05:36:15 INFO - SUITE-END | took 1177s 05:36:15 INFO - Completed test suite (00:19:37) 05:36:15 INFO - javascript benchmark 05:36:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.2699589960175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.0, 3108.0, 3132.530120481928, 3137.513685378766, 3144.3868445653106, 5307.495787900153, 5346.866328341794, 5386.245925570418, 5416.729163541827, 5422.674639521631, 5203.427622961472, 5335.573154147669, 5349.0, 5351.946480535194, 5437.891242175154, 4778.68938518996, 4797.7121372717575, 4893.877653058684, 4981.651284410093, 4996.0, 826.6782890992724, 4809.254565542346, 4933.284673722326, 4946.629002824785, 4946.653734238605, 4885.755712214411, 4886.071646387193, 4893.8531844044555, 4925.75371231437, 4959.752012399365, 4855.975720121377, 4910.0, 4913.361263035782, 4940.925886111711, 4980.128477516457, 4829.589484893788, 4852.708837469728, 4864.5621894029355, 4866.270059491105, 4874.731889746098, 5365.7853685852515, 5417.214503896952, 5441.455854414567, 5476.096444086721, 5517.393086760453, 5683.346415162227, 5721.427857214287, 5843.590948633598, 5850.3564607893095, 5853.736581853785, 5759.856003599902, 5783.537317014629, 5818.389069147764, 5818.44724751148, 5865.120231965197, 5402.648827826218, 5424.484673955928, 5432.809851655252, 5439.156930675752, 5441.619086663935, 5825.679587622637, 5894.616849904743, 5904.409559044061, 5931.703414829241, 5957.165996760457, 5713.885722285614, 5718.228039214653, 5718.828435146952, 5737.913931291034, 5741.282339707536, 5817.243758311392, 5824.475797178275, 5824.534037277008, 5829.183914252008, 5842.152887831241, 5508.421615730371, 5652.0391533439415, 5680.091185410314, 5736.368999410061, 5778.8266352009505, 5611.915821262684, 5714.857128571736, 5752.597318187771, 5758.395368486333, 5769.105788602773, 4389.100234451929, 4393.780310984438, 4395.802188901507, 4398.73607583546, 4429.047754732748, 3828.693704503633, 3856.402257650069, 3868.903277418031, 3899.707521935866, 3946.8223929923224, 5435.0, 5467.835964920979, 5477.808276710296, 5504.2018907258225, 5520.779168833282, 5689.516391106802, 5713.74288157034, 5730.656160630376, 5734.713264336767, 5745.569082318759, 5425.697832520245, 5468.699221542854, 5472.644278121909, 5487.314085739283, 5493.862653433616, 4875.561199492063, 4880.194767863334, 4896.95103048972, 4898.804047838118, 4942.0, 5937.465628093492, 5937.792177273861, 5938.554608404387, 5939.70301484924, 5951.583389162717, 5651.463111004448, 5740.0, 5761.596688231783, 5773.91339129905, 5808.825735227865, 5929.970350148222, 5945.554083443845, 5961.582689211714, 5970.432808883149, 5998.760049597967, 5703.486686198262, 5705.771769129355, 5712.514436272963, 5722.055860782924, 5729.026065568946, 5622.0, 5675.375708672125, 5724.4561766632105, 5743.597948143757, 5773.134029895549, 5554.91667624994, 5592.69240191777, 5619.662820230636, 5640.182173584725, 5652.039153343859, 5508.366537848199, 5578.888422231614, 5595.384507704068, 5601.29983752031, 5607.859803504945, 5335.839924802262, 5416.377116631637, 5432.7555260012605, 5437.13005919051, 5438.809641662523, 5499.4775496329385, 5545.944540554704, 5561.527270181918, 5607.943920560742, 5656.660600363992, 5474.288342515448, 5488.231647569263, 5495.505404513453, 5506.559475242051, 5510.0632892409185], "value": 5269.938511489835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9712014399281, 607.8662694207272, 615.7690865925277, 633.8573820890304, 647.6664517773347, 40700.18599628006, 41578.37632435516, 42239.577604223945, 42385.57614423855, 43961.0, 42533.7873310633, 42536.787316063375, 42808.143837123316, 42984.0, 43177.35233971493, 8923.19691227791, 9014.14365635267, 9053.0, 9069.818603627957, 9074.228690561311, 8878.42290251135, 8911.866322005142, 8947.373683842101, 8948.015718270985, 8973.10268973104, 8985.955070224672, 9001.009888912215, 9001.414908030989, 9006.819863602757, 9032.548372581345, 8838.911610883873, 8927.687530936419, 8976.326775491832, 8981.416207946528, 8989.95505022474, 8705.956470217672, 8769.517676527788, 8772.385932984693, 8790.252828509585, 8851.424657397312, 40693.79653101716, 40809.183816323806, 40884.795576022225, 40955.69965153646, 41218.587814122075, 3347.8807311304486, 3370.140614143402, 3395.2021275000357, 3422.640622734602, 3439.4235248639616, 30002.099937001924, 31725.11575795434, 32415.6758432415, 32575.0, 32612.0, 4343.109662519176, 4386.605205531486, 4529.886752831173, 4588.541145885418, 4592.816287348502, 330375.0, 330834.0, 331374.0, 331510.0, 331845.340773297, 59184.70407647934, 59711.0, 60278.0, 60330.0, 60337.0, 59060.409395906354, 59206.63173473099, 59659.70170149121, 59959.0, 59983.0, 14910.925445372704, 15758.0, 15792.052476851426, 16163.676726465404, 16218.432354867758, 10465.058144767008, 10527.420991845369, 10542.631007914839, 10558.947205264078, 10586.0, 18474.722879156823, 18651.440456786317, 18665.16006779671, 18894.449249351437, 19376.903115484612, 7053.153621565342, 7160.785176444715, 7267.963660181771, 7525.736599219001, 7527.322540971339, 1011.367895065584, 1034.5086084110137, 1113.5412609481605, 1139.5270962550615, 1143.2854465958776, 33002.17494562655, 33130.66869331324, 33279.36031984008, 33464.49803252953, 33646.663533364845, 1133.2690414682647, 1140.7547377313917, 1141.1612464838338, 1163.8545181852269, 1166.2943918928927, 17008.149592520323, 17227.0, 17295.91352043257, 17423.21595528204, 17500.0, 525535.0, 525702.0, 532922.0, 533200.0, 533588.0, 56871.146932796044, 58182.0, 58556.70721646365, 58642.533936651926, 58666.706666467246, 1336.5054929675887, 1340.477213886585, 1341.8859396951173, 1347.5957212836306, 1354.6681063139595, 30838.53742193824, 32364.35271294514, 32424.837875811412, 32572.674273256966, 32803.50794738129, 48468.5153148464, 48560.0, 48583.51416485931, 48690.0, 48821.75589122032, 454712.0, 454907.0, 456131.0, 456297.0, 456589.0, 27507.449851003268, 27733.168004959884, 28742.137735867957, 28847.56728649114, 30290.545641814948, 47977.5202247987, 48158.75920620515, 48163.277550836065, 48976.755116224194, 49205.0, 41008.79495602622, 41101.79449102735, 41946.7902660497, 41997.0, 42512.0, 41377.586224137376, 41562.1687566253, 41671.16657666769, 41906.0, 41947.37078943757, 40937.795311023256, 41306.793466032475, 41976.0, 42492.362614561425, 44881.0, 35330.0, 38864.61135388723, 39087.41368879412, 39217.60782392254, 39590.208195835345, 28441.43117137687, 28660.0, 28730.71269287364, 28851.422971540873, 28933.85533072321], "value": 20099.28853194985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8775035863704, 389.36727817296895, 389.8128898128898, 391.63969148383484, 407.5069166308766, 14275.357608907598, 17851.196696148672, 19410.805891941094, 19414.90292548537, 19965.700514492295, 18150.72773908389, 18392.44822655319, 18507.16717747701, 18519.62960740788, 18527.16627751751, 5547.583931205156, 5573.4147914469, 5789.334226563957, 5807.2450581424355, 5808.448197421239, 5598.58010649203, 5690.2887139107615, 5693.231413759131, 5695.316562012565, 5695.629784064023, 5523.309586301712, 5615.736459296646, 5718.771249150029, 5718.885622287552, 5722.856928576777, 5468.0, 5635.408282130399, 5672.149177623369, 5673.546116310706, 5699.430056994309, 5104.668196567211, 5108.64239503235, 5122.436531981479, 5143.8456846294675, 5150.330457040598, 21199.894000530054, 21869.562608747896, 22143.557128857334, 22385.440363990867, 22453.0, 2335.6029474989123, 2361.2798096580536, 2388.4148383645943, 2990.4916164251913, 3072.2319420144963, 14057.367418466194, 14156.716865662733, 14224.217668028254, 14716.632084197874, 14811.111333319928, 1806.692862213427, 1855.9628807423776, 1901.9714704279447, 1969.350114462224, 1977.3968939473455, 73374.63312683455, 76572.0, 76969.0, 77194.0, 77829.61085194538, 9140.131687489678, 10139.391636501834, 10401.895981040245, 10609.310394824312, 10617.55796166886, 10622.309549879234, 11223.494942727597, 11240.156988225915, 14746.11523308605, 14760.48338308154, 5702.429757024264, 5907.084401917709, 6581.835454113685, 7472.775816725398, 7575.280348366897, 7401.0, 7473.813154671068, 7491.737789177353, 7518.28576285252, 7699.345555627834, 3677.1542545214215, 3686.336459437327, 3797.7531460454984, 3872.0707030312524, 3902.7658340499092, 1857.1735577668078, 1893.403577872993, 1900.5723712164652, 1905.1712505060343, 1919.7504324438014, 922.7877588154762, 977.8044391121662, 1019.1795604538418, 1026.9127124194526, 1076.6769969009265, 18065.909670451827, 18310.176042077874, 18515.35196268124, 18669.253229870654, 18745.531361716065, 1030.217035053365, 1048.5386429970788, 1075.978480430387, 1117.0672488472217, 1146.2262972493534, 9987.800243995225, 10555.577776888838, 10572.735681607868, 10605.204609654307, 10610.469476526298, 487493.0, 501761.0, 504473.0, 510269.0, 512012.0, 96421.0, 98265.50867245761, 98601.0, 99511.0, 100256.0, 981.8134554434635, 1004.1314263162458, 1010.0959641121156, 1050.5587653185528, 1058.275081569143, 17116.400925967533, 17194.914025430295, 17660.32226938439, 17679.646407072043, 17708.557286067953, 42280.365794513724, 42474.575254248295, 42575.7871210642, 43905.0, 44264.12283201582, 53285.4671453296, 53968.73015634897, 56123.43876561182, 59050.40949590449, 60808.695956521704, 7816.257455541714, 7818.452708310591, 7887.132415434183, 7919.12889582134, 8092.271695547429, 12290.262584244974, 13128.934355328161, 13143.802842957171, 13286.80069798973, 13379.264140472367, 11474.655760327203, 11572.305661660328, 11832.112591555495, 11891.762164756483, 12023.63929082129, 9578.377405468622, 11629.534818607499, 11633.767324653629, 11786.410679466164, 12009.099317551394, 11736.119791015537, 11860.584879529175, 11977.700557486132, 12018.75962480763, 12479.438425270702, 7773.533587984739, 7777.500124943911, 7929.801754955942, 7962.562059086806, 8158.184181582032, 10112.342697724624, 10238.692839214835, 10794.460276985963, 11361.602343917923, 11834.171607987702], "value": 9026.573443157999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.0574173916086, 1466.691994681117, 1560.0, 1709.9914500427496, 1717.6049508613012, 7647.082350117979, 8295.294899933499, 8484.19400156985, 8807.91192088079, 8810.16303451172, 8438.620262088205, 8680.435771674836, 8709.346798990086, 8751.824963500727, 8766.649334026632, 2161.319184456895, 2211.6903633491324, 2216.091402524965, 2216.445888527868, 2221.2114699281765, 2163.145557504785, 2192.6382146945734, 2205.658122990939, 2217.623004089309, 2218.134927378324, 2155.5365596396773, 2181.291080398869, 2184.4866456382815, 2199.0, 2205.426589086841, 2075.802798734118, 2089.6969939358783, 2096.716943212662, 2097.328854766475, 2102.8738275703354, 2032.034783477851, 2074.201432448518, 2077.2937201351615, 2118.650422680256, 2121.448423409909, 8778.868316975251, 8794.472331660121, 8805.735827925173, 8841.38110332277, 8868.556572171366, 4820.542048505386, 4896.975515122402, 4947.158982972904, 4967.205247160437, 4976.328195693572, 3082.2910730532103, 3174.7301479374282, 3264.9183770405693, 3283.7865538739907, 3290.802551846873, 1061.936283822973, 1063.500154927183, 1071.5071067309048, 1093.8960798724108, 1119.3899324867884, 11933.0, 11963.700907477296, 12044.81932771009, 12050.216735912225, 12060.939695301555, 4176.83292668296, 4177.540470548237, 4205.9789701051295, 4219.135077309144, 4231.344141658048, 10127.544260508295, 10143.442110683984, 10145.985401459795, 10159.695209143738, 10236.590536378462, 4796.352492413549, 4805.519448055166, 4827.734474603931, 4856.902861942742, 4858.416989961227, 4016.6585840203325, 4423.579759922803, 4431.268840641323, 4458.152950939311, 4581.450225972904, 3737.4206997915367, 3756.6619004289746, 3775.86784462548, 3840.3663395539984, 3865.8453661853773, 1122.9045531129782, 1149.0692539043403, 1158.472894832849, 1171.9062475001979, 1187.9703007424885, 945.5555888732284, 957.4446820843893, 971.4317124482257, 973.454865275448, 1002.0, 5923.229980102559, 5958.6722730249385, 6037.758489660452, 6115.480184184395, 6143.1706719592285, 917.8898532176181, 967.8790151231096, 971.6404930175739, 976.2873102635116, 1003.9598416063276, 4060.7360521566, 4146.564610715892, 4157.459530261047, 4158.521769996429, 4187.748735075906, 10444.843327350096, 10652.0, 10669.733256668645, 10707.250492465453, 10835.349879007284, 10509.789804203872, 10579.682609521727, 10620.575176992988, 10627.84058239127, 10637.893621063846, 7737.574433406104, 7903.762887113396, 7945.562994035384, 8065.677372905136, 8179.631916563888, 5987.34139244674, 6037.094435834484, 6144.8771024580155, 6185.6907154641185, 6228.439440450381, 9695.127438530566, 9993.0, 10114.29199955996, 10232.795344093225, 10240.692779216635, 10216.59133634676, 10268.948655256676, 10318.690439286833, 10330.070293673605, 10359.63741269052, 7006.334398232159, 7609.619519023916, 7649.349805266392, 7866.646000930086, 7890.250426209501, 8565.0, 8603.569821509025, 8615.741527754177, 8633.740987770378, 8658.220760131619, 7689.192634773492, 7763.456558040883, 7876.251756083163, 7876.803079923047, 8011.3190378816125, 7649.694012239448, 7686.500377475446, 7712.421568382281, 7810.140884502814, 7826.843463130592, 6783.660816959034, 6859.211190712932, 6889.586624802528, 6912.758053468105, 6914.9308506914285, 5284.260203571426, 5342.813001544927, 5359.651622644516, 5452.127659574608, 5487.341519017744, 5369.919451208313, 5456.672599644034, 5509.669419834822, 5539.723013849372, 5578.721063946705], "value": 4529.831971563006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.79421581756037, 314.3367494586424, 317.8712621388338, 328.625367081527, 332.28227029616016, 5428.61999660024, 5530.723463826813, 5556.9444305556935, 5584.4136365681625, 5595.272614560102, 5504.972475137629, 5546.362168350641, 5561.944380556193, 5584.692841893694, 5593.356763972144, 4291.828326866929, 4295.463067116611, 4311.073119279355, 4330.501992270898, 4340.327249276352, 4101.733387329829, 4326.437563116806, 4335.5881191286935, 4336.674749393792, 4347.3261644445165, 4237.957620423787, 4253.532111467736, 4257.212415703089, 4258.6380157686635, 4275.358696195564, 4248.978755106235, 4260.723053001545, 4276.358546218061, 4282.571742825692, 4291.828326866922, 3667.504886840296, 3735.514383130203, 3741.5136032315895, 3754.6808521275725, 3763.1184407796104, 5395.0, 5403.540699040586, 5406.324209473816, 5446.673199608036, 5475.342958844924, 4864.854054378375, 4897.926531102036, 4902.950970490285, 4920.384951881015, 4921.901561968776, 5612.214289999403, 5845.649261044351, 5880.235569375996, 5889.322727886305, 5920.0, 4116.341385378325, 4149.170165966819, 4151.3150330195485, 4153.314703074019, 4153.6677065834665, 6109.969450152721, 6119.082137679339, 6120.1737765401995, 6128.571000030044, 6146.323904370515, 3970.285348637273, 4218.620324170839, 4218.915621687549, 4219.240536703423, 4237.25847976609, 4251.59609837065, 4255.5957184067465, 4265.722728022669, 4267.487901451846, 4274.2092712848225, 4885.951140488621, 4913.852584422473, 4918.5981995131215, 4939.580135688435, 4946.183879659816, 5329.600279978939, 5883.294004719461, 5922.407759224129, 5935.812837432531, 5939.673317967467, 1402.901796874209, 1412.1103704665995, 1418.9216195691142, 1419.5457453614745, 1425.9287035648176, 900.4102312985005, 910.6175406329226, 921.2721949659827, 926.536731634183, 945.6217512994857, 4994.950050499521, 5004.047611908991, 5015.01906746833, 5035.82374616894, 5037.800996367333, 5232.953409318152, 5285.119609812585, 5345.358556973188, 5357.598180136505, 5363.490468405495, 4968.975155124273, 4974.502549744997, 5007.248912663057, 5283.260343551906, 5787.7395517200985, 3206.695363940422, 3232.951505727416, 3234.175285302233, 3262.8531716072835, 3271.247613049012, 5976.252968378953, 6295.496360291166, 6297.4962003039645, 6328.873422531616, 6338.161933039367, 6224.190855188796, 6239.251289845157, 6244.968775156095, 6254.9687251563455, 6277.112528236971, 6165.691715414211, 6229.688515574294, 6230.813075607648, 6252.812415627538, 6279.277883043417, 5869.970650146722, 6062.878742425215, 6069.575129740876, 6074.3318234994995, 6086.7260973255425, 5844.947909376353, 5987.700614969322, 6005.549583781147, 6028.306744724237, 6045.909311360421, 5927.2590926134235, 6183.752649893954, 6188.938110619017, 6202.689865506797, 6296.84257893538, 4077.06227567667, 4116.5060192777055, 4137.8965525862095, 4141.7722025288895, 4182.477190351206, 5937.6843031216995, 6015.0, 6039.0, 6060.393960603904, 6116.217121209927, 5873.177755114202, 5885.646861188342, 5910.438508341701, 5919.6152250103605, 5928.288605367384, 5872.823815285548, 5877.823665289877, 5911.728978269693, 5964.284285885721, 5979.4618484336615, 5632.493075623213, 5846.473817356458, 5862.618929769551, 5903.409659034062, 5904.143899134516, 5876.324222714272, 5910.049683604486, 5953.315368732651, 5969.194158788681, 5977.193078934288, 5701.686407247641, 5830.62100963436, 5843.386444423274, 5856.297244330707, 5865.0], "value": 4393.670105636196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.1080711285996, 763.435058057038, 785.1089013969145, 789.6091434739805, 800.5516910530101, 13835.861641383595, 14345.856541434583, 14371.496997605085, 14457.277136143177, 16402.0, 14770.0, 15007.774883376758, 15046.774298385533, 15078.54764357071, 15143.167125808104, 662.6123717625195, 782.2724865874762, 807.555844285642, 818.4557269415832, 822.042320696388, 797.8922845415882, 807.6325272001226, 812.175641723651, 815.9347252219837, 817.9386546009043, 837.7486753973814, 844.9831003379928, 847.3094428041157, 851.7189327521934, 853.9829203415928, 837.6356285016037, 844.936629752771, 845.5222799118478, 846.551327796269, 846.7840700621364, 616.488314698799, 617.3147805935408, 617.3517806303408, 619.0281258424276, 619.5879739972912, 14761.483348082766, 14965.92517037408, 15028.474003409938, 15061.096334219872, 15092.094474331576, 14062.507812226626, 14321.928390358085, 14357.497487587885, 14375.424983000667, 14560.781588276184, 11855.644330670093, 11995.820062699066, 12026.0, 12037.699057523545, 12724.109312348139, 3827.2728181645675, 3833.463315135883, 3999.6400323970984, 4047.534533528623, 4053.148838743867, 75444.62277688576, 75891.24108758898, 76095.23904760992, 76112.0, 77142.84285735774, 11275.154363422776, 11350.09199264057, 11591.710207244887, 11686.357250351311, 11868.88131118695, 21645.458863528536, 21764.347069587937, 21971.231006915, 22051.11795528161, 22516.32451026472, 8455.408121431441, 8600.0109987351, 8605.225529702357, 8840.911590884009, 8992.121435472418, 4761.928571071437, 4872.317875497433, 4886.511348865156, 4889.902201955941, 4981.153203955337, 3457.3258214648404, 3487.0, 3548.3435564420665, 3551.911202219965, 3569.161247106928, 590.6574186971546, 598.1984141250745, 601.6330038676404, 603.1977469964936, 619.102301662591, 670.808819486444, 682.5017737051979, 735.724103461202, 747.4618274842105, 749.5952185819706, 9201.447913125234, 9493.715188544216, 9494.477803720862, 9507.33448658601, 9559.569819358145, 602.6293829294953, 723.1358526560709, 727.294524311417, 742.858856817203, 744.7691215723144, 4548.454185497695, 4699.718016918996, 4700.976495117503, 4763.928541071887, 4782.139214941274, 67582.66208669024, 107424.0, 111247.0, 113167.43416283031, 115446.42276788563, 59735.40264597299, 61952.38047619556, 62048.37951620516, 62136.0, 64106.6794666033, 56153.7192314044, 63673.0, 74391.62804185944, 74424.25575744173, 76891.0, 9926.553305101143, 10079.848802268118, 10215.795684086424, 10286.279960402999, 10471.738206544896, 38083.809580951915, 50143.498565013884, 53453.0, 53920.73039634777, 54680.45319546753, 44960.0, 46166.0, 57571.0, 75562.0, 76772.61613691896, 12488.875111249135, 13226.140300880412, 13235.338233088114, 13349.799753003907, 13412.262325572186, 14056.0, 14174.165166966854, 14271.215083170526, 14485.275736212936, 14673.339699713752, 13648.65878353049, 13957.0, 14156.362963666454, 14865.033772805165, 14874.925625371803, 13842.792358114837, 14103.647408814863, 14139.434422623392, 14333.140011599337, 14537.92731036338, 13520.661983450493, 13546.661333466742, 13573.457061717421, 13608.319584020957, 13689.247091410069, 10431.94784026075, 10511.421871797125, 10741.570337186426, 10808.567657293936, 11512.712182195512, 11266.718332041764, 11626.53493860236, 11636.360000199731, 11733.237339572901, 11857.229280096766], "value": 7370.947318884711, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 113.0, 114.0, 112.0, 112.0, 112.0, 113.0, 113.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 160.0, 177.0, 126.0, 152.0, 159.0, 127.0, 184.0, 126.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 165.0, 174.0, 164.0, 166.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 160.0, 78.0, 77.0, 75.0, 78.0, 174.0, 73.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 146.0, 85.0, 85.0, 88.0, 140.0, 85.0, 85.0, 139.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 61.0, 59.0, 54.0, 58.0, 53.0, 60.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 65.0, 63.0, 64.0, 63.0, 64.0, 62.0, 72.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 81.0, 81.0, 82.0, 81.0, 89.0, 81.0, 110.0, 80.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 133.0, 122.0, 123.0, 123.0, 131.0, 121.0, 124.0, 136.0, 133.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 166.0, 160.0, 167.0, 161.0, 167.0, 161.0, 160.0, 166.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 64.0, 66.0, 70.0, 65.0, 62.0, 66.0, 71.0, 63.0, 68.0], "value": 66.9, "unit": "score"}]}]} 05:36:15 INFO - Return code: 0 05:36:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:15 ERROR - # TBPL SUCCESS # 05:36:15 INFO - Running post-action listener: _resource_record_post_action 05:36:15 INFO - ##### 05:36:15 INFO - ##### Finished run-tests step (success) 05:36:15 INFO - ##### 05:36:15 INFO - Running post-run listener: _resource_record_post_run 05:36:15 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 4096; Write bytes: 558886912; Read time: 12; Write time: 981756 05:36:15 INFO - TinderboxPrint: CPU usage
13.6% 05:36:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:36:15 INFO - TinderboxPrint: I/O write bytes / time
558,886,912 / 981,756 05:36:15 INFO - TinderboxPrint: CPU idle
8,246.1 (86.4%) 05:36:15 INFO - TinderboxPrint: CPU user
1,225.6 (12.8%) 05:36:15 INFO - TinderboxPrint: Swap in / out
0 / 0 05:36:15 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 211767296; Read time: 0; Write time: 586824 05:36:15 INFO - run-tests - Wall time: 1179s; CPU: 14.0%; Read bytes: 4096; Write bytes: 296706048; Read time: 12; Write time: 369728 05:36:16 INFO - Running post-run listener: _upload_blobber_files 05:36:16 INFO - Blob upload gear active. 05:36:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:16 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 05:36:16 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'] 05:36:16 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 05:36:16 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:17 INFO - (blobuploader) - INFO - Done attempting. 05:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:18 INFO - (blobuploader) - INFO - Done attempting. 05:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:22 INFO - (blobuploader) - INFO - Done attempting. 05:36:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:22 INFO - Return code: 0 05:36:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0874883ad2d78e98adb0e9b6a4d7f13d0b3df0a7e699edd5795a7f8478e0d798551bc2311c1467293055d2703b45d51c5084cadafc1a591291384e2b45b80fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4858974229cb6e4fa944e6d736b26db7dfec53ff44d2601a7a179ccd4d376171ed15d71fceff23f97177162a4ee1eca7dc5d8d87b4cbb55f8919be872a081ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15afdd679bd8617069bfdc9b000ca59779e2597b64789c52c1edfb793a082addb402d3e5e7d6113ef626793a7c02d35650dc518e761ced96ea3946e53656c7e5"} 05:36:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:22 INFO - Contents: 05:36:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0874883ad2d78e98adb0e9b6a4d7f13d0b3df0a7e699edd5795a7f8478e0d798551bc2311c1467293055d2703b45d51c5084cadafc1a591291384e2b45b80fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4858974229cb6e4fa944e6d736b26db7dfec53ff44d2601a7a179ccd4d376171ed15d71fceff23f97177162a4ee1eca7dc5d8d87b4cbb55f8919be872a081ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15afdd679bd8617069bfdc9b000ca59779e2597b64789c52c1edfb793a082addb402d3e5e7d6113ef626793a7c02d35650dc518e761ced96ea3946e53656c7e5"} 05:36:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:22 INFO - Copying logs to upload dir... 05:36:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.546451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-11 05:36:21.462017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 05:36:21.465954) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0874883ad2d78e98adb0e9b6a4d7f13d0b3df0a7e699edd5795a7f8478e0d798551bc2311c1467293055d2703b45d51c5084cadafc1a591291384e2b45b80fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4858974229cb6e4fa944e6d736b26db7dfec53ff44d2601a7a179ccd4d376171ed15d71fceff23f97177162a4ee1eca7dc5d8d87b4cbb55f8919be872a081ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15afdd679bd8617069bfdc9b000ca59779e2597b64789c52c1edfb793a082addb402d3e5e7d6113ef626793a7c02d35650dc518e761ced96ea3946e53656c7e5"} build_url:https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/SCGZxjF1TlOmibT9CXdxKw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0874883ad2d78e98adb0e9b6a4d7f13d0b3df0a7e699edd5795a7f8478e0d798551bc2311c1467293055d2703b45d51c5084cadafc1a591291384e2b45b80fb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4858974229cb6e4fa944e6d736b26db7dfec53ff44d2601a7a179ccd4d376171ed15d71fceff23f97177162a4ee1eca7dc5d8d87b4cbb55f8919be872a081ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15afdd679bd8617069bfdc9b000ca59779e2597b64789c52c1edfb793a082addb402d3e5e7d6113ef626793a7c02d35650dc518e761ced96ea3946e53656c7e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-11 05:36:21.492366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:36:21.492746) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465641682.182470-2093617699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-11 05:36:21.577635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 05:36:21.577983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-11 05:36:21.578295) ========= ========= Total master_lag: 0.17 =========