builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1464966671.94 results: success (0) buildid: 20160603053007 builduid: 7cb7edd069bb4d71b98cd12dd7c2799a revision: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:11.940911) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:11.941358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:11.941656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:11.956289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:11.956566) ========= 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=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 08:11:11-- 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% 46.3M=0s 2016-06-03 08:11:12 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069767 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:12.040243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:12.040613) ========= 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=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020145 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:12.090473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 08:11:12.090876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 --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 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 --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=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 08:11:12,156 truncating revision to first 12 chars 2016-06-03 08:11:12,156 Setting DEBUG logging. 2016-06-03 08:11:12,156 attempt 1/10 2016-06-03 08:11:12,156 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ef7cc6b42c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 08:11:13,424 unpacking tar archive at: fx-team-0ef7cc6b42c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614097 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 08:11:13.736111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:13.736855) ========= script_repo_revision: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:13.737729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:13.738353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 08:11:13.755534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-03 08:11:13.755949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:13 INFO - MultiFileLogger online at 20160603 08:11:13 in /builds/slave/test 08:11:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:11:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:13 INFO - {'append_to_log': False, 08:11:13 INFO - 'base_work_dir': '/builds/slave/test', 08:11:13 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:13 INFO - 'branch': 'Fx-Team', 08:11:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:13 INFO - 'config_files': ('talos/linux_config.py',), 08:11:13 INFO - 'default_actions': ('clobber', 08:11:13 INFO - 'read-buildbot-config', 08:11:13 INFO - 'download-and-extract', 08:11:13 INFO - 'populate-webroot', 08:11:13 INFO - 'create-virtualenv', 08:11:13 INFO - 'install', 08:11:13 INFO - 'run-tests'), 08:11:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:13 INFO - 'download_minidump_stackwalk': True, 08:11:13 INFO - 'download_symbols': 'ondemand', 08:11:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:13 INFO - 'installer_path': 'installer.exe', 08:11:13 INFO - 'log_level': 'info', 08:11:13 INFO - 'log_name': 'talos', 08:11:13 INFO - 'log_to_console': True, 08:11:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:13 INFO - 'opt_config_files': (), 08:11:13 INFO - 'pip_index': False, 08:11:13 INFO - 'sps_profile': False, 08:11:13 INFO - 'sps_profile_interval': 0, 08:11:13 INFO - 'suite': 'dromaeojs', 08:11:13 INFO - 'system_bits': '32', 08:11:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:13 INFO - 'title': 'talos-linux64-ix-050', 08:11:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:13 INFO - 'use_talos_json': True, 08:11:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:13 INFO - 'work_dir': 'build'} 08:11:13 INFO - ##### 08:11:13 INFO - ##### Running clobber step. 08:11:13 INFO - ##### 08:11:13 INFO - Running pre-action listener: _resource_record_pre_action 08:11:13 INFO - Running main action method: clobber 08:11:13 INFO - rmtree: /builds/slave/test/build 08:11:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:14 INFO - Running post-action listener: _resource_record_post_action 08:11:14 INFO - ##### 08:11:14 INFO - ##### Finished clobber step (success) 08:11:14 INFO - ##### 08:11:14 INFO - ##### 08:11:14 INFO - ##### Running read-buildbot-config step. 08:11:14 INFO - ##### 08:11:14 INFO - Running pre-action listener: _resource_record_pre_action 08:11:14 INFO - Running main action method: read_buildbot_config 08:11:14 INFO - Using buildbot properties: 08:11:14 INFO - { 08:11:14 INFO - "project": "", 08:11:14 INFO - "product": "firefox", 08:11:14 INFO - "script_repo_revision": "production", 08:11:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:11:14 INFO - "repository": "", 08:11:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:11:14 INFO - "buildid": "20160603053007", 08:11:14 INFO - "pgo_build": "True", 08:11:14 INFO - "basedir": "/builds/slave/test", 08:11:14 INFO - "buildnumber": 149, 08:11:14 INFO - "slavename": "talos-linux64-ix-050", 08:11:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:11:14 INFO - "platform": "ubuntu64_hw", 08:11:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:14 INFO - "branch": "fx-team", 08:11:14 INFO - "repo_path": "integration/fx-team", 08:11:14 INFO - "revision": "0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32", 08:11:14 INFO - "stage_platform": "linux64-pgo", 08:11:14 INFO - "builduid": "7cb7edd069bb4d71b98cd12dd7c2799a", 08:11:14 INFO - "slavebuilddir": "test" 08:11:14 INFO - } 08:11:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:11:14 INFO - Running post-action listener: _resource_record_post_action 08:11:14 INFO - ##### 08:11:14 INFO - ##### Finished read-buildbot-config step (success) 08:11:14 INFO - ##### 08:11:14 INFO - ##### 08:11:14 INFO - ##### Running download-and-extract step. 08:11:14 INFO - ##### 08:11:14 INFO - Running pre-action listener: _resource_record_pre_action 08:11:14 INFO - Running main action method: download_and_extract 08:11:14 INFO - mkdir: /builds/slave/test/build/tests 08:11:14 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')]} 08:11:14 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:11:15 INFO - Downloaded 1361 bytes. 08:11:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:11:15 INFO - Using the following test package requirements: 08:11:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'jsshell-linux-x86_64.zip'], 08:11:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11: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')]} 08:11:15 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:16 INFO - Downloaded 24440968 bytes. 08:11:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:11:17 INFO - Return code: 0 08:11:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:11:17 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')]} 08:11:17 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:19 INFO - Downloaded 24440968 bytes. 08:11:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:11:21 INFO - Return code: 0 08:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:21 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:23 INFO - Downloaded 10833369 bytes. 08:11:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:11:24 INFO - Return code: 0 08:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:24 INFO - https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:11:26 INFO - Downloaded 59155860 bytes. 08:11:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:11:26 INFO - mkdir: /builds/slave/test/properties 08:11:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:26 INFO - Contents: 08:11:26 INFO - build_url:https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:11:26 INFO - Running post-action listener: _resource_record_post_action 08:11:26 INFO - Running post-action listener: set_extra_try_arguments 08:11:26 INFO - ##### 08:11:26 INFO - ##### Finished download-and-extract step (success) 08:11:26 INFO - ##### 08:11:26 INFO - ##### 08:11:26 INFO - ##### Running populate-webroot step. 08:11:26 INFO - ##### 08:11:26 INFO - Running pre-action listener: _resource_record_pre_action 08:11:26 INFO - Running main action method: populate_webroot 08:11:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:26 INFO - '--tppagecycles', 08:11:26 INFO - '7'], 08:11:26 INFO - 'tests': ['tsvgm']}}, 08:11:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['damp', 'tps']}, 08:11:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['damp', 'tps']}, 08:11:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['dromaeo_dom']}, 08:11:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['a11yr', 08:11:26 INFO - 'ts_paint', 08:11:26 INFO - 'tpaint', 08:11:26 INFO - 'sessionrestore', 08:11:26 INFO - 'sessionrestore_no_auto_restore', 08:11:26 INFO - 'tabpaint']}, 08:11:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tsvgx', 08:11:26 INFO - 'tsvgr_opacity', 08:11:26 INFO - 'tart', 08:11:26 INFO - 'tscrollx', 08:11:26 INFO - 'cart']}, 08:11:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:26 INFO - 'tsvgr_opacity', 08:11:26 INFO - 'tart', 08:11:26 INFO - 'tscrollx', 08:11:26 INFO - 'cart']}, 08:11:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s'], 08:11:26 INFO - 'tests': ['tp5o']}, 08:11:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'tests': ['tp5o']}, 08:11:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--disable-e10s', 08:11:26 INFO - '--xperf_path', 08:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:26 INFO - 'tests': ['tp5n']}, 08:11:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:26 INFO - 'talos_options': ['--xperf_path', 08:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:26 INFO - 'tests': ['tp5n']}}, 08:11:26 INFO - 'talos.zip': {'path': '', 08:11:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:26 INFO - Running post-action listener: _resource_record_post_action 08:11:26 INFO - ##### 08:11:26 INFO - ##### Finished populate-webroot step (success) 08:11:26 INFO - ##### 08:11:26 INFO - ##### 08:11:26 INFO - ##### Running create-virtualenv step. 08:11:26 INFO - ##### 08:11:26 INFO - Running pre-action listener: _resource_record_pre_action 08:11:26 INFO - Running main action method: create_virtualenv 08:11:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:26 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 08:11:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:27 INFO - Using real prefix '/usr' 08:11:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:29 INFO - Installing pip.................done. 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:29 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 08:11:29 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 08:11:29 INFO - Using env: {'DISPLAY': ':0', 08:11:29 INFO - 'HOME': '/home/cltbld', 08:11:29 INFO - 'LANG': 'en_US.UTF-8', 08:11:29 INFO - 'LANGUAGE': 'en_US:en', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MAIL': '/var/mail/cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SHLVL': '1', 08:11:29 INFO - 'TERM': 'linux', 08:11:29 INFO - 'TMOUT': '86400', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - '_': '/tools/buildbot/bin/python'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 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 08:11:29 INFO - Cleaning up... 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:29 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 08:11:29 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 08:11:29 INFO - Using env: {'DISPLAY': ':0', 08:11:29 INFO - 'HOME': '/home/cltbld', 08:11:29 INFO - 'LANG': 'en_US.UTF-8', 08:11:29 INFO - 'LANGUAGE': 'en_US:en', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MAIL': '/var/mail/cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SHLVL': '1', 08:11:29 INFO - 'TERM': 'linux', 08:11:29 INFO - 'TMOUT': '86400', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - '_': '/tools/buildbot/bin/python'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 INFO - Downloading/unpacking psutil>=3.1.1 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:31 INFO - Installing collected packages: psutil 08:11:31 INFO - Running setup.py install for psutil 08:11:32 INFO - building 'psutil._psutil_linux' extension 08:11:32 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 08:11:32 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 08:11:32 INFO - building 'psutil._psutil_posix' extension 08:11:32 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 08:11:32 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 08:11:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:32 INFO - Successfully installed psutil 08:11:32 INFO - Cleaning up... 08:11:32 INFO - Return code: 0 08:11:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:32 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:32 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 08:11:32 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 08:11:32 INFO - Using env: {'DISPLAY': ':0', 08:11:32 INFO - 'HOME': '/home/cltbld', 08:11:32 INFO - 'LANG': 'en_US.UTF-8', 08:11:32 INFO - 'LANGUAGE': 'en_US:en', 08:11:32 INFO - 'LOGNAME': 'cltbld', 08:11:32 INFO - 'MAIL': '/var/mail/cltbld', 08:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:32 INFO - 'MOZ_NO_REMOTE': '1', 08:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:32 INFO - 'NO_EM_RESTART': '1', 08:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:32 INFO - 'PWD': '/builds/slave/test', 08:11:32 INFO - 'SHELL': '/bin/bash', 08:11:32 INFO - 'SHLVL': '1', 08:11:32 INFO - 'TERM': 'linux', 08:11:32 INFO - 'TMOUT': '86400', 08:11:32 INFO - 'USER': 'cltbld', 08:11:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:32 INFO - '_': '/tools/buildbot/bin/python'} 08:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:32 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 08:11:32 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 08:11:32 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 08:11:32 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 08:11:32 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 08:11:32 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 08:11:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:34 INFO - Installing collected packages: mozsystemmonitor 08:11:34 INFO - Running setup.py install for mozsystemmonitor 08:11:34 INFO - Successfully installed mozsystemmonitor 08:11:34 INFO - Cleaning up... 08:11:34 INFO - Return code: 0 08:11:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:34 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')]} 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 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')]} 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:34 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 08:11:34 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 08:11:34 INFO - Using env: {'DISPLAY': ':0', 08:11:34 INFO - 'HOME': '/home/cltbld', 08:11:34 INFO - 'LANG': 'en_US.UTF-8', 08:11:34 INFO - 'LANGUAGE': 'en_US:en', 08:11:34 INFO - 'LOGNAME': 'cltbld', 08:11:34 INFO - 'MAIL': '/var/mail/cltbld', 08:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:34 INFO - 'MOZ_NO_REMOTE': '1', 08:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:34 INFO - 'NO_EM_RESTART': '1', 08:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:34 INFO - 'PWD': '/builds/slave/test', 08:11:34 INFO - 'SHELL': '/bin/bash', 08:11:34 INFO - 'SHLVL': '1', 08:11:34 INFO - 'TERM': 'linux', 08:11:34 INFO - 'TMOUT': '86400', 08:11:34 INFO - 'USER': 'cltbld', 08:11:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:34 INFO - '_': '/tools/buildbot/bin/python'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:35 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 08:11:35 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 08:11:35 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 08:11:35 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 08:11:35 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 08:11:35 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 08:11:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:37 INFO - warning: no files found matching '*.txt' 08:11:37 INFO - no previously-included directories found matching 'build' 08:11:37 INFO - no previously-included directories found matching 'dist' 08:11:37 INFO - no previously-included directories found matching '.git*' 08:11:37 INFO - Installing collected packages: jsonschema, functools32 08:11:37 INFO - Running setup.py install for functools32 08:11:37 INFO - warning: no files found matching '*.txt' 08:11:37 INFO - no previously-included directories found matching 'build' 08:11:37 INFO - no previously-included directories found matching 'dist' 08:11:37 INFO - no previously-included directories found matching '.git*' 08:11:37 INFO - Successfully installed jsonschema functools32 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:37 INFO - Using env: {'DISPLAY': ':0', 08:11:37 INFO - 'HOME': '/home/cltbld', 08:11:37 INFO - 'LANG': 'en_US.UTF-8', 08:11:37 INFO - 'LANGUAGE': 'en_US:en', 08:11:37 INFO - 'LOGNAME': 'cltbld', 08:11:37 INFO - 'MAIL': '/var/mail/cltbld', 08:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:37 INFO - 'MOZ_NO_REMOTE': '1', 08:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:37 INFO - 'NO_EM_RESTART': '1', 08:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:37 INFO - 'PWD': '/builds/slave/test', 08:11:37 INFO - 'SHELL': '/bin/bash', 08:11:37 INFO - 'SHLVL': '1', 08:11:37 INFO - 'TERM': 'linux', 08:11:37 INFO - 'TMOUT': '86400', 08:11:37 INFO - 'USER': 'cltbld', 08:11:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:37 INFO - '_': '/tools/buildbot/bin/python'} 08:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:39 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 08:11:40 INFO - Downloading docopt-0.6.1.tar.gz 08:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:40 INFO - Running setup.py install for blobuploader 08:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:40 INFO - Running setup.py install for requests 08:11:40 INFO - Running setup.py install for docopt 08:11:40 INFO - Successfully installed blobuploader requests docopt 08:11:40 INFO - Cleaning up... 08:11:40 INFO - Return code: 0 08:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:40 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:40 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 08:11:40 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 08:11:40 INFO - Using env: {'DISPLAY': ':0', 08:11:40 INFO - 'HOME': '/home/cltbld', 08:11:40 INFO - 'LANG': 'en_US.UTF-8', 08:11:40 INFO - 'LANGUAGE': 'en_US:en', 08:11:40 INFO - 'LOGNAME': 'cltbld', 08:11:40 INFO - 'MAIL': '/var/mail/cltbld', 08:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:40 INFO - 'MOZ_NO_REMOTE': '1', 08:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:40 INFO - 'NO_EM_RESTART': '1', 08:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:40 INFO - 'PWD': '/builds/slave/test', 08:11:40 INFO - 'SHELL': '/bin/bash', 08:11:40 INFO - 'SHLVL': '1', 08:11:40 INFO - 'TERM': 'linux', 08:11:40 INFO - 'TMOUT': '86400', 08:11:40 INFO - 'USER': 'cltbld', 08:11:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:40 INFO - '_': '/tools/buildbot/bin/python'} 08:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:41 INFO - Running setup.py (path:/tmp/pip-n5rRtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:41 INFO - Running setup.py (path:/tmp/pip-iHvVff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:41 INFO - Running setup.py (path:/tmp/pip-zpTkXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:41 INFO - Running setup.py (path:/tmp/pip-gxHj6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:41 INFO - Running setup.py (path:/tmp/pip-XWyQTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:41 INFO - Running setup.py (path:/tmp/pip-KHQpNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 INFO - Running setup.py (path:/tmp/pip-amrCKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:41 INFO - Running setup.py (path:/tmp/pip-a6sfl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:41 INFO - Running setup.py (path:/tmp/pip-aADRG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:41 INFO - Running setup.py (path:/tmp/pip-rco30B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:41 INFO - Running setup.py (path:/tmp/pip-MtX7eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:41 INFO - Running setup.py (path:/tmp/pip-Kq47J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:41 INFO - Running setup.py (path:/tmp/pip-DfX4fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:41 INFO - Running setup.py (path:/tmp/pip-wWJkbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:42 INFO - Running setup.py (path:/tmp/pip-tUo47_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:42 INFO - Running setup.py (path:/tmp/pip-cuIpWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:42 INFO - Running setup.py (path:/tmp/pip-O4tMEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:42 INFO - Running setup.py install for manifestparser 08:11:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozcrash 08:11:42 INFO - Running setup.py install for mozdebug 08:11:42 INFO - Running setup.py install for mozdevice 08:11:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozfile 08:11:42 INFO - Running setup.py install for mozhttpd 08:11:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozinfo 08:11:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:42 INFO - Running setup.py install for mozInstall 08:11:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozleak 08:11:43 INFO - Running setup.py install for mozlog 08:11:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for moznetwork 08:11:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozprocess 08:11:43 INFO - Running setup.py install for mozprofile 08:11:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozrunner 08:11:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:43 INFO - Running setup.py install for mozscreenshot 08:11:43 INFO - Running setup.py install for moztest 08:11:43 INFO - Running setup.py install for mozversion 08:11:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:44 INFO - Cleaning up... 08:11:44 INFO - Return code: 0 08:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:44 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:44 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 08:11:44 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 08:11:44 INFO - Using env: {'DISPLAY': ':0', 08:11:44 INFO - 'HOME': '/home/cltbld', 08:11:44 INFO - 'LANG': 'en_US.UTF-8', 08:11:44 INFO - 'LANGUAGE': 'en_US:en', 08:11:44 INFO - 'LOGNAME': 'cltbld', 08:11:44 INFO - 'MAIL': '/var/mail/cltbld', 08:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:44 INFO - 'MOZ_NO_REMOTE': '1', 08:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:44 INFO - 'NO_EM_RESTART': '1', 08:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:44 INFO - 'PWD': '/builds/slave/test', 08:11:44 INFO - 'SHELL': '/bin/bash', 08:11:44 INFO - 'SHLVL': '1', 08:11:44 INFO - 'TERM': 'linux', 08:11:44 INFO - 'TMOUT': '86400', 08:11:44 INFO - 'USER': 'cltbld', 08:11:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:44 INFO - '_': '/tools/buildbot/bin/python'} 08:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:44 INFO - Running setup.py (path:/tmp/pip-ziQnK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:44 INFO - Running setup.py (path:/tmp/pip-DTZDxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:44 INFO - Running setup.py (path:/tmp/pip-gd_kge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:44 INFO - Running setup.py (path:/tmp/pip-cjvVv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:44 INFO - Running setup.py (path:/tmp/pip-S_gvNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:44 INFO - Running setup.py (path:/tmp/pip-DytGrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:44 INFO - Running setup.py (path:/tmp/pip-d146dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:44 INFO - Running setup.py (path:/tmp/pip-U8FuEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:44 INFO - Running setup.py (path:/tmp/pip-x2YRDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:44 INFO - Running setup.py (path:/tmp/pip-_aG_N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:44 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)) 08:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:44 INFO - Running setup.py (path:/tmp/pip-h5jhN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:45 INFO - Running setup.py (path:/tmp/pip-7aqI5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:45 INFO - Running setup.py (path:/tmp/pip-O7hQZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:45 INFO - Running setup.py (path:/tmp/pip-b4o4HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:45 INFO - Running setup.py (path:/tmp/pip-KytIyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:45 INFO - Running setup.py (path:/tmp/pip-rnuxTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:45 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)) 08:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:45 INFO - Running setup.py (path:/tmp/pip-d5m0Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:47 INFO - Downloading blessings-1.6.tar.gz 08:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:47 INFO - Installing collected packages: blessings 08:11:47 INFO - Running setup.py install for blessings 08:11:47 INFO - Successfully installed blessings 08:11:47 INFO - Cleaning up... 08:11:47 INFO - Return code: 0 08:11:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:47 INFO - Reading from file tmpfile_stdout 08:11:47 INFO - Current package versions: 08:11:47 INFO - argparse == 1.2.1 08:11:47 INFO - blessings == 1.6 08:11:47 INFO - blobuploader == 1.2.4 08:11:47 INFO - docopt == 0.6.1 08:11:47 INFO - functools32 == 3.2.3-2 08:11:47 INFO - jsonschema == 2.5.1 08:11:47 INFO - manifestparser == 1.1 08:11:47 INFO - mozInstall == 1.12 08:11:47 INFO - mozcrash == 0.17 08:11:47 INFO - mozdebug == 0.1 08:11:47 INFO - mozdevice == 0.48 08:11:47 INFO - mozfile == 1.2 08:11:47 INFO - mozhttpd == 0.7 08:11:47 INFO - mozinfo == 0.9 08:11:47 INFO - mozleak == 0.1 08:11:47 INFO - mozlog == 3.2 08:11:47 INFO - moznetwork == 0.27 08:11:47 INFO - mozprocess == 0.22 08:11:47 INFO - mozprofile == 0.28 08:11:47 INFO - mozrunner == 6.11 08:11:47 INFO - mozscreenshot == 0.1 08:11:47 INFO - mozsystemmonitor == 0.3 08:11:47 INFO - moztest == 0.7 08:11:47 INFO - mozversion == 1.4 08:11:47 INFO - psutil == 3.1.1 08:11:47 INFO - requests == 1.2.3 08:11:47 INFO - wsgiref == 0.1.2 08:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:47 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:47 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 08:11:47 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 08:11:47 INFO - Using env: {'DISPLAY': ':0', 08:11:47 INFO - 'HOME': '/home/cltbld', 08:11:47 INFO - 'LANG': 'en_US.UTF-8', 08:11:47 INFO - 'LANGUAGE': 'en_US:en', 08:11:47 INFO - 'LOGNAME': 'cltbld', 08:11:47 INFO - 'MAIL': '/var/mail/cltbld', 08:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:47 INFO - 'MOZ_NO_REMOTE': '1', 08:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:47 INFO - 'NO_EM_RESTART': '1', 08:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:47 INFO - 'PWD': '/builds/slave/test', 08:11:47 INFO - 'SHELL': '/bin/bash', 08:11:47 INFO - 'SHLVL': '1', 08:11:47 INFO - 'TERM': 'linux', 08:11:47 INFO - 'TMOUT': '86400', 08:11:47 INFO - 'USER': 'cltbld', 08:11:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:47 INFO - '_': '/tools/buildbot/bin/python'} 08:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 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)) 08:11:48 INFO - Cleaning up... 08:11:48 INFO - Return code: 0 08:11:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:48 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 08:11:48 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 08:11:48 INFO - Using env: {'DISPLAY': ':0', 08:11:48 INFO - 'HOME': '/home/cltbld', 08:11:48 INFO - 'LANG': 'en_US.UTF-8', 08:11:48 INFO - 'LANGUAGE': 'en_US:en', 08:11:48 INFO - 'LOGNAME': 'cltbld', 08:11:48 INFO - 'MAIL': '/var/mail/cltbld', 08:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:48 INFO - 'MOZ_NO_REMOTE': '1', 08:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:48 INFO - 'NO_EM_RESTART': '1', 08:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:48 INFO - 'PWD': '/builds/slave/test', 08:11:48 INFO - 'SHELL': '/bin/bash', 08:11:48 INFO - 'SHLVL': '1', 08:11:48 INFO - 'TERM': 'linux', 08:11:48 INFO - 'TMOUT': '86400', 08:11:48 INFO - 'USER': 'cltbld', 08:11:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:48 INFO - '_': '/tools/buildbot/bin/python'} 08:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:48 INFO - Cleaning up... 08:11:48 INFO - Return code: 0 08:11:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:48 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 0x7f07fb319f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13633b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, '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': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', '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 08:11:48 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 08:11:48 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 08:11:48 INFO - Using env: {'DISPLAY': ':0', 08:11:48 INFO - 'HOME': '/home/cltbld', 08:11:48 INFO - 'LANG': 'en_US.UTF-8', 08:11:48 INFO - 'LANGUAGE': 'en_US:en', 08:11:48 INFO - 'LOGNAME': 'cltbld', 08:11:48 INFO - 'MAIL': '/var/mail/cltbld', 08:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:48 INFO - 'MOZ_NO_REMOTE': '1', 08:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:48 INFO - 'NO_EM_RESTART': '1', 08:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:48 INFO - 'PWD': '/builds/slave/test', 08:11:48 INFO - 'SHELL': '/bin/bash', 08:11:48 INFO - 'SHLVL': '1', 08:11:48 INFO - 'TERM': 'linux', 08:11:48 INFO - 'TMOUT': '86400', 08:11:48 INFO - 'USER': 'cltbld', 08:11:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:48 INFO - '_': '/tools/buildbot/bin/python'} 08:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:48 INFO - Downloading/unpacking flake8 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:11:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:11:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:50 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 08:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:11:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:51 INFO - no previously-included directories found matching 'docs/_build' 08:11:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:11:51 INFO - Running setup.py install for pep8 08:11:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:51 INFO - no previously-included directories found matching 'docs/_build' 08:11:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:11:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:11:51 INFO - Cleaning up... 08:11:51 INFO - Return code: 0 08:11:51 INFO - Running post-action listener: _resource_record_post_action 08:11:51 INFO - Running post-action listener: _start_resource_monitoring 08:11:51 INFO - Starting resource monitoring. 08:11:51 INFO - ##### 08:11:51 INFO - ##### Finished create-virtualenv step (success) 08:11:51 INFO - ##### 08:11:51 INFO - ##### 08:11:51 INFO - ##### Running install step. 08:11:51 INFO - ##### 08:11:51 INFO - Running pre-action listener: _resource_record_pre_action 08:11:51 INFO - Running main action method: install 08:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:51 INFO - Reading from file tmpfile_stdout 08:11:51 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:51 INFO - Reading from file tmpfile_stdout 08:11:51 INFO - Output received: 08:11:51 INFO - Usage: mozinstall [options] installer 08:11:51 INFO - Options: 08:11:51 INFO - -h, --help show this help message and exit 08:11:51 INFO - -d DEST, --destination=DEST 08:11:51 INFO - Directory to install application into. [default: 08:11:51 INFO - "/builds/slave/test"] 08:11:51 INFO - --app=APP Application being installed. [default: firefox] 08:11:51 INFO - mkdir: /builds/slave/test/build/application 08:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:12:08 INFO - Reading from file tmpfile_stdout 08:12:08 INFO - Output received: 08:12:08 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - ##### 08:12:08 INFO - ##### Finished install step (success) 08:12:08 INFO - ##### 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running run-tests step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: run_tests 08:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:08 INFO - Python 2.7.3 08:12:08 INFO - Return code: 0 08:12:08 INFO - grabbing minidump binary from tooltool 08:12: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')]} 08:12:08 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 0x13f5990>, '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 0x1361470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1361900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:08 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 08:12:08 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 08:12:08 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 08:12:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:08 INFO - Return code: 0 08:12:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:12:09 INFO - Return code: 0 08:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:12:09 INFO - Using env: {'DISPLAY': ':0', 08:12:09 INFO - 'HOME': '/home/cltbld', 08:12:09 INFO - 'LANG': 'en_US.UTF-8', 08:12:09 INFO - 'LANGUAGE': 'en_US:en', 08:12:09 INFO - 'LOGNAME': 'cltbld', 08:12:09 INFO - 'MAIL': '/var/mail/cltbld', 08:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:09 INFO - 'MOZ_NO_REMOTE': '1', 08:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:09 INFO - 'NO_EM_RESTART': '1', 08:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:09 INFO - 'PWD': '/builds/slave/test', 08:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:09 INFO - 'SHELL': '/bin/bash', 08:12:09 INFO - 'SHLVL': '1', 08:12:09 INFO - 'TERM': 'linux', 08:12:09 INFO - 'TMOUT': '86400', 08:12:09 INFO - 'USER': 'cltbld', 08:12:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692', 08:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:09 INFO - '_': '/tools/buildbot/bin/python'} 08:12:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:12:09 INFO - mozversion application_buildid: 20160603053007 08:12:09 INFO - mozversion application_changeset: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 08:12:09 INFO - mozversion application_display_name: Nightly 08:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:09 INFO - mozversion application_name: Firefox 08:12:09 INFO - mozversion application_remotingname: firefox 08:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:09 INFO - mozversion application_vendor: Mozilla 08:12:09 INFO - mozversion application_version: 49.0a1 08:12:09 INFO - mozversion platform_buildid: 20160603053007 08:12:09 INFO - mozversion platform_changeset: 0ef7cc6b42c72be6ef8d0786fb1f5371c11e9e32 08:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:09 INFO - mozversion platform_version: 49.0a1 08:12:09 INFO - using testdate: 1464966729 08:12:09 INFO - actual date: 1464966729 08:12:09 INFO - starting webserver on 'localhost:45786' 08:12:09 INFO - SUITE-START | Running 2 tests 08:12:09 INFO - TEST-START | dromaeo_css 08:12:09 INFO - operating with platform_type : linux_ 08:12:09 INFO - Initialising browser for dromaeo_css test... 08:12:09 INFO - TEST-INFO | started process 14753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIcSFg4/profile http://localhost:45786/getInfo.html) 08:12:13 INFO - PROCESS | 14753 | __metrics Screen width/height:1600/1200 08:12:13 INFO - PROCESS | 14753 | colorDepth:24 08:12:13 INFO - PROCESS | 14753 | Browser inner width/height: 1024/697 08:12:13 INFO - PROCESS | 14753 | __metrics 08:12:14 ERROR - PROCESS | 14753 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:12:15 INFO - TEST-INFO | 14753: exit 0 08:12:15 INFO - Browser initialized. 08:12:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:15 INFO - TEST-INFO | started process 14833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIcSFg4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:27 INFO - PROCESS | 14833 | RSS: Main: 155811840 08:12:27 INFO - PROCESS | 14833 | 08:13:18 INFO - PROCESS | 14833 | 1464966798391 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] 08:15:26 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45786/tests/dromaeo/cssquery-ext.html) 08:15:27 INFO - PROCESS | 14833 | RSS: Main: 259670016 08:15:27 INFO - PROCESS | 14833 | 08:18:29 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-ext.html (next: http://localhost:45786/tests/dromaeo/cssquery-jquery.html) 08:18:30 INFO - PROCESS | 14833 | RSS: Main: 245469184 08:18:30 INFO - PROCESS | 14833 | 08:21:32 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45786/tests/dromaeo/cssquery-mootools.html) 08:21:33 INFO - PROCESS | 14833 | RSS: Main: 249917440 08:21:33 INFO - PROCESS | 14833 | 08:24:35 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45786/tests/dromaeo/cssquery-prototype.html) 08:24:35 INFO - PROCESS | 14833 | RSS: Main: 237060096 08:24:35 INFO - PROCESS | 14833 | 08:27:38 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45786/tests/dromaeo/cssquery-yui.html) 08:27:38 INFO - PROCESS | 14833 | RSS: Main: 204738560 08:27:38 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:45786/tests/dromaeo/cssquery-yui.html (next: http://localhost:45786/tests/dromaeo/cssquery-dojo.html) 08:30:41 INFO - PROCESS | 14833 | RSS: Main: 288354304 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | __start_tp_report 08:30:41 INFO - PROCESS | 14833 | _x_x_mozilla_page_load 08:30:41 INFO - PROCESS | 14833 | _x_x_mozilla_page_load_details 08:30:41 INFO - PROCESS | 14833 | |i|pagename|runs| 08:30:41 INFO - PROCESS | 14833 | |0;dojo.html;3143.3870395272925;3146.842657867107;3146.8583913723864;3178.825164615945;3206.470932296171;5355.946440535594;5382.192671099337;5389.649672771267;5465.808696695616;5504.091824848905;5475.5072043516075;5494.945050549493;5496.285482887219;5500.5874559408;5521.3926468088475;4935.062338155757;4961.677490963076;5023.472535383787;5033.320501732274;5156.53591176794;5045.672031317952;5062.063518249117;5096.3884333879805;5111.258867464216;5120.103981803189;4874.585660218886;4895.5838753705975;4942.481039490855;4944.480829512885;4956.925646115311;4955.578775804061;4982.202847544376;5052.393712754493;5058.241263810458;5086.54221120101;4831.685940413897;4985.626078044125;4999.125153098194;5028.472010438924;5062.468440813698;5355.143177091685;5405.27028851104;5415.83752487426;5507.697076660782;5507.972460137674;5842.591018628697;5862.560307976876;5878.941210587882;5884.117382392633;5898.262717160355;5800.59395842287;5880.912031274185;5910.940890591082;5928.081147422156;5932.9406705932815;5540.141278101901;5635.71821408932;5636.210930469738;5637.689927054011;5644.125160600113;6110.1034462138705;6116.082587611894;6119.969325458895;6129.540284478593;6137.956547386955;5625.09998400254;5664.405237450091;5685.374608793029;5927.555433342431;5931.614445061057;5814.738336774855;5815.214945982323;5820.563457740602;5865.648061116347;5874.295084589877;5751.884962300731;5780.046292361713;5790.334111577138;5794;5798.33319168301;5610.887782244332;5792.681402522901;5829.242198514251;5857.765689372377;5877.265341832271;4455.643548516111;4468.195724769507;4468.798904049326;4471.128130014616;4509.594136527663;3937.8621748238675;3959.6238357356006;3983.8406463741126;4013.1973605279063;4027.0536423940353;5497.890042199134;5542.944570554324;5559.166125081189;5636.013697602903;5639.069553523705;5949.8215053548465;5963.314218864886;5979;6000.849978750479;6058.878822423527;5631.915521267184;5641.323041235078;5642;5647.181158731961;5650.85872853182;4861.538153875376;4879.2925025871045;4913.975430122827;4926.310316555685;4931.778069986859;6101.755929762849;6107.144999700045;6109.908351374733;6111.84720381994;6133.3866613338305;5753.539716822728;5908.4682378586995;5916.290045194604;5921.259842519685;5923.141144534105;5999.400059993965;6022.337542870193;6025.487833534199;6104.32852386246;6116.082587611894;5773.422657734361;5790.710464476843;5796.565257605612;5797.101449275369;5811.476967072984;5690.118031705092;5876.588638795243;5915.142304365929;5950.077737950624;5951.256092988377;5797.072468405035;5836.737346819488;5849.5612829037145;5850.23946886919;5901.380355062828;5761.884762304647;5775.480206781242;5778.451047150514;5779.422057794187;5791.8552036199435;5540.695261760642;5588.050031494575;5614.410486898817;5712.0860662293835;5718.285214348207;5805.477507024219;5835.2122463466885;5841.415858414124;5847.532197424111;5850.619709719025;5628.155776633538;5654.46282603152;5661.122526008476;5661.801836935688;5672.688002159921 08:30:41 INFO - PROCESS | 14833 | |1;ext.html;583.5681595619241;616.6916541729136;618.9910445973063;627.1032423634205;630.2090875950681;32527.512087318708;35519.82240088802;35531.4670279946;43985.34021989673;45093.77453112738;46548.301775473396;46612.203267803874;46973.53026469734;47055;47090.058198836006;8609.698660546883;8766.123387661215;8787.121287871194;8792.912070879305;8792.956035219815;8724.38929274951;8845.823083538326;8869.157430044168;8871.290296776242;8873.29013678904;8856.291496680251;8889;8913;8915.42049766763;8915.95542022289;8816.559172041372;8853.11468853116;8875.511846848422;8879.689210877588;8879.866801997976;8763.649454021832;8868.733937981871;8874.334424918092;8880.111988801069;8884.911150888538;42566.36150457746;43008.56991430108;43073.56926430727;43096.78451607753;43103.78448107771;3477.7739446935866;3588.4617307403837;3655.4151335786146;3812.980935095307;3964.345882929313;32076.198095047577;32750.836245818617;33248;34199.82900085508;34219.14452138716;4235.57644235577;4337.891552711176;4383;4396.912061758779;4525.298578720271;344107;345367;347255;347356;347683;60772;61169.69415152896;61590;61746.69126654428;61753.38246617566;62837;63455;63487.68256158782;63585;63598.64013598603;16610.252538635792;16986.235619397157;17294.567635809206;17400.21699023547;17973.37093201732;11629.418529073682;11732.648020559396;11756.23584467007;11762;11777;19760.308389206308;20131.698024529353;20180.69728954067;20185.798142018684;20209.191632334543;7134.678939447737;7151.606661633556;7235.6020418876415;7237.095363079615;7295.832666773291;963.5230560872413;1067.236925598201;1144.0332918683698;1155.7110722319421;1197.8802119788127;32758.181045474055;33153.66846331554;33207.501887471706;33318.50022249668;33973;1128.90968722502;1130.2483848240993;1178.6051672689746;1181.772359103097;1217.5292484632268;17343.913280433768;17373.13134343278;17423;17494.562635934202;17511.474655760347;523538;526537;529659;530166;534169;58958;59571;59576.70211648914;59631.70184149052;59656.70171649114;1242.7328124453286;1278.571678487717;1364.4951367993906;1367.43934986655;1368.438940034581;30361.544576831806;34012.48981265332;34149.658503415645;34515.65484345225;34518.30963380668;49800.75099624479;50394.244086338;50986.490135098175;51033.74483127561;51048;390643;391662;391702;392366;392466;25222.369440763392;27872.44255114927;28712.282192945342;28751.856240718662;29287.7071229285;48012.7599362001;48871.5112848867;49084;49453.50546494633;50744;40030.59969400269;40615.79692101521;41298;41812.79093604512;41831.7908410456;40160.59839401685;40740.59259407368;41030.58969410268;41103.38344924888;41167.588324116376;36904.81547592245;41320.38019429771;41374;41907.37138942979;42438.151236975704;33406.498902515996;37355.252894942496;37534.6246537542;37705.245895082495;38289.425658614586;28318.43363132767;28449.43101138007;28499.572506412005;28544.57183142296;28695.569566456103 08:30:41 INFO - PROCESS | 14833 | |2;jquery.html;389.8908305674411;393.39613692981277;396.4172666180715;402.3943964333677;419.2516358300434;13117.764888924818;18145.63708725825;19811.20755169793;19832.60334793305;20033.298834540794;15842.603934901605;16645.66708665829;18408.447746567592;19061.332853350137;19083.236670533162;5493.890122197554;5671.914921276163;5680.176374425706;5680.744366503496;5684.971575142118;5480.205370221315;5509.669419834822;5564.8052318168875;5618.831435056934;5620.9437905621035;5611.7474713637785;5647.407022262665;5653.547716182696;5654.6041777075625;5658.151277308416;5455.454454554513;5577.52591029761;5624.100143976964;5625.831225063234;5750.137479378085;5441.646292990982;5604.663720176803;5625.5499560035505;5627.155926611041;5635.070213414781;13957.930210348984;14325.856741432557;23198.420039499146;23199.652005219934;23697.170599029123;2155.89220538974;2289.782470665284;2343.5430091132066;2511.296836885657;2531.5949448088218;9371.250299976055;9418.152366286999;9701.757456063655;10375.481225938673;10455.84316235257;1916.425072478251;1925.2491528303972;1946.6106778644328;1947.6688962876344;1960.284496158906;81594.59202703949;81979.18020819775;84715;86809.56595217047;88366.5581672094;10829.404382759023;10979.670609881716;11144.2199046066;11206.439678016066;12070;15531.922340388226;15630.296636651377;15710.293036813371;15753.188383336063;15800.604984875241;7746.806329841686;7825.882611760828;8070.636821343053;8099.838003239902;8487.066422693499;7842.294193522496;7901.249381308767;8026.919730802734;8063.83872322562;8114.431989760778;3988.501437320335;4119.134981653826;4256.233877901946;4277.978610106992;4337.566243375701;1919.9040047997823;1925.258775371464;1936;1938.70919362094;1962.833159181457;873.6767396063498;957.2809634569746;987.6543209876629;1034.0125180452649;1053.910417614496;17996.460106196835;19160.616787664447;19540.511487212934;19608;19611.313604024075;984.9950750246346;1000.7598176437602;1008.037324355239;1026.7587117027492;1048.1667074675652;10416.270861039655;10794.136469082454;10804.135669146606;10841.403722795321;10879.510422031028;407689;436925;455827;458170;465607;89142;90262;91938;93341;94781;998.1017084623752;1007.4459047523833;1015.6851376073441;1016.9373005209721;1031.8400647899587;16524.339026438807;16897.239624216694;17094.743578846577;17164.570885727957;17622.295108196042;41208.58791412047;42109.36835947402;42175.99999999877;42407.151856963304;42413.57586424219;56850.14724779214;57888.421115788304;58571;59005;59106.70446647739;7877.251661092187;8226.136255693305;8361.83276334482;8391.118932511998;8396.412251142361;9224;12863.614091577268;13095.476180952655;13122.671933201746;13411.195328280335;9818.85271720939;11431.542738290374;11436.485358158736;11561.190716649753;11711.88288117108;11176.832347514957;11256.268342557707;11275.548978040786;11370.886291136983;11397.772044559228;11492.48283827213;11724.70688232767;11783.410829458664;11804.291742495478;11955;8359.205875441823;8407.285380742705;8460.932584993228;8475;8629.56852157377;10856.131509479064;11456.427178641201;11487.25332853362;11687.240329378563;11762.764744704888 08:30:41 INFO - PROCESS | 14833 | |3;mootools.html;1334.459543884727;1522.687848990957;1549.2331296008476;1695.186310570926;1860;8411.91588084119;8870.290376769852;8870.645174193032;9061.592228349724;9072.682456114037;8737.475751454902;8928.955355223232;8936.10638936106;8941.150590693873;8948.507832069234;2059.9485012874648;2312.6184179610345;2334.089705015041;2377.988110059447;2390.5457962987066;2358.929232123039;2360.3155085025323;2360.822938279627;2361.102780943239;2365.4914193448403;2351.8000969917493;2354.023080421623;2378.1795280628244;2382.1305223593436;2383.07060246504;2035.714999900015;2284.4060544258446;2313.109452860644;2344.976550234493;2349.283468542094;2352.8235382346393;2356.9175078872327;2380.369202161429;2380.4286971126976;2382.237683941122;8962.775930601721;9088.591013404413;9101.089891010912;9105.36262461628;9118.179363857285;5184.481551844785;5303.761330740087;5306.230596563477;5308.5487733542695;5310.017646735328;3211.1329940916057;3432.1248081739245;3511.7541772075965;3551.786892786441;3589.6589823966683;1156.1329003247565;1184.9052075833913;1186.2822992089834;1194.737157825277;1228.3060071059822;12278;12282.938585307105;12314.692132696664;12325.137240393176;12325.938370308091;4726.834560790356;4732.503087175865;4755.358026666425;4768.8086249172875;4844.8304309349705;10437.425941573134;10456.058954694114;10475.114479393782;10484.842727359095;10486.26596138263;5278.947210527922;5291.523762861284;5298.549623281987;5300.549453296513;5300.92048619271;4363.869083927487;4709.835155769531;4881.585065269492;4883.340748998839;4941.579965702884;4094.549599544048;4142.730722503027;4180.853670121531;4190.057237121623;4268.487781466244;1288.9419976101099;1290.5676598339662;1313.0939651640529;1317.8352705911761;1322.7090040191335;822.284612387215;905.0451773379148;923.612082925173;946.4368700623119;949.0651708067548;5551.25058117149;5753.683547404933;5772;5869.178315035899;5869.8239052828485;965.2374624047064;994.5922171909482;996.9551370188359;1036.740814796301;1077.3320541264309;3870.53553573573;3899.0642245861354;4005.759654420744;4007.3788562772816;4022.61785130418;10962.671119866416;11192;11256.549738010552;11376.260543064674;11378.146639002109;11144.944275278734;11147.38689372076;11149.16381271408;11153.72115697114;11155.107591392669;8177.182281771775;8422.536760478233;8506.106858779738;8526.744197673956;8565.614547345385;5534.667919924817;5632.127020311858;5695.202671625892;5840.853978650568;5858.765649374148;9822.312438129262;10154.289199755945;10177.796444071226;10335.379877207391;10418.374897506174;10424.061834434937;10466.581336746749;10470.476476176313;10478.528466219192;10625;7027.821375373651;7645.464817462725;7832.843343132991;7857.371410287049;7949.165337639464;8755.474671519474;8806.60370283326;8825.249853762502;8839.779005524913;8855.114488551093;7700.114486834086;7740.14858365568;7795.415343849348;7988.254031455491;7999.600019999093;7323.597202153933;7730.613469326624;7755.2632499912415;7879.684812607432;7912.604369781603;6972.233054363915;7165;7173.3185347394;7176.282371762991;7196.568205907663;5065.974670126626;5080.517350851663;5317.548008419173;5330.227117067926;5379.220013098157;5192.663301514258;5267.947320526899;5280.023195708806;5318.042752304467;5420.728963551728 08:30:41 INFO - PROCESS | 14833 | |4;prototype.html;305.34503490013935;323.81542520763145;336.3307019032126;336.9966300336997;343.1027862140502;5116.309298244736;5263.578913686905;5265.289185959894;5281.392639846419;5349.839504814857;5249.711265880375;5289.285946397235;5315.681059136455;5320.17537281722;5371.328583927009;4160.292750232453;4183.665306775466;4184.895377615569;4187.74873507589;4209.9789501052455;3935.5867633898456;3966.5438474575362;4171.519110715698;4172.645325147366;4204.285271503836;4106.260873042851;4134.4625198724125;4142.396115379624;4150.605692459227;4159.48178914697;4158.4178215049915;4160.479940007499;4164.271827191712;4183.309753890604;4194.2869712149;3411.624721280657;3728.5339332583426;3732.2908647356917;3741.6632503074584;3746.737728359016;5063.822766203165;5085.847424577269;5094.108531007096;5098.1842905135;5098.439171691148;4669.735178438455;4693.835715749967;4717.858464246078;4735.195016847109;4736.739479328636;5266.631335806495;5491.478309560585;5525.2264682944015;5528.585356098309;5545.833624991256;3967.4247234151176;3969.9007524811823;3979.422983667352;3981.601839816024;3984.4620976168135;5713.657180569221;5742.368339482654;5746.454086861741;5795.3045634523705;5806.796762113348;3980.9402858957137;4032.1129351542613;4066.7763273019677;4066.8576599818866;4071.900586841536;4057.69567282455;4085.752835940221;4090.8159132839096;4122.855700050483;4125.50493940729;4621;4637.39713837199;4679.883002924954;4689.976550117228;4697.154512187771;5353.162823703444;5483.533899618577;5483.7806487740845;5486.31421072366;5495.642783219078;1315.302889468583;1345.7106722054805;1348.1708749119416;1356.1117468058437;1360.8775210231126;904.5522466379184;912.5802131019673;920.4339331311329;929.7907970706672;932.8507438809758;4786.832460863853;4789.281607758794;4792.329073929653;4801.7118972861745;4856.708597484162;4713.151632706077;4987.576056035277;5019.84940451787;5023.472535383732;5038.6976781392505;4723.7874295656775;4736.763161841963;4741.881452963704;4760.595349395271;4809.807607695723;2665.4935562243113;2673.451942351813;2696.474187533451;2741.2735625059377;2746.491898998692;5504.7522861470525;5941.732622032019;5954.166416701579;5955.731992060368;5958.421018430119;5868.882622347529;5881.323647780475;5885.5585831062845;5887.17415640495;5905.7932972346625;5689.350088474296;5858.853528661817;5863.765449381977;5902.852428689317;5946.910796338058;5647.745851436777;5675.829725108253;5685;5687.488126068673;5743.310802703702;5633.887322253614;5635.605507614428;5639.577031722555;5665.206871037975;5678.77284908599;5672.290963629546;5800.4489573490455;5822.82531524055;5888.3228428731245;5890.410958904075;3945;4034.818433170573;4041.4341992121713;4062.614051665087;4081.6938729594804;5438.742921687455;5746.454086861741;5752.165935939349;5757.769689212385;5766.826995190151;5482.616216864782;5564.553216163908;5575.1915972184615;5575.526080283222;5588.451333403237;5229.398619158694;5368.946310536845;5371.650842695212;5484.972575137099;5521.806736764194;5422.6475279106735;5451.4276001019325;5536.418676039119;5539.418361072029;5555.944440555704;5369.946300536944;5650.26546548946;5670.461306175906;5672.971635141798;5686.289213848269;5335.33308336458;5493.642913210629;5494.313210848644;5501.697406642673;5512.33851937754 08:30:41 INFO - PROCESS | 14833 | |5;yui.html;757.3562471898883;783.6708582395394;803.3733687723578;828.2380210206609;854.5812551849596;15462.381504739811;16505.587360315967;16563.751543726823;16634.25145868437;16643.500694979153;13594.252316122635;13608.523701670443;13630.250336231504;14298.714025719506;15203.54389368318;812.1431889356726;818.8280461103176;824.2128767027474;826.4545400035947;826.5040975414734;672.9226138994005;805.5448671500584;820.2248874813274;820.8973878265217;825.3603457320595;850.4429598612918;851.259404318244;851.2849206666399;851.8168593752342;852.8166444214493;703.9401650859683;848.3128665780706;849.371465115816;849.464837152593;849.6601359456205;613.4816080412045;621.4934828115072;622.0110025060176;622.4087117238641;622.8380621038563;14260.643483912881;14292.714145717131;14306.642333941734;14318;14318.212498312589;13650.385732642055;13697.383617737127;13848.930755346159;14337.78493322601;14482.203478808662;12585.24488530691;12862.549810756578;12866.742665146645;12930.806037909439;13072.673183170402;4378.1462614790125;4405.977970110161;4431.6233120184825;4468.240399132155;4567.977160114211;74653.1336716581;75262;76227.23772762313;76395;76685;11232;11372.31766094037;11546.76906461866;11643.592474263529;11772.117091218193;20403.285884993955;20727.27454539084;20734.48163795887;20735.8963205183;20737.27419540339;8176.3867709922;8203.753887383387;8339.416240863082;8674.56627168639;8781.956090219508;4651.069786042805;4653.95346046542;4803.279508073817;4896.975515122402;4937.679050861682;3656.195636959918;3784.526934133233;3788.3938569829247;3795.9430608540893;3797.7531460454984;653.3792896748108;662.1788981662703;664.8670265946733;670.0184230102923;680.3026897430174;702.3503259484957;720.2725247499958;738.6048464071696;742.109468637637;749.2170681637592;9285.225461938404;9488.810223795486;9521.809563808685;9592.424454532611;9660.516974151264;697.4699228586311;705.5837056136801;727.5998200989541;745.0835472368908;753.9170691223961;4107.424960505532;4349.347597860283;4467.173572889026;4475.980898489546;4582.862514124582;70059.29940700528;70286.297137029;87596;106796.46601766942;111858;99144;100896.4955175234;101169;102351;102412;87434.56282718673;87682.56158719165;90126.54936725274;91556;92910;9094.317926155432;9181.357304988855;9226.630934762534;9259.53702314895;9274.118958698913;43788;50185.49814501954;51656.74171629268;52706;54744.45255547394;69457.3054269471;69629.65185174042;71261;71696.28303716896;72753;12606.810897836356;12797;12854.871451285368;13159.53941612039;13607.251601162032;13687.533087610936;14006.229657368942;14130.858691412954;14151.292435377984;14456.566303010926;12739.74520509566;12877.484900603871;12957;13126.540571079966;13475.932620336836;12567.183133096685;12643.93678031604;12770.936145319214;12950.963922885958;13244.139130956457;12831.422585983466;13287.534936277183;13371.264580448169;13403.932980335036;13813.930930345285;10389.480525973822;10676.199285053497;10749.14006879432;10791.56833726642;11359.829602556134;10608.628697995533;11058.538185505013;11164.665060048212;11199.72000699989;11210.607628732956 08:30:41 INFO - PROCESS | 14833 | __end_tp_report 08:30:41 INFO - PROCESS | 14833 | __start_cc_report 08:30:41 INFO - PROCESS | 14833 | _x_x_mozilla_cycle_collect,896 08:30:41 INFO - PROCESS | 14833 | __end_cc_report 08:30:41 INFO - PROCESS | 14833 | __startTimestamp1464967841875__endTimestamp 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | ------- Summary: start ------- 08:30:41 INFO - PROCESS | 14833 | Number of tests: 6 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#0] dojo.html Cycles:165 Average:5463.31 Median:5661.12 stddev:633.41 (11.2%) stddev-sans-first:608.65 08:30:41 INFO - PROCESS | 14833 | Values: 3143.4 3146.8 3146.9 3178.8 3206.5 5355.9 5382.2 5389.6 5465.8 5504.1 5475.5 5494.9 5496.3 5500.6 5521.4 4935.1 4961.7 5023.5 5033.3 5156.5 5045.7 5062.1 5096.4 5111.3 5120.1 4874.6 4895.6 4942.5 4944.5 4956.9 4955.6 4982.2 5052.4 5058.2 5086.5 4831.7 4985.6 4999.1 5028.5 5062.5 5355.1 5405.3 5415.8 5507.7 5508.0 5842.6 5862.6 5878.9 5884.1 5898.3 5800.6 5880.9 5910.9 5928.1 5932.9 5540.1 5635.7 5636.2 5637.7 5644.1 6110.1 6116.1 6120.0 6129.5 6138.0 5625.1 5664.4 5685.4 5927.6 5931.6 5814.7 5815.2 5820.6 5865.6 5874.3 5751.9 5780.0 5790.3 5794.0 5798.3 5610.9 5792.7 5829.2 5857.8 5877.3 4455.6 4468.2 4468.8 4471.1 4509.6 3937.9 3959.6 3983.8 4013.2 4027.1 5497.9 5542.9 5559.2 5636.0 5639.1 5949.8 5963.3 5979.0 6000.8 6058.9 5631.9 5641.3 5642.0 5647.2 5650.9 4861.5 4879.3 4914.0 4926.3 4931.8 6101.8 6107.1 6109.9 6111.8 6133.4 5753.5 5908.5 5916.3 5921.3 5923.1 5999.4 6022.3 6025.5 6104.3 6116.1 5773.4 5790.7 5796.6 5797.1 5811.5 5690.1 5876.6 5915.1 5950.1 5951.3 5797.1 5836.7 5849.6 5850.2 5901.4 5761.9 5775.5 5778.5 5779.4 5791.9 5540.7 5588.1 5614.4 5712.1 5718.3 5805.5 5835.2 5841.4 5847.5 5850.6 5628.2 5654.5 5661.1 5661.8 5672.7 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#1] ext.html Cycles:180 Average:59050.86 Median:41309.19 stddev:113648.42 (275.1%) stddev-sans-first:113882.46 08:30:41 INFO - PROCESS | 14833 | Values: 583.6 616.7 619.0 627.1 630.2 32527.5 35519.8 35531.5 43985.3 45093.8 46548.3 46612.2 46973.5 47055.0 47090.1 8609.7 8766.1 8787.1 8792.9 8793.0 8724.4 8845.8 8869.2 8871.3 8873.3 8856.3 8889.0 8913.0 8915.4 8916.0 8816.6 8853.1 8875.5 8879.7 8879.9 8763.6 8868.7 8874.3 8880.1 8884.9 42566.4 43008.6 43073.6 43096.8 43103.8 3477.8 3588.5 3655.4 3813.0 3964.3 32076.2 32750.8 33248.0 34199.8 34219.1 4235.6 4337.9 4383.0 4396.9 4525.3 344107.0 345367.0 347255.0 347356.0 347683.0 60772.0 61169.7 61590.0 61746.7 61753.4 62837.0 63455.0 63487.7 63585.0 63598.6 16610.3 16986.2 17294.6 17400.2 17973.4 11629.4 11732.6 11756.2 11762.0 11777.0 19760.3 20131.7 20180.7 20185.8 20209.2 7134.7 7151.6 7235.6 7237.1 7295.8 963.5 1067.2 1144.0 1155.7 1197.9 32758.2 33153.7 33207.5 33318.5 33973.0 1128.9 1130.2 1178.6 1181.8 1217.5 17343.9 17373.1 17423.0 17494.6 17511.5 523538.0 526537.0 529659.0 530166.0 534169.0 58958.0 59571.0 59576.7 59631.7 59656.7 1242.7 1278.6 1364.5 1367.4 1368.4 30361.5 34012.5 34149.7 34515.7 34518.3 49800.8 50394.2 50986.5 51033.7 51048.0 390643.0 391662.0 391702.0 392366.0 392466.0 25222.4 27872.4 28712.3 28751.9 29287.7 48012.8 48871.5 49084.0 49453.5 50744.0 40030.6 40615.8 41298.0 41812.8 41831.8 40160.6 40740.6 41030.6 41103.4 41167.6 36904.8 41320.4 41374.0 41907.4 42438.2 33406.5 37355.3 37534.6 37705.2 38289.4 28318.4 28449.4 28499.6 28544.6 28695.6 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#2] jquery.html Cycles:180 Average:27608.56 Median:391.64 stddev:73826.42 (18850.4%) stddev-sans-first:74005.23 08:30:41 INFO - PROCESS | 14833 | Values: 389.9 393.4 396.4 402.4 419.3 13117.8 18145.6 19811.2 19832.6 20033.3 15842.6 16645.7 18408.4 19061.3 19083.2 5493.9 5671.9 5680.2 5680.7 5685.0 5480.2 5509.7 5564.8 5618.8 5620.9 5611.7 5647.4 5653.5 5654.6 5658.2 5455.5 5577.5 5624.1 5625.8 5750.1 5441.6 5604.7 5625.5 5627.2 5635.1 13957.9 14325.9 23198.4 23199.7 23697.2 2155.9 2289.8 2343.5 2511.3 2531.6 9371.3 9418.2 9701.8 10375.5 10455.8 1916.4 1925.2 1946.6 1947.7 1960.3 81594.6 81979.2 84715.0 86809.6 88366.6 10829.4 10979.7 11144.2 11206.4 12070.0 15531.9 15630.3 15710.3 15753.2 15800.6 7746.8 7825.9 8070.6 8099.8 8487.1 7842.3 7901.2 8026.9 8063.8 8114.4 3988.5 4119.1 4256.2 4278.0 4337.6 1919.9 1925.3 1936.0 1938.7 1962.8 873.7 957.3 987.7 1034.0 1053.9 17996.5 19160.6 19540.5 19608.0 19611.3 985.0 1000.8 1008.0 1026.8 1048.2 10416.3 10794.1 10804.1 10841.4 10879.5 407689.0 436925.0 455827.0 458170.0 465607.0 89142.0 90262.0 91938.0 93341.0 94781.0 998.1 1007.4 1015.7 1016.9 1031.8 16524.3 16897.2 17094.7 17164.6 17622.3 41208.6 42109.4 42176.0 42407.2 42413.6 56850.1 57888.4 58571.0 59005.0 59106.7 7877.3 8226.1 8361.8 8391.1 8396.4 9224.0 12863.6 13095.5 13122.7 13411.2 9818.9 11431.5 11436.5 11561.2 11711.9 11176.8 11256.3 11275.5 11370.9 11397.8 11492.5 11724.7 11783.4 11804.3 11955.0 8359.2 8407.3 8460.9 8475.0 8629.6 10856.1 11456.4 11487.3 11687.2 11762.8 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#3] mootools.html Cycles:180 Average:5879.37 Median:4762.08 stddev:3357.24 (70.5%) stddev-sans-first:3349.28 08:30:41 INFO - PROCESS | 14833 | Values: 1334.5 1522.7 1549.2 1695.2 1860.0 8411.9 8870.3 8870.6 9061.6 9072.7 8737.5 8929.0 8936.1 8941.2 8948.5 2059.9 2312.6 2334.1 2378.0 2390.5 2358.9 2360.3 2360.8 2361.1 2365.5 2351.8 2354.0 2378.2 2382.1 2383.1 2035.7 2284.4 2313.1 2345.0 2349.3 2352.8 2356.9 2380.4 2380.4 2382.2 8962.8 9088.6 9101.1 9105.4 9118.2 5184.5 5303.8 5306.2 5308.5 5310.0 3211.1 3432.1 3511.8 3551.8 3589.7 1156.1 1184.9 1186.3 1194.7 1228.3 12278.0 12282.9 12314.7 12325.1 12325.9 4726.8 4732.5 4755.4 4768.8 4844.8 10437.4 10456.1 10475.1 10484.8 10486.3 5278.9 5291.5 5298.5 5300.5 5300.9 4363.9 4709.8 4881.6 4883.3 4941.6 4094.5 4142.7 4180.9 4190.1 4268.5 1288.9 1290.6 1313.1 1317.8 1322.7 822.3 905.0 923.6 946.4 949.1 5551.3 5753.7 5772.0 5869.2 5869.8 965.2 994.6 997.0 1036.7 1077.3 3870.5 3899.1 4005.8 4007.4 4022.6 10962.7 11192.0 11256.5 11376.3 11378.1 11144.9 11147.4 11149.2 11153.7 11155.1 8177.2 8422.5 8506.1 8526.7 8565.6 5534.7 5632.1 5695.2 5840.9 5858.8 9822.3 10154.3 10177.8 10335.4 10418.4 10424.1 10466.6 10470.5 10478.5 10625.0 7027.8 7645.5 7832.8 7857.4 7949.2 8755.5 8806.6 8825.2 8839.8 8855.1 7700.1 7740.1 7795.4 7988.3 7999.6 7323.6 7730.6 7755.3 7879.7 7912.6 6972.2 7165.0 7173.3 7176.3 7196.6 5066.0 5080.5 5317.5 5330.2 5379.2 5192.7 5267.9 5280.0 5318.0 5420.7 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#4] prototype.html Cycles:180 Average:4608.98 Median:5172.85 stddev:1370.45 (26.5%) stddev-sans-first:1335.68 08:30:41 INFO - PROCESS | 14833 | Values: 305.3 323.8 336.3 337.0 343.1 5116.3 5263.6 5265.3 5281.4 5349.8 5249.7 5289.3 5315.7 5320.2 5371.3 4160.3 4183.7 4184.9 4187.7 4210.0 3935.6 3966.5 4171.5 4172.6 4204.3 4106.3 4134.5 4142.4 4150.6 4159.5 4158.4 4160.5 4164.3 4183.3 4194.3 3411.6 3728.5 3732.3 3741.7 3746.7 5063.8 5085.8 5094.1 5098.2 5098.4 4669.7 4693.8 4717.9 4735.2 4736.7 5266.6 5491.5 5525.2 5528.6 5545.8 3967.4 3969.9 3979.4 3981.6 3984.5 5713.7 5742.4 5746.5 5795.3 5806.8 3980.9 4032.1 4066.8 4066.9 4071.9 4057.7 4085.8 4090.8 4122.9 4125.5 4621.0 4637.4 4679.9 4690.0 4697.2 5353.2 5483.5 5483.8 5486.3 5495.6 1315.3 1345.7 1348.2 1356.1 1360.9 904.6 912.6 920.4 929.8 932.9 4786.8 4789.3 4792.3 4801.7 4856.7 4713.2 4987.6 5019.8 5023.5 5038.7 4723.8 4736.8 4741.9 4760.6 4809.8 2665.5 2673.5 2696.5 2741.3 2746.5 5504.8 5941.7 5954.2 5955.7 5958.4 5868.9 5881.3 5885.6 5887.2 5905.8 5689.4 5858.9 5863.8 5902.9 5946.9 5647.7 5675.8 5685.0 5687.5 5743.3 5633.9 5635.6 5639.6 5665.2 5678.8 5672.3 5800.4 5822.8 5888.3 5890.4 3945.0 4034.8 4041.4 4062.6 4081.7 5438.7 5746.5 5752.2 5757.8 5766.8 5482.6 5564.6 5575.2 5575.5 5588.5 5229.4 5368.9 5371.7 5485.0 5521.8 5422.6 5451.4 5536.4 5539.4 5555.9 5369.9 5650.3 5670.5 5673.0 5686.3 5335.3 5493.6 5494.3 5501.7 5512.3 08:30:41 INFO - PROCESS | 14833 | 08:30:41 INFO - PROCESS | 14833 | [#5] yui.html Cycles:180 Average:20032.79 Median:4575.42 stddev:28255.39 (617.5%) stddev-sans-first:28297.59 08:30:41 INFO - PROCESS | 14833 | Values: 757.4 783.7 803.4 828.2 854.6 15462.4 16505.6 16563.8 16634.3 16643.5 13594.3 13608.5 13630.3 14298.7 15203.5 812.1 818.8 824.2 826.5 826.5 672.9 805.5 820.2 820.9 825.4 850.4 851.3 851.3 851.8 852.8 703.9 848.3 849.4 849.5 849.7 613.5 621.5 622.0 622.4 622.8 14260.6 14292.7 14306.6 14318.0 14318.2 13650.4 13697.4 13848.9 14337.8 14482.2 12585.2 12862.5 12866.7 12930.8 13072.7 4378.1 4406.0 4431.6 4468.2 4568.0 74653.1 75262.0 76227.2 76395.0 76685.0 11232.0 11372.3 11546.8 11643.6 11772.1 20403.3 20727.3 20734.5 20735.9 20737.3 8176.4 8203.8 8339.4 8674.6 8782.0 4651.1 4654.0 4803.3 4897.0 4937.7 3656.2 3784.5 3788.4 3795.9 3797.8 653.4 662.2 664.9 670.0 680.3 702.4 720.3 738.6 742.1 749.2 9285.2 9488.8 9521.8 9592.4 9660.5 697.5 705.6 727.6 745.1 753.9 4107.4 4349.3 4467.2 4476.0 4582.9 70059.3 70286.3 87596.0 106796.5 111858.0 99144.0 100896.5 101169.0 102351.0 102412.0 87434.6 87682.6 90126.5 91556.0 92910.0 9094.3 9181.4 9226.6 9259.5 9274.1 43788.0 50185.5 51656.7 52706.0 54744.5 69457.3 69629.7 71261.0 71696.3 72753.0 12606.8 12797.0 12854.9 13159.5 13607.3 13687.5 14006.2 14130.9 14151.3 14456.6 12739.7 12877.5 12957.0 13126.5 13475.9 12567.2 12643.9 12770.9 12951.0 13244.1 12831.4 13287.5 13371.3 13403.9 13813.9 10389.5 10676.2 10749.1 10791.6 11359.8 10608.6 11058.5 11164.7 11199.7 11210.6 08:30:41 INFO - PROCESS | 14833 | -------- Summary: end -------- 08:30:41 INFO - PROCESS | 14833 | 08:30:42 INFO - TEST-INFO | 14833: exit 0 08:30:42 INFO - TEST-OK | dromaeo_css | took 1112905ms 08:30:42 INFO - TEST-START | kraken 08:30:42 INFO - operating with platform_type : linux_ 08:30:42 INFO - Initialising browser for kraken test... 08:30:42 INFO - TEST-INFO | started process 15019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwTufal/profile http://localhost:45786/getInfo.html) 08:30:46 INFO - PROCESS | 15019 | __metrics Screen width/height:1600/1200 08:30:46 INFO - PROCESS | 15019 | colorDepth:24 08:30:46 INFO - PROCESS | 15019 | Browser inner width/height: 1024/697 08:30:46 INFO - PROCESS | 15019 | __metrics 08:30:47 ERROR - PROCESS | 15019 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:30:48 INFO - TEST-INFO | 15019: exit 0 08:30:48 INFO - Browser initialized. 08:30:48 INFO - Running cycle 1/1 for kraken test... 08:30:48 INFO - TEST-INFO | started process 15101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwTufal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:00 INFO - PROCESS | 15101 | RSS: Main: 156266496 08:31:00 INFO - PROCESS | 15101 | 08:31:02 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:03 INFO - PROCESS | 15101 | RSS: Main: 213729280 08:31:03 INFO - PROCESS | 15101 | 08:31:06 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-dft) 08:31:06 INFO - PROCESS | 15101 | RSS: Main: 201277440 08:31:06 INFO - PROCESS | 15101 | 08:31:09 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-fft) 08:31:10 INFO - PROCESS | 15101 | RSS: Main: 269664256 08:31:10 INFO - PROCESS | 15101 | 08:31:12 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45786/tests/kraken/driver.html?testName=audio-oscillator) 08:31:13 INFO - PROCESS | 15101 | RSS: Main: 179732480 08:31:13 INFO - PROCESS | 15101 | 08:31:15 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:15 INFO - PROCESS | 15101 | RSS: Main: 183648256 08:31:15 INFO - PROCESS | 15101 | 08:31:19 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:19 INFO - PROCESS | 15101 | RSS: Main: 218406912 08:31:19 INFO - PROCESS | 15101 | 08:31:22 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45786/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:23 INFO - PROCESS | 15101 | RSS: Main: 220852224 08:31:23 INFO - PROCESS | 15101 | 08:31:26 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45786/tests/kraken/driver.html?testName=json-parse-financial) 08:31:26 INFO - PROCESS | 15101 | RSS: Main: 220999680 08:31:26 INFO - PROCESS | 15101 | 08:31:28 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:29 INFO - PROCESS | 15101 | RSS: Main: 207327232 08:31:29 INFO - PROCESS | 15101 | 08:31:30 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:31 INFO - PROCESS | 15101 | RSS: Main: 210186240 08:31:31 INFO - PROCESS | 15101 | 08:31:33 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:34 INFO - PROCESS | 15101 | RSS: Main: 217837568 08:31:34 INFO - PROCESS | 15101 | 08:31:36 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:37 INFO - PROCESS | 15101 | RSS: Main: 223154176 08:31:37 INFO - PROCESS | 15101 | 08:31:40 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:40 INFO - PROCESS | 15101 | RSS: Main: 224886784 08:31:40 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | Cycle 1(1): loaded http://localhost:45786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45786/tests/kraken/driver.html?testName=ai-astar) 08:31:42 INFO - PROCESS | 15101 | RSS: Main: 267059200 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | __start_tp_report 08:31:42 INFO - PROCESS | 15101 | _x_x_mozilla_page_load 08:31:42 INFO - PROCESS | 15101 | _x_x_mozilla_page_load_details 08:31:42 INFO - PROCESS | 15101 | |i|pagename|runs| 08:31:42 INFO - PROCESS | 15101 | |0;ai-astar;111;105;111;109;110;109;108;109;110;112 08:31:42 INFO - PROCESS | 15101 | |1;audio-beat-detection;161;127;127;178;127;127;149;129;179;127 08:31:42 INFO - PROCESS | 15101 | |2;audio-dft;160;161;162;161;161;161;162;161;162;161 08:31:42 INFO - PROCESS | 15101 | |3;audio-fft;74;74;78;130;74;74;73;74;103;75 08:31:42 INFO - PROCESS | 15101 | |4;audio-oscillator;83;85;119;86;84;85;123;84;84;133 08:31:42 INFO - PROCESS | 15101 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;117;117;117 08:31:42 INFO - PROCESS | 15101 | |6;imaging-darkroom;145;146;146;146;145;146;145;145;146;146 08:31:42 INFO - PROCESS | 15101 | |7;imaging-desaturate;94;94;95;95;95;95;94;95;95;95 08:31:42 INFO - PROCESS | 15101 | |8;json-parse-financial;54;54;54;53;54;53;55;53;53;54 08:31:42 INFO - PROCESS | 15101 | |9;json-stringify-tinderbox;62;62;62;63;63;63;62;63;62;63 08:31:42 INFO - PROCESS | 15101 | |10;stanford-crypto-aes;80;86;78;80;80;81;80;80;132;85 08:31:42 INFO - PROCESS | 15101 | |11;stanford-crypto-ccm;121;121;137;119;118;127;121;128;135;126 08:31:42 INFO - PROCESS | 15101 | |12;stanford-crypto-pbkdf2;159;162;164;160;164;159;161;161;162;159 08:31:42 INFO - PROCESS | 15101 | |13;stanford-crypto-sha256-iterative;64;66;64;63;64;64;64;63;62;62 08:31:42 INFO - PROCESS | 15101 | __end_tp_report 08:31:42 INFO - PROCESS | 15101 | __start_cc_report 08:31:42 INFO - PROCESS | 15101 | _x_x_mozilla_cycle_collect,1592 08:31:42 INFO - PROCESS | 15101 | __end_cc_report 08:31:42 INFO - PROCESS | 15101 | __startTimestamp1464967902593__endTimestamp 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | ------- Summary: start ------- 08:31:42 INFO - PROCESS | 15101 | Number of tests: 14 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.96 (1.8%) stddev-sans-first:1.99 08:31:42 INFO - PROCESS | 15101 | Values: 111.0 105.0 111.0 109.0 110.0 109.0 108.0 109.0 110.0 112.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:139.00 stddev:22.00 (15.8%) stddev-sans-first:22.36 08:31:42 INFO - PROCESS | 15101 | Values: 161.0 127.0 127.0 178.0 127.0 127.0 149.0 129.0 179.0 127.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 08:31:42 INFO - PROCESS | 15101 | Values: 160.0 161.0 162.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.00 stddev:18.86 (25.5%) stddev-sans-first:19.73 08:31:42 INFO - PROCESS | 15101 | Values: 74.0 74.0 78.0 130.0 74.0 74.0 73.0 74.0 103.0 75.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:19.91 (23.7%) stddev-sans-first:20.50 08:31:42 INFO - PROCESS | 15101 | Values: 83.0 85.0 119.0 86.0 84.0 85.0 123.0 84.0 84.0 133.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:31:42 INFO - PROCESS | 15101 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:31:42 INFO - PROCESS | 15101 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:31:42 INFO - PROCESS | 15101 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 08:31:42 INFO - PROCESS | 15101 | Values: 54.0 54.0 54.0 53.0 54.0 53.0 55.0 53.0 53.0 54.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:31:42 INFO - PROCESS | 15101 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 62.0 63.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:80.00 stddev:16.28 (20.4%) stddev-sans-first:17.11 08:31:42 INFO - PROCESS | 15101 | Values: 80.0 86.0 78.0 80.0 80.0 81.0 80.0 80.0 132.0 85.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:6.58 (5.2%) stddev-sans-first:6.80 08:31:42 INFO - PROCESS | 15101 | Values: 121.0 121.0 137.0 119.0 118.0 127.0 121.0 128.0 135.0 126.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:1.91 (1.2%) stddev-sans-first:1.87 08:31:42 INFO - PROCESS | 15101 | Values: 159.0 162.0 164.0 160.0 164.0 159.0 161.0 161.0 162.0 159.0 08:31:42 INFO - PROCESS | 15101 | 08:31:42 INFO - PROCESS | 15101 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 08:31:42 INFO - PROCESS | 15101 | Values: 64.0 66.0 64.0 63.0 64.0 64.0 64.0 63.0 62.0 62.0 08:31:42 INFO - PROCESS | 15101 | -------- Summary: end -------- 08:31:42 INFO - PROCESS | 15101 | 08:31:43 INFO - TEST-INFO | 15101: exit 0 08:31:43 INFO - TEST-OK | kraken | took 60980ms 08:31:43 INFO - SUITE-END | took 1173s 08:31:43 INFO - Completed test suite (00:19:34) 08:31:43 INFO - javascript benchmark 08:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.3870395272925, 3146.842657867107, 3146.8583913723864, 3178.825164615945, 3206.470932296171, 5355.946440535594, 5382.192671099337, 5389.649672771267, 5465.808696695616, 5504.091824848905, 5475.5072043516075, 5494.945050549493, 5496.285482887219, 5500.5874559408, 5521.3926468088475, 4935.062338155757, 4961.677490963076, 5023.472535383787, 5033.320501732274, 5156.53591176794, 5045.672031317952, 5062.063518249117, 5096.3884333879805, 5111.258867464216, 5120.103981803189, 4874.585660218886, 4895.5838753705975, 4942.481039490855, 4944.480829512885, 4956.925646115311, 4955.578775804061, 4982.202847544376, 5052.393712754493, 5058.241263810458, 5086.54221120101, 4831.685940413897, 4985.626078044125, 4999.125153098194, 5028.472010438924, 5062.468440813698, 5355.143177091685, 5405.27028851104, 5415.83752487426, 5507.697076660782, 5507.972460137674, 5842.591018628697, 5862.560307976876, 5878.941210587882, 5884.117382392633, 5898.262717160355, 5800.59395842287, 5880.912031274185, 5910.940890591082, 5928.081147422156, 5932.9406705932815, 5540.141278101901, 5635.71821408932, 5636.210930469738, 5637.689927054011, 5644.125160600113, 6110.1034462138705, 6116.082587611894, 6119.969325458895, 6129.540284478593, 6137.956547386955, 5625.09998400254, 5664.405237450091, 5685.374608793029, 5927.555433342431, 5931.614445061057, 5814.738336774855, 5815.214945982323, 5820.563457740602, 5865.648061116347, 5874.295084589877, 5751.884962300731, 5780.046292361713, 5790.334111577138, 5794.0, 5798.33319168301, 5610.887782244332, 5792.681402522901, 5829.242198514251, 5857.765689372377, 5877.265341832271, 4455.643548516111, 4468.195724769507, 4468.798904049326, 4471.128130014616, 4509.594136527663, 3937.8621748238675, 3959.6238357356006, 3983.8406463741126, 4013.1973605279063, 4027.0536423940353, 5497.890042199134, 5542.944570554324, 5559.166125081189, 5636.013697602903, 5639.069553523705, 5949.8215053548465, 5963.314218864886, 5979.0, 6000.849978750479, 6058.878822423527, 5631.915521267184, 5641.323041235078, 5642.0, 5647.181158731961, 5650.85872853182, 4861.538153875376, 4879.2925025871045, 4913.975430122827, 4926.310316555685, 4931.778069986859, 6101.755929762849, 6107.144999700045, 6109.908351374733, 6111.84720381994, 6133.3866613338305, 5753.539716822728, 5908.4682378586995, 5916.290045194604, 5921.259842519685, 5923.141144534105, 5999.400059993965, 6022.337542870193, 6025.487833534199, 6104.32852386246, 6116.082587611894, 5773.422657734361, 5790.710464476843, 5796.565257605612, 5797.101449275369, 5811.476967072984, 5690.118031705092, 5876.588638795243, 5915.142304365929, 5950.077737950624, 5951.256092988377, 5797.072468405035, 5836.737346819488, 5849.5612829037145, 5850.23946886919, 5901.380355062828, 5761.884762304647, 5775.480206781242, 5778.451047150514, 5779.422057794187, 5791.8552036199435, 5540.695261760642, 5588.050031494575, 5614.410486898817, 5712.0860662293835, 5718.285214348207, 5805.477507024219, 5835.2122463466885, 5841.415858414124, 5847.532197424111, 5850.619709719025, 5628.155776633538, 5654.46282603152, 5661.122526008476, 5661.801836935688, 5672.688002159921], "value": 5419.641313180056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5681595619241, 616.6916541729136, 618.9910445973063, 627.1032423634205, 630.2090875950681, 32527.512087318708, 35519.82240088802, 35531.4670279946, 43985.34021989673, 45093.77453112738, 46548.301775473396, 46612.203267803874, 46973.53026469734, 47055.0, 47090.058198836006, 8609.698660546883, 8766.123387661215, 8787.121287871194, 8792.912070879305, 8792.956035219815, 8724.38929274951, 8845.823083538326, 8869.157430044168, 8871.290296776242, 8873.29013678904, 8856.291496680251, 8889.0, 8913.0, 8915.42049766763, 8915.95542022289, 8816.559172041372, 8853.11468853116, 8875.511846848422, 8879.689210877588, 8879.866801997976, 8763.649454021832, 8868.733937981871, 8874.334424918092, 8880.111988801069, 8884.911150888538, 42566.36150457746, 43008.56991430108, 43073.56926430727, 43096.78451607753, 43103.78448107771, 3477.7739446935866, 3588.4617307403837, 3655.4151335786146, 3812.980935095307, 3964.345882929313, 32076.198095047577, 32750.836245818617, 33248.0, 34199.82900085508, 34219.14452138716, 4235.57644235577, 4337.891552711176, 4383.0, 4396.912061758779, 4525.298578720271, 344107.0, 345367.0, 347255.0, 347356.0, 347683.0, 60772.0, 61169.69415152896, 61590.0, 61746.69126654428, 61753.38246617566, 62837.0, 63455.0, 63487.68256158782, 63585.0, 63598.64013598603, 16610.252538635792, 16986.235619397157, 17294.567635809206, 17400.21699023547, 17973.37093201732, 11629.418529073682, 11732.648020559396, 11756.23584467007, 11762.0, 11777.0, 19760.308389206308, 20131.698024529353, 20180.69728954067, 20185.798142018684, 20209.191632334543, 7134.678939447737, 7151.606661633556, 7235.6020418876415, 7237.095363079615, 7295.832666773291, 963.5230560872413, 1067.236925598201, 1144.0332918683698, 1155.7110722319421, 1197.8802119788127, 32758.181045474055, 33153.66846331554, 33207.501887471706, 33318.50022249668, 33973.0, 1128.90968722502, 1130.2483848240993, 1178.6051672689746, 1181.772359103097, 1217.5292484632268, 17343.913280433768, 17373.13134343278, 17423.0, 17494.562635934202, 17511.474655760347, 523538.0, 526537.0, 529659.0, 530166.0, 534169.0, 58958.0, 59571.0, 59576.70211648914, 59631.70184149052, 59656.70171649114, 1242.7328124453286, 1278.571678487717, 1364.4951367993906, 1367.43934986655, 1368.438940034581, 30361.544576831806, 34012.48981265332, 34149.658503415645, 34515.65484345225, 34518.30963380668, 49800.75099624479, 50394.244086338, 50986.490135098175, 51033.74483127561, 51048.0, 390643.0, 391662.0, 391702.0, 392366.0, 392466.0, 25222.369440763392, 27872.44255114927, 28712.282192945342, 28751.856240718662, 29287.7071229285, 48012.7599362001, 48871.5112848867, 49084.0, 49453.50546494633, 50744.0, 40030.59969400269, 40615.79692101521, 41298.0, 41812.79093604512, 41831.7908410456, 40160.59839401685, 40740.59259407368, 41030.58969410268, 41103.38344924888, 41167.588324116376, 36904.81547592245, 41320.38019429771, 41374.0, 41907.37138942979, 42438.151236975704, 33406.498902515996, 37355.252894942496, 37534.6246537542, 37705.245895082495, 38289.425658614586, 28318.43363132767, 28449.43101138007, 28499.572506412005, 28544.57183142296, 28695.569566456103], "value": 20279.979682733658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.8908305674411, 393.39613692981277, 396.4172666180715, 402.3943964333677, 419.2516358300434, 13117.764888924818, 18145.63708725825, 19811.20755169793, 19832.60334793305, 20033.298834540794, 15842.603934901605, 16645.66708665829, 18408.447746567592, 19061.332853350137, 19083.236670533162, 5493.890122197554, 5671.914921276163, 5680.176374425706, 5680.744366503496, 5684.971575142118, 5480.205370221315, 5509.669419834822, 5564.8052318168875, 5618.831435056934, 5620.9437905621035, 5611.7474713637785, 5647.407022262665, 5653.547716182696, 5654.6041777075625, 5658.151277308416, 5455.454454554513, 5577.52591029761, 5624.100143976964, 5625.831225063234, 5750.137479378085, 5441.646292990982, 5604.663720176803, 5625.5499560035505, 5627.155926611041, 5635.070213414781, 13957.930210348984, 14325.856741432557, 23198.420039499146, 23199.652005219934, 23697.170599029123, 2155.89220538974, 2289.782470665284, 2343.5430091132066, 2511.296836885657, 2531.5949448088218, 9371.250299976055, 9418.152366286999, 9701.757456063655, 10375.481225938673, 10455.84316235257, 1916.425072478251, 1925.2491528303972, 1946.6106778644328, 1947.6688962876344, 1960.284496158906, 81594.59202703949, 81979.18020819775, 84715.0, 86809.56595217047, 88366.5581672094, 10829.404382759023, 10979.670609881716, 11144.2199046066, 11206.439678016066, 12070.0, 15531.922340388226, 15630.296636651377, 15710.293036813371, 15753.188383336063, 15800.604984875241, 7746.806329841686, 7825.882611760828, 8070.636821343053, 8099.838003239902, 8487.066422693499, 7842.294193522496, 7901.249381308767, 8026.919730802734, 8063.83872322562, 8114.431989760778, 3988.501437320335, 4119.134981653826, 4256.233877901946, 4277.978610106992, 4337.566243375701, 1919.9040047997823, 1925.258775371464, 1936.0, 1938.70919362094, 1962.833159181457, 873.6767396063498, 957.2809634569746, 987.6543209876629, 1034.0125180452649, 1053.910417614496, 17996.460106196835, 19160.616787664447, 19540.511487212934, 19608.0, 19611.313604024075, 984.9950750246346, 1000.7598176437602, 1008.037324355239, 1026.7587117027492, 1048.1667074675652, 10416.270861039655, 10794.136469082454, 10804.135669146606, 10841.403722795321, 10879.510422031028, 407689.0, 436925.0, 455827.0, 458170.0, 465607.0, 89142.0, 90262.0, 91938.0, 93341.0, 94781.0, 998.1017084623752, 1007.4459047523833, 1015.6851376073441, 1016.9373005209721, 1031.8400647899587, 16524.339026438807, 16897.239624216694, 17094.743578846577, 17164.570885727957, 17622.295108196042, 41208.58791412047, 42109.36835947402, 42175.99999999877, 42407.151856963304, 42413.57586424219, 56850.14724779214, 57888.421115788304, 58571.0, 59005.0, 59106.70446647739, 7877.251661092187, 8226.136255693305, 8361.83276334482, 8391.118932511998, 8396.412251142361, 9224.0, 12863.614091577268, 13095.476180952655, 13122.671933201746, 13411.195328280335, 9818.85271720939, 11431.542738290374, 11436.485358158736, 11561.190716649753, 11711.88288117108, 11176.832347514957, 11256.268342557707, 11275.548978040786, 11370.886291136983, 11397.772044559228, 11492.48283827213, 11724.70688232767, 11783.410829458664, 11804.291742495478, 11955.0, 8359.205875441823, 8407.285380742705, 8460.932584993228, 8475.0, 8629.56852157377, 10856.131509479064, 11456.427178641201, 11487.25332853362, 11687.240329378563, 11762.764744704888], "value": 9037.949200936457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.459543884727, 1522.687848990957, 1549.2331296008476, 1695.186310570926, 1860.0, 8411.91588084119, 8870.290376769852, 8870.645174193032, 9061.592228349724, 9072.682456114037, 8737.475751454902, 8928.955355223232, 8936.10638936106, 8941.150590693873, 8948.507832069234, 2059.9485012874648, 2312.6184179610345, 2334.089705015041, 2377.988110059447, 2390.5457962987066, 2358.929232123039, 2360.3155085025323, 2360.822938279627, 2361.102780943239, 2365.4914193448403, 2351.8000969917493, 2354.023080421623, 2378.1795280628244, 2382.1305223593436, 2383.07060246504, 2035.714999900015, 2284.4060544258446, 2313.109452860644, 2344.976550234493, 2349.283468542094, 2352.8235382346393, 2356.9175078872327, 2380.369202161429, 2380.4286971126976, 2382.237683941122, 8962.775930601721, 9088.591013404413, 9101.089891010912, 9105.36262461628, 9118.179363857285, 5184.481551844785, 5303.761330740087, 5306.230596563477, 5308.5487733542695, 5310.017646735328, 3211.1329940916057, 3432.1248081739245, 3511.7541772075965, 3551.786892786441, 3589.6589823966683, 1156.1329003247565, 1184.9052075833913, 1186.2822992089834, 1194.737157825277, 1228.3060071059822, 12278.0, 12282.938585307105, 12314.692132696664, 12325.137240393176, 12325.938370308091, 4726.834560790356, 4732.503087175865, 4755.358026666425, 4768.8086249172875, 4844.8304309349705, 10437.425941573134, 10456.058954694114, 10475.114479393782, 10484.842727359095, 10486.26596138263, 5278.947210527922, 5291.523762861284, 5298.549623281987, 5300.549453296513, 5300.92048619271, 4363.869083927487, 4709.835155769531, 4881.585065269492, 4883.340748998839, 4941.579965702884, 4094.549599544048, 4142.730722503027, 4180.853670121531, 4190.057237121623, 4268.487781466244, 1288.9419976101099, 1290.5676598339662, 1313.0939651640529, 1317.8352705911761, 1322.7090040191335, 822.284612387215, 905.0451773379148, 923.612082925173, 946.4368700623119, 949.0651708067548, 5551.25058117149, 5753.683547404933, 5772.0, 5869.178315035899, 5869.8239052828485, 965.2374624047064, 994.5922171909482, 996.9551370188359, 1036.740814796301, 1077.3320541264309, 3870.53553573573, 3899.0642245861354, 4005.759654420744, 4007.3788562772816, 4022.61785130418, 10962.671119866416, 11192.0, 11256.549738010552, 11376.260543064674, 11378.146639002109, 11144.944275278734, 11147.38689372076, 11149.16381271408, 11153.72115697114, 11155.107591392669, 8177.182281771775, 8422.536760478233, 8506.106858779738, 8526.744197673956, 8565.614547345385, 5534.667919924817, 5632.127020311858, 5695.202671625892, 5840.853978650568, 5858.765649374148, 9822.312438129262, 10154.289199755945, 10177.796444071226, 10335.379877207391, 10418.374897506174, 10424.061834434937, 10466.581336746749, 10470.476476176313, 10478.528466219192, 10625.0, 7027.821375373651, 7645.464817462725, 7832.843343132991, 7857.371410287049, 7949.165337639464, 8755.474671519474, 8806.60370283326, 8825.249853762502, 8839.779005524913, 8855.114488551093, 7700.114486834086, 7740.14858365568, 7795.415343849348, 7988.254031455491, 7999.600019999093, 7323.597202153933, 7730.613469326624, 7755.2632499912415, 7879.684812607432, 7912.604369781603, 6972.233054363915, 7165.0, 7173.3185347394, 7176.282371762991, 7196.568205907663, 5065.974670126626, 5080.517350851663, 5317.548008419173, 5330.227117067926, 5379.220013098157, 5192.663301514258, 5267.947320526899, 5280.023195708806, 5318.042752304467, 5420.728963551728], "value": 4701.609377009335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.34503490013935, 323.81542520763145, 336.3307019032126, 336.9966300336997, 343.1027862140502, 5116.309298244736, 5263.578913686905, 5265.289185959894, 5281.392639846419, 5349.839504814857, 5249.711265880375, 5289.285946397235, 5315.681059136455, 5320.17537281722, 5371.328583927009, 4160.292750232453, 4183.665306775466, 4184.895377615569, 4187.74873507589, 4209.9789501052455, 3935.5867633898456, 3966.5438474575362, 4171.519110715698, 4172.645325147366, 4204.285271503836, 4106.260873042851, 4134.4625198724125, 4142.396115379624, 4150.605692459227, 4159.48178914697, 4158.4178215049915, 4160.479940007499, 4164.271827191712, 4183.309753890604, 4194.2869712149, 3411.624721280657, 3728.5339332583426, 3732.2908647356917, 3741.6632503074584, 3746.737728359016, 5063.822766203165, 5085.847424577269, 5094.108531007096, 5098.1842905135, 5098.439171691148, 4669.735178438455, 4693.835715749967, 4717.858464246078, 4735.195016847109, 4736.739479328636, 5266.631335806495, 5491.478309560585, 5525.2264682944015, 5528.585356098309, 5545.833624991256, 3967.4247234151176, 3969.9007524811823, 3979.422983667352, 3981.601839816024, 3984.4620976168135, 5713.657180569221, 5742.368339482654, 5746.454086861741, 5795.3045634523705, 5806.796762113348, 3980.9402858957137, 4032.1129351542613, 4066.7763273019677, 4066.8576599818866, 4071.900586841536, 4057.69567282455, 4085.752835940221, 4090.8159132839096, 4122.855700050483, 4125.50493940729, 4621.0, 4637.39713837199, 4679.883002924954, 4689.976550117228, 4697.154512187771, 5353.162823703444, 5483.533899618577, 5483.7806487740845, 5486.31421072366, 5495.642783219078, 1315.302889468583, 1345.7106722054805, 1348.1708749119416, 1356.1117468058437, 1360.8775210231126, 904.5522466379184, 912.5802131019673, 920.4339331311329, 929.7907970706672, 932.8507438809758, 4786.832460863853, 4789.281607758794, 4792.329073929653, 4801.7118972861745, 4856.708597484162, 4713.151632706077, 4987.576056035277, 5019.84940451787, 5023.472535383732, 5038.6976781392505, 4723.7874295656775, 4736.763161841963, 4741.881452963704, 4760.595349395271, 4809.807607695723, 2665.4935562243113, 2673.451942351813, 2696.474187533451, 2741.2735625059377, 2746.491898998692, 5504.7522861470525, 5941.732622032019, 5954.166416701579, 5955.731992060368, 5958.421018430119, 5868.882622347529, 5881.323647780475, 5885.5585831062845, 5887.17415640495, 5905.7932972346625, 5689.350088474296, 5858.853528661817, 5863.765449381977, 5902.852428689317, 5946.910796338058, 5647.745851436777, 5675.829725108253, 5685.0, 5687.488126068673, 5743.310802703702, 5633.887322253614, 5635.605507614428, 5639.577031722555, 5665.206871037975, 5678.77284908599, 5672.290963629546, 5800.4489573490455, 5822.82531524055, 5888.3228428731245, 5890.410958904075, 3945.0, 4034.818433170573, 4041.4341992121713, 4062.614051665087, 4081.6938729594804, 5438.742921687455, 5746.454086861741, 5752.165935939349, 5757.769689212385, 5766.826995190151, 5482.616216864782, 5564.553216163908, 5575.1915972184615, 5575.526080283222, 5588.451333403237, 5229.398619158694, 5368.946310536845, 5371.650842695212, 5484.972575137099, 5521.806736764194, 5422.6475279106735, 5451.4276001019325, 5536.418676039119, 5539.418361072029, 5555.944440555704, 5369.946300536944, 5650.26546548946, 5670.461306175906, 5672.971635141798, 5686.289213848269, 5335.33308336458, 5493.642913210629, 5494.313210848644, 5501.697406642673, 5512.33851937754], "value": 4169.641345824427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.3562471898883, 783.6708582395394, 803.3733687723578, 828.2380210206609, 854.5812551849596, 15462.381504739811, 16505.587360315967, 16563.751543726823, 16634.25145868437, 16643.500694979153, 13594.252316122635, 13608.523701670443, 13630.250336231504, 14298.714025719506, 15203.54389368318, 812.1431889356726, 818.8280461103176, 824.2128767027474, 826.4545400035947, 826.5040975414734, 672.9226138994005, 805.5448671500584, 820.2248874813274, 820.8973878265217, 825.3603457320595, 850.4429598612918, 851.259404318244, 851.2849206666399, 851.8168593752342, 852.8166444214493, 703.9401650859683, 848.3128665780706, 849.371465115816, 849.464837152593, 849.6601359456205, 613.4816080412045, 621.4934828115072, 622.0110025060176, 622.4087117238641, 622.8380621038563, 14260.643483912881, 14292.714145717131, 14306.642333941734, 14318.0, 14318.212498312589, 13650.385732642055, 13697.383617737127, 13848.930755346159, 14337.78493322601, 14482.203478808662, 12585.24488530691, 12862.549810756578, 12866.742665146645, 12930.806037909439, 13072.673183170402, 4378.1462614790125, 4405.977970110161, 4431.6233120184825, 4468.240399132155, 4567.977160114211, 74653.1336716581, 75262.0, 76227.23772762313, 76395.0, 76685.0, 11232.0, 11372.31766094037, 11546.76906461866, 11643.592474263529, 11772.117091218193, 20403.285884993955, 20727.27454539084, 20734.48163795887, 20735.8963205183, 20737.27419540339, 8176.3867709922, 8203.753887383387, 8339.416240863082, 8674.56627168639, 8781.956090219508, 4651.069786042805, 4653.95346046542, 4803.279508073817, 4896.975515122402, 4937.679050861682, 3656.195636959918, 3784.526934133233, 3788.3938569829247, 3795.9430608540893, 3797.7531460454984, 653.3792896748108, 662.1788981662703, 664.8670265946733, 670.0184230102923, 680.3026897430174, 702.3503259484957, 720.2725247499958, 738.6048464071696, 742.109468637637, 749.2170681637592, 9285.225461938404, 9488.810223795486, 9521.809563808685, 9592.424454532611, 9660.516974151264, 697.4699228586311, 705.5837056136801, 727.5998200989541, 745.0835472368908, 753.9170691223961, 4107.424960505532, 4349.347597860283, 4467.173572889026, 4475.980898489546, 4582.862514124582, 70059.29940700528, 70286.297137029, 87596.0, 106796.46601766942, 111858.0, 99144.0, 100896.4955175234, 101169.0, 102351.0, 102412.0, 87434.56282718673, 87682.56158719165, 90126.54936725274, 91556.0, 92910.0, 9094.317926155432, 9181.357304988855, 9226.630934762534, 9259.53702314895, 9274.118958698913, 43788.0, 50185.49814501954, 51656.74171629268, 52706.0, 54744.45255547394, 69457.3054269471, 69629.65185174042, 71261.0, 71696.28303716896, 72753.0, 12606.810897836356, 12797.0, 12854.871451285368, 13159.53941612039, 13607.251601162032, 13687.533087610936, 14006.229657368942, 14130.858691412954, 14151.292435377984, 14456.566303010926, 12739.74520509566, 12877.484900603871, 12957.0, 13126.540571079966, 13475.932620336836, 12567.183133096685, 12643.93678031604, 12770.936145319214, 12950.963922885958, 13244.139130956457, 12831.422585983466, 13287.534936277183, 13371.264580448169, 13403.932980335036, 13813.930930345285, 10389.480525973822, 10676.199285053497, 10749.14006879432, 10791.56833726642, 11359.829602556134, 10608.628697995533, 11058.538185505013, 11164.665060048212, 11199.72000699989, 11210.607628732956], "value": 7501.572036145773, "unit": "score"}], "name": "dromaeo_css", "value": 7257.299953294696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 109.0, 110.0, 109.0, 108.0, 109.0, 110.0, 112.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 127.0, 178.0, 127.0, 127.0, 149.0, 129.0, 179.0, 127.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 130.0, 74.0, 74.0, 73.0, 74.0, 103.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 119.0, 86.0, 84.0, 85.0, 123.0, 84.0, 84.0, 133.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 78.0, 80.0, 80.0, 81.0, 80.0, 80.0, 132.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 137.0, 119.0, 118.0, 127.0, 121.0, 128.0, 135.0, 126.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 164.0, 160.0, 164.0, 159.0, 161.0, 161.0, 162.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 62.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1502.9, "alertThreshold": 2.0}]} 08:31:43 INFO - Return code: 0 08:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:43 ERROR - # TBPL SUCCESS # 08:31:43 INFO - Running post-action listener: _resource_record_post_action 08:31:43 INFO - ##### 08:31:43 INFO - ##### Finished run-tests step (success) 08:31:43 INFO - ##### 08:31:43 INFO - Running post-run listener: _resource_record_post_run 08:31:43 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550699008; Read time: 12; Write time: 403720 08:31:43 INFO - TinderboxPrint: CPU usage
13.2% 08:31:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:31:43 INFO - TinderboxPrint: I/O write bytes / time
550,699,008 / 403,720 08:31:43 INFO - TinderboxPrint: CPU idle
8,260.0 (86.8%) 08:31:43 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 08:31:43 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 197218304; Read time: 0; Write time: 214180 08:31:43 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293318656; Read time: 12; Write time: 169744 08:31:44 INFO - Running post-run listener: _upload_blobber_files 08:31:44 INFO - Blob upload gear active. 08:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:44 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 08:31:44 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'] 08:31:44 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 08:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:45 INFO - (blobuploader) - INFO - Done attempting. 08:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:50 INFO - (blobuploader) - INFO - Done attempting. 08:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:51 INFO - (blobuploader) - INFO - Done attempting. 08:31:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:51 INFO - Return code: 0 08:31:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46689aa89da3dc771980a65f9ba1670229033ccddadcbfe3ce3a7f0bdcc654d6a0c5208d570065c77003091753a8f9fb46f588d990f689d940fc3a7d90eec6c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dfcc765cb5544b2c8adb3bd2cbe71b0d099ddffe68872ce7ad9c0dd4bd8572ae589a2abed96c140c3357375ab535e913a6b4646bbd9c1cbdda68a5e745d7bae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d03e5684455f8bb10a8a72c6ab4b27928b9d69f74a2bebb6efe151b937b5134887d4d01716683eb15a9fe97a6d0bfe5ea0b710bb6177f657a86fd313646791"} 08:31:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:51 INFO - Contents: 08:31:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46689aa89da3dc771980a65f9ba1670229033ccddadcbfe3ce3a7f0bdcc654d6a0c5208d570065c77003091753a8f9fb46f588d990f689d940fc3a7d90eec6c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dfcc765cb5544b2c8adb3bd2cbe71b0d099ddffe68872ce7ad9c0dd4bd8572ae589a2abed96c140c3357375ab535e913a6b4646bbd9c1cbdda68a5e745d7bae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d03e5684455f8bb10a8a72c6ab4b27928b9d69f74a2bebb6efe151b937b5134887d4d01716683eb15a9fe97a6d0bfe5ea0b710bb6177f657a86fd313646791"} 08:31:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:51 INFO - Copying logs to upload dir... 08:31:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.964486 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-03 08:31:51.726266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 08:31:51.729951) ========= 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=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46689aa89da3dc771980a65f9ba1670229033ccddadcbfe3ce3a7f0bdcc654d6a0c5208d570065c77003091753a8f9fb46f588d990f689d940fc3a7d90eec6c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dfcc765cb5544b2c8adb3bd2cbe71b0d099ddffe68872ce7ad9c0dd4bd8572ae589a2abed96c140c3357375ab535e913a6b4646bbd9c1cbdda68a5e745d7bae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d03e5684455f8bb10a8a72c6ab4b27928b9d69f74a2bebb6efe151b937b5134887d4d01716683eb15a9fe97a6d0bfe5ea0b710bb6177f657a86fd313646791"} build_url:https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/WP2Ilp0jQ4eDbNgq8ejirw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46689aa89da3dc771980a65f9ba1670229033ccddadcbfe3ce3a7f0bdcc654d6a0c5208d570065c77003091753a8f9fb46f588d990f689d940fc3a7d90eec6c1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dfcc765cb5544b2c8adb3bd2cbe71b0d099ddffe68872ce7ad9c0dd4bd8572ae589a2abed96c140c3357375ab535e913a6b4646bbd9c1cbdda68a5e745d7bae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3d03e5684455f8bb10a8a72c6ab4b27928b9d69f74a2bebb6efe151b937b5134887d4d01716683eb15a9fe97a6d0bfe5ea0b710bb6177f657a86fd313646791"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 08:31:51.755098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:31:51.755425) ========= 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=6dbc10da6d83fee962c624be000001a8-1464966331.84393-784776692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 08:31:51.840450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 08:31:51.840774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 08:31:51.841075) ========= ========= Total master_lag: 0.18 =========