builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1467040726.33 results: success (0) buildid: 20160627053006 builduid: a67037abe1d24321b35362d85663932b revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.330998) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.331455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.331776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.389167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.389478) ========= 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=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:18:46-- 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% 67.0M=0s 2016-06-27 08:18:46 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100515 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.519601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.519967) ========= 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=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014563 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.591316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:46.591684) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --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 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --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=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:18:46,806 truncating revision to first 12 chars 2016-06-27 08:18:46,806 Setting DEBUG logging. 2016-06-27 08:18:46,806 attempt 1/10 2016-06-27 08:18:46,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/507d73e670e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:18:47,130 unpacking tar archive at: fx-team-507d73e670e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664754 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:47.286113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:47.286551) ========= script_repo_revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:47.287056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:47.287427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:47.298016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-27 08:18:47.298414) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:47 INFO - MultiFileLogger online at 20160627 08:18:47 in /builds/slave/test 08:18:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:18:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:47 INFO - {'append_to_log': False, 08:18:47 INFO - 'base_work_dir': '/builds/slave/test', 08:18:47 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:47 INFO - 'branch': 'Fx-Team', 08:18:47 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:47 INFO - 'config_files': ('talos/linux_config.py',), 08:18:47 INFO - 'default_actions': ('clobber', 08:18:47 INFO - 'read-buildbot-config', 08:18:47 INFO - 'download-and-extract', 08:18:47 INFO - 'populate-webroot', 08:18:47 INFO - 'create-virtualenv', 08:18:47 INFO - 'install', 08:18:47 INFO - 'run-tests'), 08:18:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:47 INFO - 'download_minidump_stackwalk': True, 08:18:47 INFO - 'download_symbols': 'ondemand', 08:18:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:47 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:47 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:47 INFO - 'installer_path': 'installer.exe', 08:18:47 INFO - 'log_level': 'info', 08:18:47 INFO - 'log_name': 'talos', 08:18:47 INFO - 'log_to_console': True, 08:18:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:47 INFO - 'opt_config_files': (), 08:18:47 INFO - 'pip_index': False, 08:18:47 INFO - 'sps_profile': False, 08:18:47 INFO - 'sps_profile_interval': 0, 08:18:47 INFO - 'suite': 'dromaeojs-e10s', 08:18:47 INFO - 'system_bits': '32', 08:18:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:47 INFO - 'title': 'talos-linux64-ix-048', 08:18:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:47 INFO - 'use_talos_json': True, 08:18:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:47 INFO - 'work_dir': 'build'} 08:18:47 INFO - ##### 08:18:47 INFO - ##### Running clobber step. 08:18:47 INFO - ##### 08:18:47 INFO - Running pre-action listener: _resource_record_pre_action 08:18:47 INFO - Running main action method: clobber 08:18:47 INFO - rmtree: /builds/slave/test/build 08:18:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:48 INFO - Running post-action listener: _resource_record_post_action 08:18:48 INFO - ##### 08:18:48 INFO - ##### Finished clobber step (success) 08:18:48 INFO - ##### 08:18:48 INFO - ##### 08:18:48 INFO - ##### Running read-buildbot-config step. 08:18:48 INFO - ##### 08:18:48 INFO - Running pre-action listener: _resource_record_pre_action 08:18:48 INFO - Running main action method: read_buildbot_config 08:18:48 INFO - Using buildbot properties: 08:18:48 INFO - { 08:18:48 INFO - "project": "", 08:18:48 INFO - "product": "firefox", 08:18:48 INFO - "script_repo_revision": "production", 08:18:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:18:48 INFO - "repository": "", 08:18:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:18:48 INFO - "buildid": "20160627053006", 08:18:48 INFO - "pgo_build": "True", 08:18:48 INFO - "basedir": "/builds/slave/test", 08:18:48 INFO - "buildnumber": 868, 08:18:48 INFO - "slavename": "talos-linux64-ix-048", 08:18:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:18:48 INFO - "platform": "ubuntu64_hw", 08:18:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:18:48 INFO - "branch": "fx-team", 08:18:48 INFO - "repo_path": "integration/fx-team", 08:18:48 INFO - "revision": "507d73e670e6b25171aa135d8cf809ff3f3bf8dd", 08:18:48 INFO - "stage_platform": "linux64-pgo", 08:18:48 INFO - "builduid": "a67037abe1d24321b35362d85663932b", 08:18:48 INFO - "slavebuilddir": "test" 08:18:48 INFO - } 08:18:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:18:48 INFO - Running post-action listener: _resource_record_post_action 08:18:48 INFO - ##### 08:18:48 INFO - ##### Finished read-buildbot-config step (success) 08:18:48 INFO - ##### 08:18:48 INFO - ##### 08:18:48 INFO - ##### Running download-and-extract step. 08:18:48 INFO - ##### 08:18:48 INFO - Running pre-action listener: _resource_record_pre_action 08:18:48 INFO - Running main action method: download_and_extract 08:18:48 INFO - mkdir: /builds/slave/test/build/tests 08:18: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:18:48 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:18:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:18:50 INFO - Downloaded 1361 bytes. 08:18:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:50 INFO - Using the following test package requirements: 08:18:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:18:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'jsshell-linux-x86_64.zip'], 08:18:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:50 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:18:51 INFO - Downloaded 24279315 bytes. 08:18:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:18:53 INFO - Return code: 0 08:18:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:53 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:18:59 INFO - Downloaded 24279315 bytes. 08:18:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:19:00 INFO - Return code: 0 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:00 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:19:02 INFO - Downloaded 14405240 bytes. 08:19:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:19:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:19:02 INFO - Return code: 0 08:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:02 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:19:04 INFO - Downloaded 60190590 bytes. 08:19:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:04 INFO - mkdir: /builds/slave/test/properties 08:19:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:04 INFO - Contents: 08:19:04 INFO - build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:19:06 INFO - Running post-action listener: _resource_record_post_action 08:19:06 INFO - Running post-action listener: set_extra_try_arguments 08:19:06 INFO - ##### 08:19:06 INFO - ##### Finished download-and-extract step (success) 08:19:06 INFO - ##### 08:19:06 INFO - ##### 08:19:06 INFO - ##### Running populate-webroot step. 08:19:06 INFO - ##### 08:19:06 INFO - Running pre-action listener: _resource_record_pre_action 08:19:06 INFO - Running main action method: populate_webroot 08:19:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:06 INFO - '--tppagecycles', 08:19:06 INFO - '7'], 08:19:06 INFO - 'tests': ['tsvgm']}}, 08:19:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:19:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:19:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['damp', 'tps']}, 08:19:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'tests': ['damp', 'tps']}, 08:19:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['dromaeo_dom']}, 08:19:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['basic_compositor_video']}, 08:19:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:19:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['a11yr', 08:19:06 INFO - 'ts_paint', 08:19:06 INFO - 'tpaint', 08:19:06 INFO - 'sessionrestore', 08:19:06 INFO - 'sessionrestore_no_auto_restore', 08:19:06 INFO - 'tabpaint']}, 08:19:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['tsvgx', 08:19:06 INFO - 'tsvgr_opacity', 08:19:06 INFO - 'tart', 08:19:06 INFO - 'tscrollx', 08:19:06 INFO - 'cart']}, 08:19:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:19:06 INFO - 'tsvgr_opacity', 08:19:06 INFO - 'tart', 08:19:06 INFO - 'tscrollx', 08:19:06 INFO - 'cart']}, 08:19:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'talos_options': ['--disable-e10s'], 08:19:06 INFO - 'tests': ['tp5o']}, 08:19:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'tests': ['tp5o']}, 08:19:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'talos_options': ['--disable-e10s', 08:19:06 INFO - '--xperf_path', 08:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:06 INFO - 'tests': ['tp5n']}, 08:19:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:06 INFO - 'talos_options': ['--xperf_path', 08:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:06 INFO - 'tests': ['tp5n']}}, 08:19:06 INFO - 'talos.zip': {'path': '', 08:19:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:06 INFO - Running post-action listener: _resource_record_post_action 08:19:06 INFO - ##### 08:19:06 INFO - ##### Finished populate-webroot step (success) 08:19:06 INFO - ##### 08:19:06 INFO - ##### 08:19:06 INFO - ##### Running create-virtualenv step. 08:19:06 INFO - ##### 08:19:06 INFO - Running pre-action listener: _resource_record_pre_action 08:19:06 INFO - Running main action method: create_virtualenv 08:19:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:06 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:19:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:06 INFO - Using real prefix '/usr' 08:19:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:09 INFO - Installing pip.................done. 08:19:09 INFO - Return code: 0 08:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:09 INFO - Using env: {'DISPLAY': ':0', 08:19:09 INFO - 'HOME': '/home/cltbld', 08:19:09 INFO - 'LANG': 'en_US.UTF-8', 08:19:09 INFO - 'LANGUAGE': 'en_US:en', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MAIL': '/var/mail/cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SHLVL': '1', 08:19:09 INFO - 'TERM': 'linux', 08:19:09 INFO - 'TMOUT': '86400', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - '_': '/tools/buildbot/bin/python'} 08:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:09 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:19:09 INFO - Cleaning up... 08:19:09 INFO - Return code: 0 08:19:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:19:09 INFO - Using env: {'DISPLAY': ':0', 08:19:09 INFO - 'HOME': '/home/cltbld', 08:19:09 INFO - 'LANG': 'en_US.UTF-8', 08:19:09 INFO - 'LANGUAGE': 'en_US:en', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MAIL': '/var/mail/cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SHLVL': '1', 08:19:09 INFO - 'TERM': 'linux', 08:19:09 INFO - 'TMOUT': '86400', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - '_': '/tools/buildbot/bin/python'} 08:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:09 INFO - Downloading/unpacking psutil>=3.1.1 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:11 INFO - Installing collected packages: psutil 08:19:11 INFO - Running setup.py install for psutil 08:19:11 INFO - building 'psutil._psutil_linux' extension 08:19:11 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:19:11 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:19:11 INFO - building 'psutil._psutil_posix' extension 08:19:11 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:19:12 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:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:12 INFO - Successfully installed psutil 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:12 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:19:12 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:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:14 INFO - Installing collected packages: mozsystemmonitor 08:19:14 INFO - Running setup.py install for mozsystemmonitor 08:19:14 INFO - Successfully installed mozsystemmonitor 08:19:14 INFO - Cleaning up... 08:19:14 INFO - Return code: 0 08:19:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19: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:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:14 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:14 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:19:14 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:19:14 INFO - Using env: {'DISPLAY': ':0', 08:19:14 INFO - 'HOME': '/home/cltbld', 08:19:14 INFO - 'LANG': 'en_US.UTF-8', 08:19:14 INFO - 'LANGUAGE': 'en_US:en', 08:19:14 INFO - 'LOGNAME': 'cltbld', 08:19:14 INFO - 'MAIL': '/var/mail/cltbld', 08:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:14 INFO - 'MOZ_NO_REMOTE': '1', 08:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:14 INFO - 'NO_EM_RESTART': '1', 08:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:14 INFO - 'PWD': '/builds/slave/test', 08:19:14 INFO - 'SHELL': '/bin/bash', 08:19:14 INFO - 'SHLVL': '1', 08:19:14 INFO - 'TERM': 'linux', 08:19:14 INFO - 'TMOUT': '86400', 08:19:14 INFO - 'USER': 'cltbld', 08:19:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:14 INFO - '_': '/tools/buildbot/bin/python'} 08:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:16 INFO - warning: no files found matching '*.txt' 08:19:16 INFO - no previously-included directories found matching 'build' 08:19:16 INFO - no previously-included directories found matching 'dist' 08:19:16 INFO - no previously-included directories found matching '.git*' 08:19:16 INFO - Installing collected packages: jsonschema, functools32 08:19:16 INFO - Running setup.py install for functools32 08:19:17 INFO - warning: no files found matching '*.txt' 08:19:17 INFO - no previously-included directories found matching 'build' 08:19:17 INFO - no previously-included directories found matching 'dist' 08:19:17 INFO - no previously-included directories found matching '.git*' 08:19:17 INFO - Successfully installed jsonschema functools32 08:19:17 INFO - Cleaning up... 08:19:17 INFO - Return code: 0 08:19:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19: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:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:17 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:17 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:19:17 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:19:17 INFO - Using env: {'DISPLAY': ':0', 08:19:17 INFO - 'HOME': '/home/cltbld', 08:19:17 INFO - 'LANG': 'en_US.UTF-8', 08:19:17 INFO - 'LANGUAGE': 'en_US:en', 08:19:17 INFO - 'LOGNAME': 'cltbld', 08:19:17 INFO - 'MAIL': '/var/mail/cltbld', 08:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:17 INFO - 'MOZ_NO_REMOTE': '1', 08:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:17 INFO - 'NO_EM_RESTART': '1', 08:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:17 INFO - 'PWD': '/builds/slave/test', 08:19:17 INFO - 'SHELL': '/bin/bash', 08:19:17 INFO - 'SHLVL': '1', 08:19:17 INFO - 'TERM': 'linux', 08:19:17 INFO - 'TMOUT': '86400', 08:19:17 INFO - 'USER': 'cltbld', 08:19:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:17 INFO - '_': '/tools/buildbot/bin/python'} 08:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:19 INFO - Downloading docopt-0.6.1.tar.gz 08:19:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:20 INFO - Running setup.py install for blobuploader 08:19:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:20 INFO - Running setup.py install for requests 08:19:20 INFO - Running setup.py install for docopt 08:19:20 INFO - Successfully installed blobuploader requests docopt 08:19:20 INFO - Cleaning up... 08:19:20 INFO - Return code: 0 08:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:20 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:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:20 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:19:20 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:19:20 INFO - Using env: {'DISPLAY': ':0', 08:19:20 INFO - 'HOME': '/home/cltbld', 08:19:20 INFO - 'LANG': 'en_US.UTF-8', 08:19:20 INFO - 'LANGUAGE': 'en_US:en', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MAIL': '/var/mail/cltbld', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SHLVL': '1', 08:19:20 INFO - 'TERM': 'linux', 08:19:20 INFO - 'TMOUT': '86400', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - '_': '/tools/buildbot/bin/python'} 08:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:20 INFO - Running setup.py (path:/tmp/pip-vLIESd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:20 INFO - Running setup.py (path:/tmp/pip-OnMEm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:20 INFO - Running setup.py (path:/tmp/pip-3TINQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:21 INFO - Running setup.py (path:/tmp/pip-aBFRhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:21 INFO - Running setup.py (path:/tmp/pip-FSqtea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:21 INFO - Running setup.py (path:/tmp/pip-CpObnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:21 INFO - Running setup.py (path:/tmp/pip-TNfrK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:21 INFO - Running setup.py (path:/tmp/pip-uGu6Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:21 INFO - Running setup.py (path:/tmp/pip-0v0E_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:21 INFO - Running setup.py (path:/tmp/pip-88R95P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:21 INFO - Running setup.py (path:/tmp/pip-Ytt654-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:21 INFO - Running setup.py (path:/tmp/pip-vev_2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:21 INFO - Running setup.py (path:/tmp/pip-Q_hyPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:21 INFO - Running setup.py (path:/tmp/pip-lKSRwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:21 INFO - Running setup.py (path:/tmp/pip-aypH5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:21 INFO - Running setup.py (path:/tmp/pip-gTecRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:22 INFO - Running setup.py (path:/tmp/pip-tDGVLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:22 INFO - Running setup.py install for manifestparser 08:19:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Running setup.py install for mozcrash 08:19:22 INFO - Running setup.py install for mozdebug 08:19:22 INFO - Running setup.py install for mozdevice 08:19:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Running setup.py install for mozfile 08:19:22 INFO - Running setup.py install for mozhttpd 08:19:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Running setup.py install for mozinfo 08:19:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Running setup.py install for mozInstall 08:19:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:22 INFO - Running setup.py install for mozleak 08:19:22 INFO - Running setup.py install for mozlog 08:19:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Running setup.py install for moznetwork 08:19:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Running setup.py install for mozprocess 08:19:23 INFO - Running setup.py install for mozprofile 08:19:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Running setup.py install for mozrunner 08:19:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Running setup.py install for mozscreenshot 08:19:23 INFO - Running setup.py install for moztest 08:19:23 INFO - Running setup.py install for mozversion 08:19:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:23 INFO - Cleaning up... 08:19:23 INFO - Return code: 0 08:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:23 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:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:23 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:23 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:19:23 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:19:23 INFO - Using env: {'DISPLAY': ':0', 08:19:23 INFO - 'HOME': '/home/cltbld', 08:19:23 INFO - 'LANG': 'en_US.UTF-8', 08:19:23 INFO - 'LANGUAGE': 'en_US:en', 08:19:23 INFO - 'LOGNAME': 'cltbld', 08:19:23 INFO - 'MAIL': '/var/mail/cltbld', 08:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:23 INFO - 'MOZ_NO_REMOTE': '1', 08:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:23 INFO - 'NO_EM_RESTART': '1', 08:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:23 INFO - 'PWD': '/builds/slave/test', 08:19:23 INFO - 'SHELL': '/bin/bash', 08:19:23 INFO - 'SHLVL': '1', 08:19:23 INFO - 'TERM': 'linux', 08:19:23 INFO - 'TMOUT': '86400', 08:19:23 INFO - 'USER': 'cltbld', 08:19:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:23 INFO - '_': '/tools/buildbot/bin/python'} 08:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:24 INFO - Running setup.py (path:/tmp/pip-tlFeok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:24 INFO - Running setup.py (path:/tmp/pip-PEd05T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:24 INFO - Running setup.py (path:/tmp/pip-LKXbet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:24 INFO - Running setup.py (path:/tmp/pip-D2K6S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:24 INFO - Running setup.py (path:/tmp/pip-9QZGgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:24 INFO - Running setup.py (path:/tmp/pip-WiOUR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:24 INFO - Running setup.py (path:/tmp/pip-aLPsvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:24 INFO - Running setup.py (path:/tmp/pip-baQfTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:24 INFO - Running setup.py (path:/tmp/pip-2coWSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:24 INFO - Running setup.py (path:/tmp/pip-uo3pxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:24 INFO - Running setup.py (path:/tmp/pip-BtYonQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:24 INFO - Running setup.py (path:/tmp/pip-XNqEUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:24 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:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:24 INFO - Running setup.py (path:/tmp/pip-Os4Ghz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:25 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:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:25 INFO - Running setup.py (path:/tmp/pip-g4m8vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:25 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:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:25 INFO - Running setup.py (path:/tmp/pip-OOfXAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:25 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:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:25 INFO - Running setup.py (path:/tmp/pip-CDFRwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:25 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:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:25 INFO - Running setup.py (path:/tmp/pip-RhHjUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:25 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:19:27 INFO - Downloading blessings-1.6.tar.gz 08:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:27 INFO - Installing collected packages: blessings 08:19:27 INFO - Running setup.py install for blessings 08:19:27 INFO - Successfully installed blessings 08:19:27 INFO - Cleaning up... 08:19:27 INFO - Return code: 0 08:19:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:27 INFO - Reading from file tmpfile_stdout 08:19:27 INFO - Current package versions: 08:19:27 INFO - argparse == 1.2.1 08:19:27 INFO - blessings == 1.6 08:19:27 INFO - blobuploader == 1.2.4 08:19:27 INFO - docopt == 0.6.1 08:19:27 INFO - functools32 == 3.2.3-2 08:19:27 INFO - jsonschema == 2.5.1 08:19:27 INFO - manifestparser == 1.1 08:19:27 INFO - mozInstall == 1.12 08:19:27 INFO - mozcrash == 0.17 08:19:27 INFO - mozdebug == 0.1 08:19:27 INFO - mozdevice == 0.48 08:19:27 INFO - mozfile == 1.2 08:19:27 INFO - mozhttpd == 0.7 08:19:27 INFO - mozinfo == 0.9 08:19:27 INFO - mozleak == 0.1 08:19:27 INFO - mozlog == 3.2 08:19:27 INFO - moznetwork == 0.27 08:19:27 INFO - mozprocess == 0.22 08:19:27 INFO - mozprofile == 0.28 08:19:27 INFO - mozrunner == 6.11 08:19:27 INFO - mozscreenshot == 0.1 08:19:27 INFO - mozsystemmonitor == 0.3 08:19:27 INFO - moztest == 0.7 08:19:27 INFO - mozversion == 1.4 08:19:27 INFO - psutil == 3.1.1 08:19:27 INFO - requests == 1.2.3 08:19:27 INFO - wsgiref == 0.1.2 08:19:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:27 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:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:27 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:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:27 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:27 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:19:27 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:19:27 INFO - Using env: {'DISPLAY': ':0', 08:19:27 INFO - 'HOME': '/home/cltbld', 08:19:27 INFO - 'LANG': 'en_US.UTF-8', 08:19:27 INFO - 'LANGUAGE': 'en_US:en', 08:19:27 INFO - 'LOGNAME': 'cltbld', 08:19:27 INFO - 'MAIL': '/var/mail/cltbld', 08:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:27 INFO - 'MOZ_NO_REMOTE': '1', 08:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:27 INFO - 'NO_EM_RESTART': '1', 08:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:27 INFO - 'PWD': '/builds/slave/test', 08:19:27 INFO - 'SHELL': '/bin/bash', 08:19:27 INFO - 'SHLVL': '1', 08:19:27 INFO - 'TERM': 'linux', 08:19:27 INFO - 'TMOUT': '86400', 08:19:27 INFO - 'USER': 'cltbld', 08:19:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:27 INFO - '_': '/tools/buildbot/bin/python'} 08:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 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:19:27 INFO - Cleaning up... 08:19:27 INFO - Return code: 0 08:19:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:27 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:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:27 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:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:27 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:27 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:19:27 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:19:27 INFO - Using env: {'DISPLAY': ':0', 08:19:27 INFO - 'HOME': '/home/cltbld', 08:19:27 INFO - 'LANG': 'en_US.UTF-8', 08:19:27 INFO - 'LANGUAGE': 'en_US:en', 08:19:27 INFO - 'LOGNAME': 'cltbld', 08:19:27 INFO - 'MAIL': '/var/mail/cltbld', 08:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:27 INFO - 'MOZ_NO_REMOTE': '1', 08:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:27 INFO - 'NO_EM_RESTART': '1', 08:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:27 INFO - 'PWD': '/builds/slave/test', 08:19:27 INFO - 'SHELL': '/bin/bash', 08:19:27 INFO - 'SHLVL': '1', 08:19:27 INFO - 'TERM': 'linux', 08:19:27 INFO - 'TMOUT': '86400', 08:19:27 INFO - 'USER': 'cltbld', 08:19:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:27 INFO - '_': '/tools/buildbot/bin/python'} 08:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:28 INFO - Cleaning up... 08:19:28 INFO - Return code: 0 08:19:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:19:28 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:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 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:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 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 0x7f30ff4c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2108480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', '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:19:28 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:19:28 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:19:28 INFO - Using env: {'DISPLAY': ':0', 08:19:28 INFO - 'HOME': '/home/cltbld', 08:19:28 INFO - 'LANG': 'en_US.UTF-8', 08:19:28 INFO - 'LANGUAGE': 'en_US:en', 08:19:28 INFO - 'LOGNAME': 'cltbld', 08:19:28 INFO - 'MAIL': '/var/mail/cltbld', 08:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:28 INFO - 'MOZ_NO_REMOTE': '1', 08:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:28 INFO - 'NO_EM_RESTART': '1', 08:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:28 INFO - 'PWD': '/builds/slave/test', 08:19:28 INFO - 'SHELL': '/bin/bash', 08:19:28 INFO - 'SHLVL': '1', 08:19:28 INFO - 'TERM': 'linux', 08:19:28 INFO - 'TMOUT': '86400', 08:19:28 INFO - 'USER': 'cltbld', 08:19:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:28 INFO - '_': '/tools/buildbot/bin/python'} 08:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:28 INFO - Downloading/unpacking flake8 08:19:28 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:19:28 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:19:28 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:19:28 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:19:28 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:19:28 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:19:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 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:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:30 INFO - no previously-included directories found matching 'docs/_build' 08:19:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:31 INFO - Running setup.py install for pep8 08:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:31 INFO - no previously-included directories found matching 'docs/_build' 08:19:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:19:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:31 INFO - Cleaning up... 08:19:31 INFO - Return code: 0 08:19:31 INFO - Running post-action listener: _resource_record_post_action 08:19:31 INFO - Running post-action listener: _start_resource_monitoring 08:19:31 INFO - Starting resource monitoring. 08:19:31 INFO - ##### 08:19:31 INFO - ##### Finished create-virtualenv step (success) 08:19:31 INFO - ##### 08:19:31 INFO - ##### 08:19:31 INFO - ##### Running install step. 08:19:31 INFO - ##### 08:19:31 INFO - Running pre-action listener: _resource_record_pre_action 08:19:31 INFO - Running main action method: install 08:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:31 INFO - Reading from file tmpfile_stdout 08:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:31 INFO - Reading from file tmpfile_stdout 08:19:31 INFO - Output received: 08:19:31 INFO - Usage: mozinstall [options] installer 08:19:31 INFO - Options: 08:19:31 INFO - -h, --help show this help message and exit 08:19:31 INFO - -d DEST, --destination=DEST 08:19:31 INFO - Directory to install application into. [default: 08:19:31 INFO - "/builds/slave/test"] 08:19:31 INFO - --app=APP Application being installed. [default: firefox] 08:19:31 INFO - mkdir: /builds/slave/test/build/application 08:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:19:48 INFO - Reading from file tmpfile_stdout 08:19:48 INFO - Output received: 08:19:48 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:48 INFO - Running post-action listener: _resource_record_post_action 08:19:48 INFO - ##### 08:19:48 INFO - ##### Finished install step (success) 08:19:48 INFO - ##### 08:19:48 INFO - ##### 08:19:48 INFO - ##### Running run-tests step. 08:19:48 INFO - ##### 08:19:48 INFO - Running pre-action listener: _resource_record_pre_action 08:19:48 INFO - Running main action method: run_tests 08:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:48 INFO - Python 2.7.3 08:19:48 INFO - Return code: 0 08:19:48 INFO - grabbing minidump binary from tooltool 08:19: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:19:48 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 0x21976f0>, '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 0x21985f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2198aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:48 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:19:48 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:19:48 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:19:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:48 INFO - Return code: 0 08:19:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:19:49 INFO - Return code: 0 08:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:19:49 INFO - Using env: {'DISPLAY': ':0', 08:19:49 INFO - 'HOME': '/home/cltbld', 08:19:49 INFO - 'LANG': 'en_US.UTF-8', 08:19:49 INFO - 'LANGUAGE': 'en_US:en', 08:19:49 INFO - 'LOGNAME': 'cltbld', 08:19:49 INFO - 'MAIL': '/var/mail/cltbld', 08:19:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:49 INFO - 'MOZ_NO_REMOTE': '1', 08:19:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:49 INFO - 'NO_EM_RESTART': '1', 08:19:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:49 INFO - 'PWD': '/builds/slave/test', 08:19:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:49 INFO - 'SHELL': '/bin/bash', 08:19:49 INFO - 'SHLVL': '1', 08:19:49 INFO - 'TERM': 'linux', 08:19:49 INFO - 'TMOUT': '86400', 08:19:49 INFO - 'USER': 'cltbld', 08:19:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337', 08:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:49 INFO - '_': '/tools/buildbot/bin/python'} 08:19:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:19:49 INFO - mozversion application_buildid: 20160627053006 08:19:49 INFO - mozversion application_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:19:49 INFO - mozversion application_display_name: Nightly 08:19:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:49 INFO - mozversion application_name: Firefox 08:19:49 INFO - mozversion application_remotingname: firefox 08:19:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:49 INFO - mozversion application_vendor: Mozilla 08:19:49 INFO - mozversion application_version: 50.0a1 08:19:49 INFO - mozversion platform_buildid: 20160627053006 08:19:49 INFO - mozversion platform_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:19:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:49 INFO - mozversion platform_version: 50.0a1 08:19:49 INFO - using testdate: 1467040789 08:19:49 INFO - actual date: 1467040789 08:19:49 INFO - starting webserver on 'localhost:40329' 08:19:49 INFO - SUITE-START | Running 2 tests 08:19:49 INFO - TEST-START | dromaeo_css 08:19:49 INFO - operating with platform_type : linux_ 08:19:49 INFO - Initialising browser for dromaeo_css test... 08:19:49 INFO - TEST-INFO | started process 16350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6GlPC/profile http://localhost:40329/getInfo.html) 08:19:54 INFO - PROCESS | 16350 | __metrics Screen width/height:1600/1200 08:19:54 INFO - PROCESS | 16350 | colorDepth:24 08:19:54 INFO - PROCESS | 16350 | Browser inner width/height: 1024/697 08:19:54 INFO - PROCESS | 16350 | __metrics 08:19:55 ERROR - PROCESS | 16350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:19:56 INFO - TEST-INFO | 16350: exit 0 08:19:56 INFO - Browser initialized. 08:19:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:56 INFO - TEST-INFO | started process 16468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6GlPC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:08 INFO - PROCESS | 16468 | RSS: Main: 185155584 08:20:08 INFO - PROCESS | 16468 | 08:20:57 INFO - PROCESS | 16468 | 1467040857819 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:23:06 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40329/tests/dromaeo/cssquery-ext.html) 08:23:07 INFO - PROCESS | 16468 | RSS: Main: 187805696 08:23:07 INFO - PROCESS | 16468 | 08:26:09 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-ext.html (next: http://localhost:40329/tests/dromaeo/cssquery-jquery.html) 08:26:09 INFO - PROCESS | 16468 | RSS: Main: 187863040 08:26:09 INFO - PROCESS | 16468 | 08:29:11 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40329/tests/dromaeo/cssquery-mootools.html) 08:29:12 INFO - PROCESS | 16468 | RSS: Main: 189378560 08:29:12 INFO - PROCESS | 16468 | 08:32:13 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40329/tests/dromaeo/cssquery-prototype.html) 08:32:14 INFO - PROCESS | 16468 | RSS: Main: 186748928 08:32:14 INFO - PROCESS | 16468 | 08:35:16 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40329/tests/dromaeo/cssquery-yui.html) 08:35:17 INFO - PROCESS | 16468 | RSS: Main: 189075456 08:35:17 INFO - PROCESS | 16468 | 08:38:19 INFO - PROCESS | 16468 | Cycle 1(1): loaded http://localhost:40329/tests/dromaeo/cssquery-yui.html (next: http://localhost:40329/tests/dromaeo/cssquery-dojo.html) 08:38:20 INFO - PROCESS | 16468 | RSS: Main: 189657088 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | __start_tp_report 08:38:20 INFO - PROCESS | 16468 | _x_x_mozilla_page_load 08:38:20 INFO - PROCESS | 16468 | _x_x_mozilla_page_load_details 08:38:20 INFO - PROCESS | 16468 | |i|pagename|runs| 08:38:20 INFO - PROCESS | 16468 | |0;dojo.html;3084.7377972872305;3158.7157155855966;3193.058047875877;3195.8402079896;3197.456432406491;5470.480304371088;5493.423190564988;5529.806456774014;5547.972260138694;5554.055810512213;5262.81580144695;5460.6177567570185;5484.972575137129;5544.805931792388;5676.148577713345;4974.751262436873;5009.824656137018;5048.1418158913075;5097.082525145473;5129.307543481619;721.5190150096065;4857.392825896763;4895.167821470359;4938.629602779788;5092.541671249587;4964.950350496485;4984.601231901457;5008.373953255825;5012.323336349601;5012.498750124995;5012.373453318335;5013.799448022075;5028.924566131511;5031.094403007457;5041.773120209599;4923.433805112386;4962.6774259673;4967.254911763228;4975.104481193383;4988.975055124737;5449.373322067973;5506.752196151183;5529.115341545374;5553.972230138864;5574.916376254359;5599.720013999284;5857.970710146422;5864.179014937869;5875;5924.259467566554;5957.136215248808;6017.548683848685;6041.848953776147;6049.941260279434;6098.3596722343955;5609.35492418373;5629.7185140742795;5630.774769009235;5630.97184514083;5631.9718401408145;5777.162311464898;6000.459958603747;6034.5172386209;6108.4807791338235;6130.233720784902;5775.5668324875805;5778.88442231153;5780.88438231233;5781.682007489629;5797;5932.881342373128;5955.851103722442;5956.821295361146;5962.612430192024;5975.641461512323;5838.416158384128;5884.293884733774;5913.467787899023;5941.1088336749835;5954.047352423591;5908.586398952118;5947.226860508106;5950.9107363389585;5957.79147729836;5970.283565972111;4360.6729495287345;4502.8198872045405;4515.525869783691;4528.818847246073;4553.840615578505;3919.7060220483577;4019.9196016079513;4054.6350828425584;4069.5320038195396;4090.3250963591267;5517.944820551743;5571.164325351148;5614.887702245932;5667.914981275284;5703.572232082611;5639.520640745583;5955.791547295824;5961.821145365646;6015.699215039231;6017.969910150508;5355.892882142335;5419.512243897989;5421.512063914188;5421.512063914267;5435.402105768362;4830.95169048305;4867.34290870735;4939.975300123477;4957.702537847741;5007.7245751484015;6044.274687037584;6112.052631842072;6113.32753397126;6120.1737765401995;6135.723892424851;5845.386234445322;5902.911456328158;5921.963656360033;5941.287045554561;5951.732172052355;5914.526837853047;6069.969650151721;6140.166841500682;6157.291911430064;6224.315325314121;5847.532197424111;5866.794662186803;5892.263467066617;5929.52563794904;5961.374055724086;5710;5961.135635332939;6014.48876845473;6023.156758053964;6026.608270462406;5708.914366284592;5717.714114294352;5755.107958266475;5763;5796.913046304225;5702.401247868914;5709.51469125129;5715.257016587817;5716.514096301861;5721.914171287351;5393.056215162253;5616.775328986958;5619.129034999582;5639.520640745583;5651.067573850269;5752.626079304831;5778.855528611818;5785.218995435563;5804.042333015174;5836.241288632451;5619.887602247851;5635.492805647511;5649.954758369715;5654.943450565442;5674.886502269849 08:38:20 INFO - PROCESS | 16468 | |1;ext.html;584.5820238529451;606.9393060693928;615.2985596420081;641.6855740687063;643.5977514053717;42695;44291.33562996558;44418.77790611042;44461;47577;44352;44621;44648;45038.54961450385;45086;8784.736457906272;9086.318526110535;9092.227160691316;9106.317026223027;9109.68116115936;8961.148690874357;9060.411073280216;9083.772905677344;9086.954565227164;9089.045650206732;9143.177114059734;9160.633574657038;9182.540872956359;9190.632374705037;9194.08059194082;9077.500737459437;9125.771855703628;9140.497272650002;9143.817123657489;9154.588043538024;8913.866292005625;8957.328200384996;8981.730548083502;8988.505632190227;9055.18503334703;42580;42900.57099428997;42983.785081074704;42989;43091.35362969558;3796.2027974125467;3855.575886652466;4079.9592004080173;4156.251874662559;4358.411614432042;32787;32825.50761738576;33001.6699833001;33311.6668833311;33787.324253514795;4424.469063712375;4459.241928872067;4519.661025423106;4532.410786597754;4546.47715512717;331183;334132;334955;335660;337252;58196.127058094164;58613;58671.70664146652;58682;58829;35485;35980.820095899355;36010;37561.624383755814;38035.429468557995;17516.737248941277;17520.21159047846;17636.294548217928;17657.38199163023;17696.380626678005;13581.524646637321;13609.591712248648;13649.454021839214;13656.522021729192;13725;19592.70610940837;19618.901905490668;19849.503762406057;19885;19986.300479483438;6945.409640180641;7181.174164970991;7307.415406767446;7487.925120748723;7642.121156067124;1001.1140140975144;1004.372267332917;1006.7734759679014;1088.395940253167;1093.2183488805383;32552.186195345304;32645.347093058004;32843.50734738981;33107.172320691694;33163;1099.5601759296185;1124.835794952237;1129.1192869561755;1158.507634255438;1229.901607871386;16458.177091145393;16887.73341999355;16967.83032169687;17106.40127595553;17109.315627375014;574237;576704;576758;577919;578143;58868.705656471444;59016;59280.407195928354;59325;59414;1373.0457332154256;1376.9036167468182;1383.1493631416606;1391.4851504943235;1401.3133564553295;31041;31062.68937310598;31100.844495777375;31410;32337.191570210933;51203;51609.74195129;51664.48335516597;52177.7391113042;52231;509208;515823;518574;524943;525222;28554.42891142207;28977.13068607945;29022.419551609273;29060;29063.128106156848;47647.76176119097;47991.76004119957;48095.5190448091;48408;48645.27032094592;40821;41271.7936410316;41678;41770.37344439775;42428;40829.79585102056;40856.38715419212;41360.59579689787;41924;42413;36092.09769755777;41299.793501032305;42382.57617423786;42455.3631695531;43466;35492.645073548934;36951.63048369482;37107.257854843294;37378.626213737516;37483.81258093692;28275.57586636161;28507.144785656463;28525;28604.284892877844;28827.397151427067 08:38:20 INFO - PROCESS | 16468 | |2;jquery.html;397.24721652468565;400.5233771811544;401.6385253272053;402.34819592260544;415.63424186715685;18376.540586485346;20018.59962800745;20087.899560502196;20238.392848214542;20525;18395.81604183961;18477.35329263476;19148.042597870084;19740.506487337825;19816.504587385323;5663.830085097433;5768.567357448208;5842.47417732404;5873.412658734135;5878.294604647427;5658.943410565904;5721.284839395075;5794.82615521535;5821.650700957956;5834.154047663086;5651.632643878155;5707.62900411474;5782.479576838084;5815.302163740357;5844.415558444143;5454.290942177491;5681;5705.942940570603;5724.713764311809;5747.0517364635;5591.245181900432;5641.407652196543;5679.2333035040565;5683.090705487143;5705.4579814917515;13284.667883302898;14228.644283892882;14245.643858903506;14276.57170284893;14278.357473913698;2698.190542837141;2741.3420779013095;2771.625830512875;2778.3748656552116;2974.866131024109;10210.438425886574;10398.168146548334;10597.099246564052;11734.53061877524;12459;1879.370410912346;1935.2162374238455;2001.1195074167465;2003.8998050097582;2038.7553493580717;79099.6045019777;82564.76152857771;82807.17192828054;83582;84270;9853.571232171294;10472.581096756045;10867.45662716861;10931.453427328603;11162.665120046411;15318;15394.461193858162;15427.5371738848;15427.84572154264;15536.378544858078;8122.309603683635;8299.377546684023;8361.540115293717;8499.192576705203;8557.657693692307;8182.7954301142945;8229.790381751121;8247;8344.791380215544;8381.580920953927;4568.086382723469;4668.229742092517;4671.182543054952;4676.719396836133;4757.714537127784;1911.3788018893915;1938.3894073366844;1946.9318573849848;1970.5664753754152;2007.056683358819;886.8847049883474;929.9860502092474;1013.3717095400899;1052.2423854824515;1053.1785207538132;19415;19718.211271549266;19747.605047899247;20045.79954200439;20116.396508104488;986.6990567876867;999.2006394884064;1004.0862814838462;1008.6016023670609;1023.948802559869;10975.451227438596;11392.658220253406;11396.430178491042;11425.942870285595;11430.542778288942;496979;508595;515981;521381;521807;89582;90478.54760726154;90919.54540227388;93397.5330123345;93548;1002.7693630465034;1030.8196065688473;1041;1054.056619325699;1057.8677665291839;17416.82583174152;17732.734008989617;17810.91094544519;17960.640787184446;18335.633287334447;39978;40825.795871020455;41677.82953795603;42302;43425.56574434342;55699.443005569425;55701.44298556963;56072;56101;63047.68476157774;12502.624921252376;13618.795718064435;13764.380602873094;13851.37668804886;13959.162450253018;14197.574072777834;14337.56987290383;14484.927575362055;14912.925435372754;14972.625684357978;12741.044421668226;12901;12988.545400910923;13071.346432678138;13256;12302.446389912655;12698.555550556055;12759.74480510366;12911.096223264281;13082.215067096005;8379.916200837913;8846.424982376126;8966.193042626195;9306.860397093913;9319.347645664739;13492.988025897901;13729.313534323044;13729.931350343584;13786.793198102238;13889.791653125008;13164.670883227613;13223.66940826487;13249.867501325249;13588.45646174142;13609.183448993092 08:38:20 INFO - PROCESS | 16468 | |3;mootools.html;1466.0836976889443;1496.3864815425675;1600.1759094066558;1709.7435384692303;1719.123247143957;7873.606319684021;8475.194856488639;8523.659053637855;9068.365214434993;9112.589933452993;8605.39762216645;8864.202221800037;8905.73282801517;8956.552172391386;8957;2276.635738281879;2309.538092381522;2309.6304591265402;2320.3503019154664;2322.605157123293;2204.713387259654;2217.1907253852387;2280.600894843404;2300.18343488061;2304.7003889494426;2242.988785056081;2251.6960210371635;2270.4323919020244;2294.977050229493;2304.976950230501;2203.1627981367137;2238.160689741347;2249.0666373454997;2255.0641483784293;2258.9096436142536;2256.5261295128043;2272.4659704969317;2281.5436912617542;2283.2807665585287;2285.0517035430275;9043.819123617557;9121.49831759253;9124.58939347731;9132.771680707969;9150.679726209552;5116.667416617908;5285.048691235576;5303.363596368422;5304.389995150568;5323.787048518055;3223.8226897520626;3257.9185520361943;3401.6768407001296;3409.2670075933793;3451.516787649731;1125.1224045244721;1125.5441546173813;1129.3562669278515;1152.9308241505537;1162.6686394377646;12589.685257868443;12620.053495987837;12700.682482937907;12709.17390369623;12716.554920577828;4580.1068791585985;4587.839425620087;4667.276572131325;4680.602148817388;4687.320338550891;10529.84205236922;10604.363738175734;10620.946895265628;10640.457133715568;10645.041946224877;5295;5298.311219541512;5300.310959575308;5314.441983591744;5321;4159.10579225462;4709.976450117796;4730.361401210861;4828.010257897193;4872.756362181876;4042.3734321180264;4078.6940979426663;4175.06061136248;4187.392828039917;4245.919499445249;1280.705437749323;1293.0819118425834;1299.051692264652;1304.243538747524;1305.2103477396229;933.9912894074383;955.4219697083304;963.6386355116831;971.5676523946917;992.3946392700446;5898.734556944948;5928.911066334009;5975.731092100866;6049.122877182784;6191.752329906843;445.07202482823027;455.6127291801942;458.09754783077284;462.9791659375336;466.1027522020165;3956.802159891994;3982.7212095153063;3989.780562069056;4013.157236980267;4084.448599439097;10762.461876906124;10934.56261749521;11026.173037022256;11108.944455277671;11253.099752019818;10892.61875834342;10936.179786516042;10940.835887461695;11000.944995275133;11014.00873921351;7891.723789667449;8231.670733170726;8233.629486673113;8320.126386729306;8365.623546940402;5806.071028635398;5838.824835254949;5900.852478688067;5930.940690593039;5992.43071908168;10194.43930583825;10423.791524169323;10475.057244848;10500.684979450629;10567.577296908345;10229.130523905254;10468.267221294436;10501.369917804956;10502.947485262524;10530.842037369599;7143.535670181422;7745.109312429143;7981.880271796043;8003.759887203393;8175.345972322081;8791.648334066565;8827.205551500396;8829.470231786114;8841.911580884109;8863.423877447945;7587.127480339611;7780.883286750816;7852;8082.393820463371;8113.59432028408;7801.4929029612895;7902.288794008567;7928.643211055632;7947.8807817881625;7975.042994840424;7196.568205907663;7258.657148427346;7284.562926224444;7331.78004659861;7352.2280160584505;5266.526012658879;5292.391374991926;5373.543248823894;5375.919361209663;5421.40364559906;4994.850154495371;5010.423801262901;5030.144875371123;5031.169856973558;5046.798128074983 08:38:20 INFO - PROCESS | 16468 | |4;prototype.html;310.22908073437503;314.529777981917;314.93071524264667;317.7553283971341;318.8724510195923;5666.433356664332;5666.631668941521;5673.319201695797;5733.140028995647;5739;5594.944050559493;5598.272224610805;5626.156076588513;5649.406812284713;5652.943470565293;4095.3447448408187;4205.137946720914;4301.3547967804925;4316.568343165674;4333.891652708692;4253.3619957006385;4269.316909294514;4273.50854651716;4289.399484072217;4312.396264522969;4250.447441832557;4261.5738426157295;4262.46719160105;4264.104538047014;4313.698041137121;4033.2336855997414;4240.766757828318;4241.660667146621;4260.616544510978;4290.334998075304;3694.3350196964534;3700.2414505026404;3717.5687360366455;3719.609441008682;3722.3671975764187;5491.121420572689;5514.145307477347;5525.309336332958;5525.336959564878;5537.916931246034;4853.878653033667;4865.245886887538;4876.487968763265;4896.387951506062;4943.1596628573225;5843.2695913010875;5848.941510584925;5859.824205273806;5862.618929769551;5865.941340586625;4085.611866872642;4126.546079931205;4143.8964025899295;4162.875113746592;4169.207850508394;5896.410358964112;6078.96960515199;6104.328523862371;6147.354527774564;6204.410580994799;4187.623113919762;4195.223883581547;4215.3044747616295;4225.260579398593;4226.450561426995;4203.306454434984;4220.936685949713;4245.787710614457;4263.722858014219;4291.120320334324;4667.696599721007;4883.121038213156;4926.704397736147;4961.181405068123;4984.355162796341;5917.585768996215;5925.703714814242;5972.193753843262;5974.9402505974385;5976.880462390728;1439.3810661415482;1456.1845366594741;1464.4508309383982;1465.6042868425466;1480.4448331875547;930.2465003347311;944.4191822029402;951.5527701980059;977.6578197630914;986.2405947420447;5613.887722245614;5620.690862002547;5624.690642014647;5643.7707105693025;5703.201551782754;5911.793087241926;5991.64050156992;6034.366391528914;6063.636181829104;6093.618041986651;5396.730163491809;5609.887802243932;5690.374058853523;5690.605801578639;5708.602386997471;3219.5492631031675;3229.822359770188;3238.2351618368048;3242.5298331742238;3258.2668899497426;6129.35641757609;6165.198524191826;6258.874822503524;6259.311475737665;6305.211848518935;6134.263888333339;6137.925862974051;6149.755339301123;6201.519392243049;6207.286162091417;6111.624884401063;6250.249970003538;6283.874322513524;6297.811065668037;6325.335839736854;6064.9393506066135;6083.513318934386;6084.726187321493;6100.603460775035;6118.265808103056;5994.28068631767;6020.397960203944;6037.18498002764;6055.757769689163;6063.818085457443;6015.72929218195;6234.314225435289;6266.749330026748;6347.682615869096;6352.428281454691;4077.653399461079;4130.277201489667;4161.417401563844;4173.436586060843;4184.895377615584;5858;5862.589618726648;6162.784302549389;6163.414475624809;6199.535034872493;5834.411836720471;5952.464278214981;5955.821325360246;5957.940420595912;5958.910616340671;5860.560457965585;5892.878563716973;5921.171036055042;5922.230110085661;5959.642421454727;5555.7499912504845;5679.858003549944;5759.2512973313205;5777.8555536111935;5782;5818.974133450667;5820.417958204315;5820.73806678692;5872.120921305313;5885.646861188342;5488.945110549003;5675.9499492594005;5739.454751798572;5750.281214848144;5802.245708057925 08:38:20 INFO - PROCESS | 16468 | |5;yui.html;699.6431819771915;749.6439191384092;778.9143194248635;821.5029906906318;847.6736456464259;14091;14638.780418293707;14661.70676586469;14682.11907285561;14700.485483008097;14096;14274.785878211835;14294.571162865104;14300.570982870504;14304.642383940407;647.9319671434503;766.1495739728897;793.2820797178534;795.399473397584;797.214743477674;788.9723859664913;791.8653828849109;793.5556088590408;796.6574373019599;798.808286011356;840.5461051032435;843.780617039568;844.7507985144366;845.2097289034741;848.0586548930683;842.2335674536173;843.9746807595751;844.4679851693425;850.3494826457764;851.706161374331;612.10326871134;617.9042248451498;621.4065567383138;622.3869488553771;623.8533944523033;13942.860571394258;13948.163110213318;13983.300834958312;13984.510542131078;14043.368048437846;14627.63430914225;14795.852041479555;14800.259987000714;14857.182854942974;14886.851131488764;11345.773084538263;11363.829542556869;11365.147613928988;11401.828972565418;11530.711732206679;3743.382341913581;3774.5281839770028;3819.923601527954;3826.2730081284467;3844.2503711776217;74490.62754686247;75514.62242688806;76177.61911190409;76691.6165419175;77351.61324193343;10800.891991079989;11248.718782030352;11537.942310288563;11713.297202167898;11854.585089521825;20769.169233230805;21049.89475052615;21091.472713182295;21115.788842111688;21125.26061587837;7396.593187374639;8203.138670439637;8388.832223355621;8529.57352132391;8592.140785921358;4825.396825396825;4890.486498917634;5017.397912250553;5109.7700603472185;5165.819196328186;3458.0836078439233;3607.3687104756564;3609.657082577151;3611.94582081269;3619.2761447710564;597.8087012156155;601.7923816283375;608.5435923057706;615.6583096381462;620.8168590265882;636.974521019154;666.2637785247329;732.6995931667991;752.2139364364252;760.4600733479181;8727.60725767342;8907.331950103639;9022.766515954496;9365.578548965314;9422.575984080733;625.7036675401288;668.238208442376;697.069412334539;739.985200295991;742.6843591473602;4351.978240108842;4518.977405112953;4608.700434471749;4669.929951050737;4697.412823397075;112849.4357528207;116044;117510;118594;120035;100611.49694251482;101175;102645.48677256715;103205;104949;91585.54207228922;92845.53577232071;94474.5276273628;95137;95369;8336.208060234268;8401.915980840358;8561.657533698582;8602.311815054905;8607.698730544402;49921.75039124781;52110.47889521056;52564;52626.47373526216;53737.19394209168;67192.32807671861;76135.23864761282;77028.61485692536;78943;79061;12495.500179992698;12734;12922;13437.260950647807;13941.093828901088;13681.521146759816;14084.436622534984;14383.352749126523;14730.337134828744;15909.284082216096;12839.679008024874;13039.035356631894;13245.801312980506;13438.193708377528;14196.219207943663;13071.608729027352;13349.199048057148;13435.932820335836;13534.255615941218;13883.583492495241;12133.272003679807;12285.75428491443;12389.256644601353;12582.811257831323;12730.045246606727;10394.596729441731;10432.165426765689;10470.11004064663;10496.527656255334;10692.358458492516;10734.570617175537;10739.838902416313;10789.676309710721;10857.15428377162;10879 08:38:20 INFO - PROCESS | 16468 | __end_tp_report 08:38:20 INFO - PROCESS | 16468 | __start_cc_report 08:38:20 INFO - PROCESS | 16468 | _x_x_mozilla_cycle_collect,361 08:38:20 INFO - PROCESS | 16468 | __end_cc_report 08:38:20 INFO - PROCESS | 16468 | __startTimestamp1467041900041__endTimestamp 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | ------- Summary: start ------- 08:38:20 INFO - PROCESS | 16468 | Number of tests: 6 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#0] dojo.html Cycles:165 Average:5447.16 Median:5667.91 stddev:736.35 (13.0%) stddev-sans-first:714.90 08:38:20 INFO - PROCESS | 16468 | Values: 3084.7 3158.7 3193.1 3195.8 3197.5 5470.5 5493.4 5529.8 5548.0 5554.1 5262.8 5460.6 5485.0 5544.8 5676.1 4974.8 5009.8 5048.1 5097.1 5129.3 721.5 4857.4 4895.2 4938.6 5092.5 4965.0 4984.6 5008.4 5012.3 5012.5 5012.4 5013.8 5028.9 5031.1 5041.8 4923.4 4962.7 4967.3 4975.1 4989.0 5449.4 5506.8 5529.1 5554.0 5574.9 5599.7 5858.0 5864.2 5875.0 5924.3 5957.1 6017.5 6041.8 6049.9 6098.4 5609.4 5629.7 5630.8 5631.0 5632.0 5777.2 6000.5 6034.5 6108.5 6130.2 5775.6 5778.9 5780.9 5781.7 5797.0 5932.9 5955.9 5956.8 5962.6 5975.6 5838.4 5884.3 5913.5 5941.1 5954.0 5908.6 5947.2 5950.9 5957.8 5970.3 4360.7 4502.8 4515.5 4528.8 4553.8 3919.7 4019.9 4054.6 4069.5 4090.3 5517.9 5571.2 5614.9 5667.9 5703.6 5639.5 5955.8 5961.8 6015.7 6018.0 5355.9 5419.5 5421.5 5421.5 5435.4 4831.0 4867.3 4940.0 4957.7 5007.7 6044.3 6112.1 6113.3 6120.2 6135.7 5845.4 5902.9 5922.0 5941.3 5951.7 5914.5 6070.0 6140.2 6157.3 6224.3 5847.5 5866.8 5892.3 5929.5 5961.4 5710.0 5961.1 6014.5 6023.2 6026.6 5708.9 5717.7 5755.1 5763.0 5796.9 5702.4 5709.5 5715.3 5716.5 5721.9 5393.1 5616.8 5619.1 5639.5 5651.1 5752.6 5778.9 5785.2 5804.0 5836.2 5619.9 5635.5 5650.0 5654.9 5674.9 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#1] ext.html Cycles:180 Average:62948.74 Median:42420.50 stddev:129809.71 (306.0%) stddev-sans-first:130089.41 08:38:20 INFO - PROCESS | 16468 | Values: 584.6 606.9 615.3 641.7 643.6 42695.0 44291.3 44418.8 44461.0 47577.0 44352.0 44621.0 44648.0 45038.5 45086.0 8784.7 9086.3 9092.2 9106.3 9109.7 8961.1 9060.4 9083.8 9087.0 9089.0 9143.2 9160.6 9182.5 9190.6 9194.1 9077.5 9125.8 9140.5 9143.8 9154.6 8913.9 8957.3 8981.7 8988.5 9055.2 42580.0 42900.6 42983.8 42989.0 43091.4 3796.2 3855.6 4080.0 4156.3 4358.4 32787.0 32825.5 33001.7 33311.7 33787.3 4424.5 4459.2 4519.7 4532.4 4546.5 331183.0 334132.0 334955.0 335660.0 337252.0 58196.1 58613.0 58671.7 58682.0 58829.0 35485.0 35980.8 36010.0 37561.6 38035.4 17516.7 17520.2 17636.3 17657.4 17696.4 13581.5 13609.6 13649.5 13656.5 13725.0 19592.7 19618.9 19849.5 19885.0 19986.3 6945.4 7181.2 7307.4 7487.9 7642.1 1001.1 1004.4 1006.8 1088.4 1093.2 32552.2 32645.3 32843.5 33107.2 33163.0 1099.6 1124.8 1129.1 1158.5 1229.9 16458.2 16887.7 16967.8 17106.4 17109.3 574237.0 576704.0 576758.0 577919.0 578143.0 58868.7 59016.0 59280.4 59325.0 59414.0 1373.0 1376.9 1383.1 1391.5 1401.3 31041.0 31062.7 31100.8 31410.0 32337.2 51203.0 51609.7 51664.5 52177.7 52231.0 509208.0 515823.0 518574.0 524943.0 525222.0 28554.4 28977.1 29022.4 29060.0 29063.1 47647.8 47991.8 48095.5 48408.0 48645.3 40821.0 41271.8 41678.0 41770.4 42428.0 40829.8 40856.4 41360.6 41924.0 42413.0 36092.1 41299.8 42382.6 42455.4 43466.0 35492.6 36951.6 37107.3 37378.6 37483.8 28275.6 28507.1 28525.0 28604.3 28827.4 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#2] jquery.html Cycles:180 Average:29865.95 Median:20102.15 stddev:84415.02 (419.9%) stddev-sans-first:84622.83 08:38:20 INFO - PROCESS | 16468 | Values: 397.2 400.5 401.6 402.3 415.6 18376.5 20018.6 20087.9 20238.4 20525.0 18395.8 18477.4 19148.0 19740.5 19816.5 5663.8 5768.6 5842.5 5873.4 5878.3 5658.9 5721.3 5794.8 5821.7 5834.2 5651.6 5707.6 5782.5 5815.3 5844.4 5454.3 5681.0 5705.9 5724.7 5747.1 5591.2 5641.4 5679.2 5683.1 5705.5 13284.7 14228.6 14245.6 14276.6 14278.4 2698.2 2741.3 2771.6 2778.4 2974.9 10210.4 10398.2 10597.1 11734.5 12459.0 1879.4 1935.2 2001.1 2003.9 2038.8 79099.6 82564.8 82807.2 83582.0 84270.0 9853.6 10472.6 10867.5 10931.5 11162.7 15318.0 15394.5 15427.5 15427.8 15536.4 8122.3 8299.4 8361.5 8499.2 8557.7 8182.8 8229.8 8247.0 8344.8 8381.6 4568.1 4668.2 4671.2 4676.7 4757.7 1911.4 1938.4 1946.9 1970.6 2007.1 886.9 930.0 1013.4 1052.2 1053.2 19415.0 19718.2 19747.6 20045.8 20116.4 986.7 999.2 1004.1 1008.6 1023.9 10975.5 11392.7 11396.4 11425.9 11430.5 496979.0 508595.0 515981.0 521381.0 521807.0 89582.0 90478.5 90919.5 93397.5 93548.0 1002.8 1030.8 1041.0 1054.1 1057.9 17416.8 17732.7 17810.9 17960.6 18335.6 39978.0 40825.8 41677.8 42302.0 43425.6 55699.4 55701.4 56072.0 56101.0 63047.7 12502.6 13618.8 13764.4 13851.4 13959.2 14197.6 14337.6 14484.9 14912.9 14972.6 12741.0 12901.0 12988.5 13071.3 13256.0 12302.4 12698.6 12759.7 12911.1 13082.2 8379.9 8846.4 8966.2 9306.9 9319.3 13493.0 13729.3 13729.9 13786.8 13889.8 13164.7 13223.7 13249.9 13588.5 13609.2 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#3] mootools.html Cycles:180 Average:5863.83 Median:2525.41 stddev:3407.62 (134.9%) stddev-sans-first:3401.16 08:38:20 INFO - PROCESS | 16468 | Values: 1466.1 1496.4 1600.2 1709.7 1719.1 7873.6 8475.2 8523.7 9068.4 9112.6 8605.4 8864.2 8905.7 8956.6 8957.0 2276.6 2309.5 2309.6 2320.4 2322.6 2204.7 2217.2 2280.6 2300.2 2304.7 2243.0 2251.7 2270.4 2295.0 2305.0 2203.2 2238.2 2249.1 2255.1 2258.9 2256.5 2272.5 2281.5 2283.3 2285.1 9043.8 9121.5 9124.6 9132.8 9150.7 5116.7 5285.0 5303.4 5304.4 5323.8 3223.8 3257.9 3401.7 3409.3 3451.5 1125.1 1125.5 1129.4 1152.9 1162.7 12589.7 12620.1 12700.7 12709.2 12716.6 4580.1 4587.8 4667.3 4680.6 4687.3 10529.8 10604.4 10620.9 10640.5 10645.0 5295.0 5298.3 5300.3 5314.4 5321.0 4159.1 4710.0 4730.4 4828.0 4872.8 4042.4 4078.7 4175.1 4187.4 4245.9 1280.7 1293.1 1299.1 1304.2 1305.2 934.0 955.4 963.6 971.6 992.4 5898.7 5928.9 5975.7 6049.1 6191.8 445.1 455.6 458.1 463.0 466.1 3956.8 3982.7 3989.8 4013.2 4084.4 10762.5 10934.6 11026.2 11108.9 11253.1 10892.6 10936.2 10940.8 11000.9 11014.0 7891.7 8231.7 8233.6 8320.1 8365.6 5806.1 5838.8 5900.9 5930.9 5992.4 10194.4 10423.8 10475.1 10500.7 10567.6 10229.1 10468.3 10501.4 10502.9 10530.8 7143.5 7745.1 7981.9 8003.8 8175.3 8791.6 8827.2 8829.5 8841.9 8863.4 7587.1 7780.9 7852.0 8082.4 8113.6 7801.5 7902.3 7928.6 7947.9 7975.0 7196.6 7258.7 7284.6 7331.8 7352.2 5266.5 5292.4 5373.5 5375.9 5421.4 4994.9 5010.4 5030.1 5031.2 5046.8 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#4] prototype.html Cycles:180 Average:4926.97 Median:5674.63 stddev:1485.29 (26.2%) stddev-sans-first:1448.47 08:38:20 INFO - PROCESS | 16468 | Values: 310.2 314.5 314.9 317.8 318.9 5666.4 5666.6 5673.3 5733.1 5739.0 5594.9 5598.3 5626.2 5649.4 5652.9 4095.3 4205.1 4301.4 4316.6 4333.9 4253.4 4269.3 4273.5 4289.4 4312.4 4250.4 4261.6 4262.5 4264.1 4313.7 4033.2 4240.8 4241.7 4260.6 4290.3 3694.3 3700.2 3717.6 3719.6 3722.4 5491.1 5514.1 5525.3 5525.3 5537.9 4853.9 4865.2 4876.5 4896.4 4943.2 5843.3 5848.9 5859.8 5862.6 5865.9 4085.6 4126.5 4143.9 4162.9 4169.2 5896.4 6079.0 6104.3 6147.4 6204.4 4187.6 4195.2 4215.3 4225.3 4226.5 4203.3 4220.9 4245.8 4263.7 4291.1 4667.7 4883.1 4926.7 4961.2 4984.4 5917.6 5925.7 5972.2 5974.9 5976.9 1439.4 1456.2 1464.5 1465.6 1480.4 930.2 944.4 951.6 977.7 986.2 5613.9 5620.7 5624.7 5643.8 5703.2 5911.8 5991.6 6034.4 6063.6 6093.6 5396.7 5609.9 5690.4 5690.6 5708.6 3219.5 3229.8 3238.2 3242.5 3258.3 6129.4 6165.2 6258.9 6259.3 6305.2 6134.3 6137.9 6149.8 6201.5 6207.3 6111.6 6250.2 6283.9 6297.8 6325.3 6064.9 6083.5 6084.7 6100.6 6118.3 5994.3 6020.4 6037.2 6055.8 6063.8 6015.7 6234.3 6266.7 6347.7 6352.4 4077.7 4130.3 4161.4 4173.4 4184.9 5858.0 5862.6 6162.8 6163.4 6199.5 5834.4 5952.5 5955.8 5957.9 5958.9 5860.6 5892.9 5921.2 5922.2 5959.6 5555.7 5679.9 5759.3 5777.9 5782.0 5819.0 5820.4 5820.7 5872.1 5885.6 5488.9 5675.9 5739.5 5750.3 5802.2 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - PROCESS | 16468 | [#5] yui.html Cycles:180 Average:21010.49 Median:4435.48 stddev:30974.21 (698.3%) stddev-sans-first:31023.56 08:38:20 INFO - PROCESS | 16468 | Values: 699.6 749.6 778.9 821.5 847.7 14091.0 14638.8 14661.7 14682.1 14700.5 14096.0 14274.8 14294.6 14300.6 14304.6 647.9 766.1 793.3 795.4 797.2 789.0 791.9 793.6 796.7 798.8 840.5 843.8 844.8 845.2 848.1 842.2 844.0 844.5 850.3 851.7 612.1 617.9 621.4 622.4 623.9 13942.9 13948.2 13983.3 13984.5 14043.4 14627.6 14795.9 14800.3 14857.2 14886.9 11345.8 11363.8 11365.1 11401.8 11530.7 3743.4 3774.5 3819.9 3826.3 3844.3 74490.6 75514.6 76177.6 76691.6 77351.6 10800.9 11248.7 11537.9 11713.3 11854.6 20769.2 21049.9 21091.5 21115.8 21125.3 7396.6 8203.1 8388.8 8529.6 8592.1 4825.4 4890.5 5017.4 5109.8 5165.8 3458.1 3607.4 3609.7 3611.9 3619.3 597.8 601.8 608.5 615.7 620.8 637.0 666.3 732.7 752.2 760.5 8727.6 8907.3 9022.8 9365.6 9422.6 625.7 668.2 697.1 740.0 742.7 4352.0 4519.0 4608.7 4669.9 4697.4 112849.4 116044.0 117510.0 118594.0 120035.0 100611.5 101175.0 102645.5 103205.0 104949.0 91585.5 92845.5 94474.5 95137.0 95369.0 8336.2 8401.9 8561.7 8602.3 8607.7 49921.8 52110.5 52564.0 52626.5 53737.2 67192.3 76135.2 77028.6 78943.0 79061.0 12495.5 12734.0 12922.0 13437.3 13941.1 13681.5 14084.4 14383.4 14730.3 15909.3 12839.7 13039.0 13245.8 13438.2 14196.2 13071.6 13349.2 13435.9 13534.3 13883.6 12133.3 12285.8 12389.3 12582.8 12730.0 10394.6 10432.2 10470.1 10496.5 10692.4 10734.6 10739.8 10789.7 10857.2 10879.0 08:38:20 INFO - PROCESS | 16468 | -------- Summary: end -------- 08:38:20 INFO - PROCESS | 16468 | 08:38:20 INFO - TEST-INFO | 16468: exit 0 08:38:20 INFO - TEST-OK | dromaeo_css | took 1110940ms 08:38:20 INFO - TEST-START | kraken 08:38:20 INFO - operating with platform_type : linux_ 08:38:20 INFO - Initialising browser for kraken test... 08:38:20 INFO - TEST-INFO | started process 16706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLFfcVd/profile http://localhost:40329/getInfo.html) 08:38:25 INFO - PROCESS | 16706 | __metrics Screen width/height:1600/1200 08:38:25 INFO - PROCESS | 16706 | colorDepth:24 08:38:25 INFO - PROCESS | 16706 | Browser inner width/height: 1024/697 08:38:25 INFO - PROCESS | 16706 | __metrics 08:38:26 ERROR - PROCESS | 16706 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:38:27 INFO - TEST-INFO | 16706: exit 0 08:38:27 INFO - Browser initialized. 08:38:27 INFO - Running cycle 1/1 for kraken test... 08:38:27 INFO - TEST-INFO | started process 16827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLFfcVd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:39 INFO - PROCESS | 16827 | RSS: Main: 184664064 08:38:39 INFO - PROCESS | 16827 | 08:38:41 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40329/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:42 INFO - PROCESS | 16827 | RSS: Main: 190267392 08:38:42 INFO - PROCESS | 16827 | 08:38:45 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40329/tests/kraken/driver.html?testName=audio-dft) 08:38:45 INFO - PROCESS | 16827 | RSS: Main: 189820928 08:38:45 INFO - PROCESS | 16827 | 08:38:48 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40329/tests/kraken/driver.html?testName=audio-fft) 08:38:49 INFO - PROCESS | 16827 | RSS: Main: 184299520 08:38:49 INFO - PROCESS | 16827 | 08:38:51 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40329/tests/kraken/driver.html?testName=audio-oscillator) 08:38:52 INFO - PROCESS | 16827 | RSS: Main: 184983552 08:38:52 INFO - PROCESS | 16827 | 08:38:54 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:54 INFO - PROCESS | 16827 | RSS: Main: 185032704 08:38:54 INFO - PROCESS | 16827 | 08:38:57 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40329/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:58 INFO - PROCESS | 16827 | RSS: Main: 184868864 08:38:58 INFO - PROCESS | 16827 | 08:39:02 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40329/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:02 INFO - PROCESS | 16827 | RSS: Main: 185843712 08:39:02 INFO - PROCESS | 16827 | 08:39:05 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40329/tests/kraken/driver.html?testName=json-parse-financial) 08:39:06 INFO - PROCESS | 16827 | RSS: Main: 185573376 08:39:06 INFO - PROCESS | 16827 | 08:39:07 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:08 INFO - PROCESS | 16827 | RSS: Main: 185745408 08:39:08 INFO - PROCESS | 16827 | 08:39:10 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:10 INFO - PROCESS | 16827 | RSS: Main: 186286080 08:39:10 INFO - PROCESS | 16827 | 08:39:12 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:13 INFO - PROCESS | 16827 | RSS: Main: 186327040 08:39:13 INFO - PROCESS | 16827 | 08:39:16 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:16 INFO - PROCESS | 16827 | RSS: Main: 186855424 08:39:16 INFO - PROCESS | 16827 | 08:39:19 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:20 INFO - PROCESS | 16827 | RSS: Main: 186531840 08:39:20 INFO - PROCESS | 16827 | 08:39:21 INFO - PROCESS | 16827 | Cycle 1(1): loaded http://localhost:40329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40329/tests/kraken/driver.html?testName=ai-astar) 08:39:22 INFO - PROCESS | 16827 | RSS: Main: 187359232 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | __start_tp_report 08:39:22 INFO - PROCESS | 16827 | _x_x_mozilla_page_load 08:39:22 INFO - PROCESS | 16827 | _x_x_mozilla_page_load_details 08:39:22 INFO - PROCESS | 16827 | |i|pagename|runs| 08:39:22 INFO - PROCESS | 16827 | |0;ai-astar;101;111;105;109;110;111;111;110;112;110 08:39:22 INFO - PROCESS | 16827 | |1;audio-beat-detection;155;130;158;203;128;160;151;129;195;126 08:39:22 INFO - PROCESS | 16827 | |2;audio-dft;163;164;162;160;166;172;164;163;162;161 08:39:22 INFO - PROCESS | 16827 | |3;audio-fft;75;75;73;161;76;76;75;76;164;77 08:39:22 INFO - PROCESS | 16827 | |4;audio-oscillator;87;85;147;86;85;85;142;85;86;132 08:39:22 INFO - PROCESS | 16827 | |5;imaging-gaussian-blur;118;118;117;119;118;118;118;118;118;117 08:39:22 INFO - PROCESS | 16827 | |6;imaging-darkroom;146;147;148;148;147;149;148;147;147;147 08:39:22 INFO - PROCESS | 16827 | |7;imaging-desaturate;95;98;96;96;95;95;96;95;96;95 08:39:22 INFO - PROCESS | 16827 | |8;json-parse-financial;59;56;54;55;59;54;54;55;56;55 08:39:22 INFO - PROCESS | 16827 | |9;json-stringify-tinderbox;62;61;62;64;63;61;72;61;62;62 08:39:22 INFO - PROCESS | 16827 | |10;stanford-crypto-aes;79;78;79;80;81;80;84;85;79;82 08:39:22 INFO - PROCESS | 16827 | |11;stanford-crypto-ccm;122;121;135;124;120;127;130;128;123;133 08:39:22 INFO - PROCESS | 16827 | |12;stanford-crypto-pbkdf2;162;164;158;161;161;156;164;161;160;162 08:39:22 INFO - PROCESS | 16827 | |13;stanford-crypto-sha256-iterative;73;63;66;63;63;62;62;63;61;61 08:39:22 INFO - PROCESS | 16827 | __end_tp_report 08:39:22 INFO - PROCESS | 16827 | __start_cc_report 08:39:22 INFO - PROCESS | 16827 | _x_x_mozilla_cycle_collect,912 08:39:22 INFO - PROCESS | 16827 | __end_cc_report 08:39:22 INFO - PROCESS | 16827 | __startTimestamp1467041962107__endTimestamp 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | ------- Summary: start ------- 08:39:22 INFO - PROCESS | 16827 | Number of tests: 14 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.40 (3.1%) stddev-sans-first:2.03 08:39:22 INFO - PROCESS | 16827 | Values: 101.0 111.0 105.0 109.0 110.0 111.0 111.0 110.0 112.0 110.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:156.50 stddev:27.49 (17.6%) stddev-sans-first:29.15 08:39:22 INFO - PROCESS | 16827 | Values: 155.0 130.0 158.0 203.0 128.0 160.0 151.0 129.0 195.0 126.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.37 (2.1%) stddev-sans-first:3.56 08:39:22 INFO - PROCESS | 16827 | Values: 163.0 164.0 162.0 160.0 166.0 172.0 164.0 163.0 162.0 161.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:36.76 (48.7%) stddev-sans-first:38.42 08:39:22 INFO - PROCESS | 16827 | Values: 75.0 75.0 73.0 161.0 76.0 76.0 75.0 76.0 164.0 77.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.00 stddev:26.70 (31.4%) stddev-sans-first:27.77 08:39:22 INFO - PROCESS | 16827 | Values: 87.0 85.0 147.0 86.0 85.0 85.0 142.0 85.0 86.0 132.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:39:22 INFO - PROCESS | 16827 | Values: 118.0 118.0 117.0 119.0 118.0 118.0 118.0 118.0 118.0 117.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 08:39:22 INFO - PROCESS | 16827 | Values: 146.0 147.0 148.0 148.0 147.0 149.0 148.0 147.0 147.0 147.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 08:39:22 INFO - PROCESS | 16827 | Values: 95.0 98.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.89 (3.4%) stddev-sans-first:1.58 08:39:22 INFO - PROCESS | 16827 | Values: 59.0 56.0 54.0 55.0 59.0 54.0 54.0 55.0 56.0 55.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:62.00 stddev:3.30 (5.3%) stddev-sans-first:3.48 08:39:22 INFO - PROCESS | 16827 | Values: 62.0 61.0 62.0 64.0 63.0 61.0 72.0 61.0 62.0 62.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.31 (2.9%) stddev-sans-first:2.37 08:39:22 INFO - PROCESS | 16827 | Values: 79.0 78.0 79.0 80.0 81.0 80.0 84.0 85.0 79.0 82.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.50 stddev:5.17 (4.1%) stddev-sans-first:5.24 08:39:22 INFO - PROCESS | 16827 | Values: 122.0 121.0 135.0 124.0 120.0 127.0 130.0 128.0 123.0 133.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:2.47 (1.5%) stddev-sans-first:2.59 08:39:22 INFO - PROCESS | 16827 | Values: 162.0 164.0 158.0 161.0 161.0 156.0 164.0 161.0 160.0 162.0 08:39:22 INFO - PROCESS | 16827 | 08:39:22 INFO - PROCESS | 16827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.00 stddev:3.56 (5.7%) stddev-sans-first:1.50 08:39:22 INFO - PROCESS | 16827 | Values: 73.0 63.0 66.0 63.0 63.0 62.0 62.0 63.0 61.0 61.0 08:39:22 INFO - PROCESS | 16827 | -------- Summary: end -------- 08:39:22 INFO - PROCESS | 16827 | 08:39:23 INFO - TEST-INFO | 16827: exit 0 08:39:23 INFO - TEST-OK | kraken | took 62363ms 08:39:23 INFO - SUITE-END | took 1173s 08:39:23 INFO - Completed test suite (00:19:33) 08:39:23 INFO - javascript benchmark 08:39:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.487951272741, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.7377972872305, 3158.7157155855966, 3193.058047875877, 3195.8402079896, 3197.456432406491, 5470.480304371088, 5493.423190564988, 5529.806456774014, 5547.972260138694, 5554.055810512213, 5262.81580144695, 5460.6177567570185, 5484.972575137129, 5544.805931792388, 5676.148577713345, 4974.751262436873, 5009.824656137018, 5048.1418158913075, 5097.082525145473, 5129.307543481619, 721.5190150096065, 4857.392825896763, 4895.167821470359, 4938.629602779788, 5092.541671249587, 4964.950350496485, 4984.601231901457, 5008.373953255825, 5012.323336349601, 5012.498750124995, 5012.373453318335, 5013.799448022075, 5028.924566131511, 5031.094403007457, 5041.773120209599, 4923.433805112386, 4962.6774259673, 4967.254911763228, 4975.104481193383, 4988.975055124737, 5449.373322067973, 5506.752196151183, 5529.115341545374, 5553.972230138864, 5574.916376254359, 5599.720013999284, 5857.970710146422, 5864.179014937869, 5875.0, 5924.259467566554, 5957.136215248808, 6017.548683848685, 6041.848953776147, 6049.941260279434, 6098.3596722343955, 5609.35492418373, 5629.7185140742795, 5630.774769009235, 5630.97184514083, 5631.9718401408145, 5777.162311464898, 6000.459958603747, 6034.5172386209, 6108.4807791338235, 6130.233720784902, 5775.5668324875805, 5778.88442231153, 5780.88438231233, 5781.682007489629, 5797.0, 5932.881342373128, 5955.851103722442, 5956.821295361146, 5962.612430192024, 5975.641461512323, 5838.416158384128, 5884.293884733774, 5913.467787899023, 5941.1088336749835, 5954.047352423591, 5908.586398952118, 5947.226860508106, 5950.9107363389585, 5957.79147729836, 5970.283565972111, 4360.6729495287345, 4502.8198872045405, 4515.525869783691, 4528.818847246073, 4553.840615578505, 3919.7060220483577, 4019.9196016079513, 4054.6350828425584, 4069.5320038195396, 4090.3250963591267, 5517.944820551743, 5571.164325351148, 5614.887702245932, 5667.914981275284, 5703.572232082611, 5639.520640745583, 5955.791547295824, 5961.821145365646, 6015.699215039231, 6017.969910150508, 5355.892882142335, 5419.512243897989, 5421.512063914188, 5421.512063914267, 5435.402105768362, 4830.95169048305, 4867.34290870735, 4939.975300123477, 4957.702537847741, 5007.7245751484015, 6044.274687037584, 6112.052631842072, 6113.32753397126, 6120.1737765401995, 6135.723892424851, 5845.386234445322, 5902.911456328158, 5921.963656360033, 5941.287045554561, 5951.732172052355, 5914.526837853047, 6069.969650151721, 6140.166841500682, 6157.291911430064, 6224.315325314121, 5847.532197424111, 5866.794662186803, 5892.263467066617, 5929.52563794904, 5961.374055724086, 5710.0, 5961.135635332939, 6014.48876845473, 6023.156758053964, 6026.608270462406, 5708.914366284592, 5717.714114294352, 5755.107958266475, 5763.0, 5796.913046304225, 5702.401247868914, 5709.51469125129, 5715.257016587817, 5716.514096301861, 5721.914171287351, 5393.056215162253, 5616.775328986958, 5619.129034999582, 5639.520640745583, 5651.067573850269, 5752.626079304831, 5778.855528611818, 5785.218995435563, 5804.042333015174, 5836.241288632451, 5619.887602247851, 5635.492805647511, 5649.954758369715, 5654.943450565442, 5674.886502269849], "value": 5398.166593649483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5820238529451, 606.9393060693928, 615.2985596420081, 641.6855740687063, 643.5977514053717, 42695.0, 44291.33562996558, 44418.77790611042, 44461.0, 47577.0, 44352.0, 44621.0, 44648.0, 45038.54961450385, 45086.0, 8784.736457906272, 9086.318526110535, 9092.227160691316, 9106.317026223027, 9109.68116115936, 8961.148690874357, 9060.411073280216, 9083.772905677344, 9086.954565227164, 9089.045650206732, 9143.177114059734, 9160.633574657038, 9182.540872956359, 9190.632374705037, 9194.08059194082, 9077.500737459437, 9125.771855703628, 9140.497272650002, 9143.817123657489, 9154.588043538024, 8913.866292005625, 8957.328200384996, 8981.730548083502, 8988.505632190227, 9055.18503334703, 42580.0, 42900.57099428997, 42983.785081074704, 42989.0, 43091.35362969558, 3796.2027974125467, 3855.575886652466, 4079.9592004080173, 4156.251874662559, 4358.411614432042, 32787.0, 32825.50761738576, 33001.6699833001, 33311.6668833311, 33787.324253514795, 4424.469063712375, 4459.241928872067, 4519.661025423106, 4532.410786597754, 4546.47715512717, 331183.0, 334132.0, 334955.0, 335660.0, 337252.0, 58196.127058094164, 58613.0, 58671.70664146652, 58682.0, 58829.0, 35485.0, 35980.820095899355, 36010.0, 37561.624383755814, 38035.429468557995, 17516.737248941277, 17520.21159047846, 17636.294548217928, 17657.38199163023, 17696.380626678005, 13581.524646637321, 13609.591712248648, 13649.454021839214, 13656.522021729192, 13725.0, 19592.70610940837, 19618.901905490668, 19849.503762406057, 19885.0, 19986.300479483438, 6945.409640180641, 7181.174164970991, 7307.415406767446, 7487.925120748723, 7642.121156067124, 1001.1140140975144, 1004.372267332917, 1006.7734759679014, 1088.395940253167, 1093.2183488805383, 32552.186195345304, 32645.347093058004, 32843.50734738981, 33107.172320691694, 33163.0, 1099.5601759296185, 1124.835794952237, 1129.1192869561755, 1158.507634255438, 1229.901607871386, 16458.177091145393, 16887.73341999355, 16967.83032169687, 17106.40127595553, 17109.315627375014, 574237.0, 576704.0, 576758.0, 577919.0, 578143.0, 58868.705656471444, 59016.0, 59280.407195928354, 59325.0, 59414.0, 1373.0457332154256, 1376.9036167468182, 1383.1493631416606, 1391.4851504943235, 1401.3133564553295, 31041.0, 31062.68937310598, 31100.844495777375, 31410.0, 32337.191570210933, 51203.0, 51609.74195129, 51664.48335516597, 52177.7391113042, 52231.0, 509208.0, 515823.0, 518574.0, 524943.0, 525222.0, 28554.42891142207, 28977.13068607945, 29022.419551609273, 29060.0, 29063.128106156848, 47647.76176119097, 47991.76004119957, 48095.5190448091, 48408.0, 48645.27032094592, 40821.0, 41271.7936410316, 41678.0, 41770.37344439775, 42428.0, 40829.79585102056, 40856.38715419212, 41360.59579689787, 41924.0, 42413.0, 36092.09769755777, 41299.793501032305, 42382.57617423786, 42455.3631695531, 43466.0, 35492.645073548934, 36951.63048369482, 37107.257854843294, 37378.626213737516, 37483.81258093692, 28275.57586636161, 28507.144785656463, 28525.0, 28604.284892877844, 28827.397151427067], "value": 20382.25583693304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.24721652468565, 400.5233771811544, 401.6385253272053, 402.34819592260544, 415.63424186715685, 18376.540586485346, 20018.59962800745, 20087.899560502196, 20238.392848214542, 20525.0, 18395.81604183961, 18477.35329263476, 19148.042597870084, 19740.506487337825, 19816.504587385323, 5663.830085097433, 5768.567357448208, 5842.47417732404, 5873.412658734135, 5878.294604647427, 5658.943410565904, 5721.284839395075, 5794.82615521535, 5821.650700957956, 5834.154047663086, 5651.632643878155, 5707.62900411474, 5782.479576838084, 5815.302163740357, 5844.415558444143, 5454.290942177491, 5681.0, 5705.942940570603, 5724.713764311809, 5747.0517364635, 5591.245181900432, 5641.407652196543, 5679.2333035040565, 5683.090705487143, 5705.4579814917515, 13284.667883302898, 14228.644283892882, 14245.643858903506, 14276.57170284893, 14278.357473913698, 2698.190542837141, 2741.3420779013095, 2771.625830512875, 2778.3748656552116, 2974.866131024109, 10210.438425886574, 10398.168146548334, 10597.099246564052, 11734.53061877524, 12459.0, 1879.370410912346, 1935.2162374238455, 2001.1195074167465, 2003.8998050097582, 2038.7553493580717, 79099.6045019777, 82564.76152857771, 82807.17192828054, 83582.0, 84270.0, 9853.571232171294, 10472.581096756045, 10867.45662716861, 10931.453427328603, 11162.665120046411, 15318.0, 15394.461193858162, 15427.5371738848, 15427.84572154264, 15536.378544858078, 8122.309603683635, 8299.377546684023, 8361.540115293717, 8499.192576705203, 8557.657693692307, 8182.7954301142945, 8229.790381751121, 8247.0, 8344.791380215544, 8381.580920953927, 4568.086382723469, 4668.229742092517, 4671.182543054952, 4676.719396836133, 4757.714537127784, 1911.3788018893915, 1938.3894073366844, 1946.9318573849848, 1970.5664753754152, 2007.056683358819, 886.8847049883474, 929.9860502092474, 1013.3717095400899, 1052.2423854824515, 1053.1785207538132, 19415.0, 19718.211271549266, 19747.605047899247, 20045.79954200439, 20116.396508104488, 986.6990567876867, 999.2006394884064, 1004.0862814838462, 1008.6016023670609, 1023.948802559869, 10975.451227438596, 11392.658220253406, 11396.430178491042, 11425.942870285595, 11430.542778288942, 496979.0, 508595.0, 515981.0, 521381.0, 521807.0, 89582.0, 90478.54760726154, 90919.54540227388, 93397.5330123345, 93548.0, 1002.7693630465034, 1030.8196065688473, 1041.0, 1054.056619325699, 1057.8677665291839, 17416.82583174152, 17732.734008989617, 17810.91094544519, 17960.640787184446, 18335.633287334447, 39978.0, 40825.795871020455, 41677.82953795603, 42302.0, 43425.56574434342, 55699.443005569425, 55701.44298556963, 56072.0, 56101.0, 63047.68476157774, 12502.624921252376, 13618.795718064435, 13764.380602873094, 13851.37668804886, 13959.162450253018, 14197.574072777834, 14337.56987290383, 14484.927575362055, 14912.925435372754, 14972.625684357978, 12741.044421668226, 12901.0, 12988.545400910923, 13071.346432678138, 13256.0, 12302.446389912655, 12698.555550556055, 12759.74480510366, 12911.096223264281, 13082.215067096005, 8379.916200837913, 8846.424982376126, 8966.193042626195, 9306.860397093913, 9319.347645664739, 13492.988025897901, 13729.313534323044, 13729.931350343584, 13786.793198102238, 13889.791653125008, 13164.670883227613, 13223.66940826487, 13249.867501325249, 13588.45646174142, 13609.183448993092], "value": 9525.456396080692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.0836976889443, 1496.3864815425675, 1600.1759094066558, 1709.7435384692303, 1719.123247143957, 7873.606319684021, 8475.194856488639, 8523.659053637855, 9068.365214434993, 9112.589933452993, 8605.39762216645, 8864.202221800037, 8905.73282801517, 8956.552172391386, 8957.0, 2276.635738281879, 2309.538092381522, 2309.6304591265402, 2320.3503019154664, 2322.605157123293, 2204.713387259654, 2217.1907253852387, 2280.600894843404, 2300.18343488061, 2304.7003889494426, 2242.988785056081, 2251.6960210371635, 2270.4323919020244, 2294.977050229493, 2304.976950230501, 2203.1627981367137, 2238.160689741347, 2249.0666373454997, 2255.0641483784293, 2258.9096436142536, 2256.5261295128043, 2272.4659704969317, 2281.5436912617542, 2283.2807665585287, 2285.0517035430275, 9043.819123617557, 9121.49831759253, 9124.58939347731, 9132.771680707969, 9150.679726209552, 5116.667416617908, 5285.048691235576, 5303.363596368422, 5304.389995150568, 5323.787048518055, 3223.8226897520626, 3257.9185520361943, 3401.6768407001296, 3409.2670075933793, 3451.516787649731, 1125.1224045244721, 1125.5441546173813, 1129.3562669278515, 1152.9308241505537, 1162.6686394377646, 12589.685257868443, 12620.053495987837, 12700.682482937907, 12709.17390369623, 12716.554920577828, 4580.1068791585985, 4587.839425620087, 4667.276572131325, 4680.602148817388, 4687.320338550891, 10529.84205236922, 10604.363738175734, 10620.946895265628, 10640.457133715568, 10645.041946224877, 5295.0, 5298.311219541512, 5300.310959575308, 5314.441983591744, 5321.0, 4159.10579225462, 4709.976450117796, 4730.361401210861, 4828.010257897193, 4872.756362181876, 4042.3734321180264, 4078.6940979426663, 4175.06061136248, 4187.392828039917, 4245.919499445249, 1280.705437749323, 1293.0819118425834, 1299.051692264652, 1304.243538747524, 1305.2103477396229, 933.9912894074383, 955.4219697083304, 963.6386355116831, 971.5676523946917, 992.3946392700446, 5898.734556944948, 5928.911066334009, 5975.731092100866, 6049.122877182784, 6191.752329906843, 445.07202482823027, 455.6127291801942, 458.09754783077284, 462.9791659375336, 466.1027522020165, 3956.802159891994, 3982.7212095153063, 3989.780562069056, 4013.157236980267, 4084.448599439097, 10762.461876906124, 10934.56261749521, 11026.173037022256, 11108.944455277671, 11253.099752019818, 10892.61875834342, 10936.179786516042, 10940.835887461695, 11000.944995275133, 11014.00873921351, 7891.723789667449, 8231.670733170726, 8233.629486673113, 8320.126386729306, 8365.623546940402, 5806.071028635398, 5838.824835254949, 5900.852478688067, 5930.940690593039, 5992.43071908168, 10194.43930583825, 10423.791524169323, 10475.057244848, 10500.684979450629, 10567.577296908345, 10229.130523905254, 10468.267221294436, 10501.369917804956, 10502.947485262524, 10530.842037369599, 7143.535670181422, 7745.109312429143, 7981.880271796043, 8003.759887203393, 8175.345972322081, 8791.648334066565, 8827.205551500396, 8829.470231786114, 8841.911580884109, 8863.423877447945, 7587.127480339611, 7780.883286750816, 7852.0, 8082.393820463371, 8113.59432028408, 7801.4929029612895, 7902.288794008567, 7928.643211055632, 7947.8807817881625, 7975.042994840424, 7196.568205907663, 7258.657148427346, 7284.562926224444, 7331.78004659861, 7352.2280160584505, 5266.526012658879, 5292.391374991926, 5373.543248823894, 5375.919361209663, 5421.40364559906, 4994.850154495371, 5010.423801262901, 5030.144875371123, 5031.169856973558, 5046.798128074983], "value": 4584.053652370486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.22908073437503, 314.529777981917, 314.93071524264667, 317.7553283971341, 318.8724510195923, 5666.433356664332, 5666.631668941521, 5673.319201695797, 5733.140028995647, 5739.0, 5594.944050559493, 5598.272224610805, 5626.156076588513, 5649.406812284713, 5652.943470565293, 4095.3447448408187, 4205.137946720914, 4301.3547967804925, 4316.568343165674, 4333.891652708692, 4253.3619957006385, 4269.316909294514, 4273.50854651716, 4289.399484072217, 4312.396264522969, 4250.447441832557, 4261.5738426157295, 4262.46719160105, 4264.104538047014, 4313.698041137121, 4033.2336855997414, 4240.766757828318, 4241.660667146621, 4260.616544510978, 4290.334998075304, 3694.3350196964534, 3700.2414505026404, 3717.5687360366455, 3719.609441008682, 3722.3671975764187, 5491.121420572689, 5514.145307477347, 5525.309336332958, 5525.336959564878, 5537.916931246034, 4853.878653033667, 4865.245886887538, 4876.487968763265, 4896.387951506062, 4943.1596628573225, 5843.2695913010875, 5848.941510584925, 5859.824205273806, 5862.618929769551, 5865.941340586625, 4085.611866872642, 4126.546079931205, 4143.8964025899295, 4162.875113746592, 4169.207850508394, 5896.410358964112, 6078.96960515199, 6104.328523862371, 6147.354527774564, 6204.410580994799, 4187.623113919762, 4195.223883581547, 4215.3044747616295, 4225.260579398593, 4226.450561426995, 4203.306454434984, 4220.936685949713, 4245.787710614457, 4263.722858014219, 4291.120320334324, 4667.696599721007, 4883.121038213156, 4926.704397736147, 4961.181405068123, 4984.355162796341, 5917.585768996215, 5925.703714814242, 5972.193753843262, 5974.9402505974385, 5976.880462390728, 1439.3810661415482, 1456.1845366594741, 1464.4508309383982, 1465.6042868425466, 1480.4448331875547, 930.2465003347311, 944.4191822029402, 951.5527701980059, 977.6578197630914, 986.2405947420447, 5613.887722245614, 5620.690862002547, 5624.690642014647, 5643.7707105693025, 5703.201551782754, 5911.793087241926, 5991.64050156992, 6034.366391528914, 6063.636181829104, 6093.618041986651, 5396.730163491809, 5609.887802243932, 5690.374058853523, 5690.605801578639, 5708.602386997471, 3219.5492631031675, 3229.822359770188, 3238.2351618368048, 3242.5298331742238, 3258.2668899497426, 6129.35641757609, 6165.198524191826, 6258.874822503524, 6259.311475737665, 6305.211848518935, 6134.263888333339, 6137.925862974051, 6149.755339301123, 6201.519392243049, 6207.286162091417, 6111.624884401063, 6250.249970003538, 6283.874322513524, 6297.811065668037, 6325.335839736854, 6064.9393506066135, 6083.513318934386, 6084.726187321493, 6100.603460775035, 6118.265808103056, 5994.28068631767, 6020.397960203944, 6037.18498002764, 6055.757769689163, 6063.818085457443, 6015.72929218195, 6234.314225435289, 6266.749330026748, 6347.682615869096, 6352.428281454691, 4077.653399461079, 4130.277201489667, 4161.417401563844, 4173.436586060843, 4184.895377615584, 5858.0, 5862.589618726648, 6162.784302549389, 6163.414475624809, 6199.535034872493, 5834.411836720471, 5952.464278214981, 5955.821325360246, 5957.940420595912, 5958.910616340671, 5860.560457965585, 5892.878563716973, 5921.171036055042, 5922.230110085661, 5959.642421454727, 5555.7499912504845, 5679.858003549944, 5759.2512973313205, 5777.8555536111935, 5782.0, 5818.974133450667, 5820.417958204315, 5820.73806678692, 5872.120921305313, 5885.646861188342, 5488.945110549003, 5675.9499492594005, 5739.454751798572, 5750.281214848144, 5802.245708057925], "value": 4440.064654663794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6431819771915, 749.6439191384092, 778.9143194248635, 821.5029906906318, 847.6736456464259, 14091.0, 14638.780418293707, 14661.70676586469, 14682.11907285561, 14700.485483008097, 14096.0, 14274.785878211835, 14294.571162865104, 14300.570982870504, 14304.642383940407, 647.9319671434503, 766.1495739728897, 793.2820797178534, 795.399473397584, 797.214743477674, 788.9723859664913, 791.8653828849109, 793.5556088590408, 796.6574373019599, 798.808286011356, 840.5461051032435, 843.780617039568, 844.7507985144366, 845.2097289034741, 848.0586548930683, 842.2335674536173, 843.9746807595751, 844.4679851693425, 850.3494826457764, 851.706161374331, 612.10326871134, 617.9042248451498, 621.4065567383138, 622.3869488553771, 623.8533944523033, 13942.860571394258, 13948.163110213318, 13983.300834958312, 13984.510542131078, 14043.368048437846, 14627.63430914225, 14795.852041479555, 14800.259987000714, 14857.182854942974, 14886.851131488764, 11345.773084538263, 11363.829542556869, 11365.147613928988, 11401.828972565418, 11530.711732206679, 3743.382341913581, 3774.5281839770028, 3819.923601527954, 3826.2730081284467, 3844.2503711776217, 74490.62754686247, 75514.62242688806, 76177.61911190409, 76691.6165419175, 77351.61324193343, 10800.891991079989, 11248.718782030352, 11537.942310288563, 11713.297202167898, 11854.585089521825, 20769.169233230805, 21049.89475052615, 21091.472713182295, 21115.788842111688, 21125.26061587837, 7396.593187374639, 8203.138670439637, 8388.832223355621, 8529.57352132391, 8592.140785921358, 4825.396825396825, 4890.486498917634, 5017.397912250553, 5109.7700603472185, 5165.819196328186, 3458.0836078439233, 3607.3687104756564, 3609.657082577151, 3611.94582081269, 3619.2761447710564, 597.8087012156155, 601.7923816283375, 608.5435923057706, 615.6583096381462, 620.8168590265882, 636.974521019154, 666.2637785247329, 732.6995931667991, 752.2139364364252, 760.4600733479181, 8727.60725767342, 8907.331950103639, 9022.766515954496, 9365.578548965314, 9422.575984080733, 625.7036675401288, 668.238208442376, 697.069412334539, 739.985200295991, 742.6843591473602, 4351.978240108842, 4518.977405112953, 4608.700434471749, 4669.929951050737, 4697.412823397075, 112849.4357528207, 116044.0, 117510.0, 118594.0, 120035.0, 100611.49694251482, 101175.0, 102645.48677256715, 103205.0, 104949.0, 91585.54207228922, 92845.53577232071, 94474.5276273628, 95137.0, 95369.0, 8336.208060234268, 8401.915980840358, 8561.657533698582, 8602.311815054905, 8607.698730544402, 49921.75039124781, 52110.47889521056, 52564.0, 52626.47373526216, 53737.19394209168, 67192.32807671861, 76135.23864761282, 77028.61485692536, 78943.0, 79061.0, 12495.500179992698, 12734.0, 12922.0, 13437.260950647807, 13941.093828901088, 13681.521146759816, 14084.436622534984, 14383.352749126523, 14730.337134828744, 15909.284082216096, 12839.679008024874, 13039.035356631894, 13245.801312980506, 13438.193708377528, 14196.219207943663, 13071.608729027352, 13349.199048057148, 13435.932820335836, 13534.255615941218, 13883.583492495241, 12133.272003679807, 12285.75428491443, 12389.256644601353, 12582.811257831323, 12730.045246606727, 10394.596729441731, 10432.165426765689, 10470.11004064663, 10496.527656255334, 10692.358458492516, 10734.570617175537, 10739.838902416313, 10789.676309710721, 10857.15428377162, 10879.0], "value": 7441.561061396627, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 109.0, 110.0, 111.0, 111.0, 110.0, 112.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 158.0, 203.0, 128.0, 160.0, 151.0, 129.0, 195.0, 126.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 160.0, 166.0, 172.0, 164.0, 163.0, 162.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 161.0, 76.0, 76.0, 75.0, 76.0, 164.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 147.0, 86.0, 85.0, 85.0, 142.0, 85.0, 86.0, 132.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 54.0, 55.0, 59.0, 54.0, 54.0, 55.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 64.0, 63.0, 61.0, 72.0, 61.0, 62.0, 62.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 81.0, 80.0, 84.0, 85.0, 79.0, 82.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 135.0, 124.0, 120.0, 127.0, 130.0, 128.0, 123.0, 133.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 158.0, 161.0, 161.0, 156.0, 164.0, 161.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 63.0, 66.0, 63.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0], "value": 63.7, "unit": "score"}]}]} 08:39:23 INFO - Return code: 0 08:39:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:23 ERROR - # TBPL SUCCESS # 08:39:23 INFO - Running post-action listener: _resource_record_post_action 08:39:23 INFO - ##### 08:39:23 INFO - ##### Finished run-tests step (success) 08:39:23 INFO - ##### 08:39:23 INFO - Running post-run listener: _resource_record_post_run 08:39:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551366656; Read time: 400; Write time: 522800 08:39:23 INFO - TinderboxPrint: CPU usage
13.4% 08:39:23 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 400 08:39:23 INFO - TinderboxPrint: I/O write bytes / time
551,366,656 / 522,800 08:39:23 INFO - TinderboxPrint: CPU idle
8,232.3 (86.6%) 08:39:23 INFO - TinderboxPrint: CPU user
1,216.8 (12.8%) 08:39:23 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 168923136; Read time: 176; Write time: 240052 08:39:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294461440; Read time: 224; Write time: 230796 08:39:24 INFO - Running post-run listener: _upload_blobber_files 08:39:24 INFO - Blob upload gear active. 08:39:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:24 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:39:24 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:39:24 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:39:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:25 INFO - (blobuploader) - INFO - Done attempting. 08:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:26 INFO - (blobuploader) - INFO - Done attempting. 08:39:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:30 INFO - (blobuploader) - INFO - Done attempting. 08:39:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:30 INFO - Return code: 0 08:39:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286c63506019c7d1e77c50bc226b93bc031bc37ea6dbd2c5982d9210c138e2462a047c9b8d5543f5d82a9ca8161db7643672d138a61b30c487731dd9a2f6dc6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3ea14357cb7a1fae98cb00350cfec9ab2f591ed69364b4cd69b6b47f286f6b1b66101397067f75e5cdc8279d7f27afe7001d995d7df95a66331922dae3a6c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7216fa872b0473d11c59281cea76158705099820cb2d7e1d20db788a29e54221a7ee027fe9986ebc3b20ba873e8fd339613a4af2d6cd60e61e61f201c391e85f"} 08:39:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:30 INFO - Contents: 08:39:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286c63506019c7d1e77c50bc226b93bc031bc37ea6dbd2c5982d9210c138e2462a047c9b8d5543f5d82a9ca8161db7643672d138a61b30c487731dd9a2f6dc6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3ea14357cb7a1fae98cb00350cfec9ab2f591ed69364b4cd69b6b47f286f6b1b66101397067f75e5cdc8279d7f27afe7001d995d7df95a66331922dae3a6c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7216fa872b0473d11c59281cea76158705099820cb2d7e1d20db788a29e54221a7ee027fe9986ebc3b20ba873e8fd339613a4af2d6cd60e61e61f201c391e85f"} 08:39:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:30 INFO - Copying logs to upload dir... 08:39:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.670969 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-27 08:39:29.976007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:29.979473) ========= 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=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286c63506019c7d1e77c50bc226b93bc031bc37ea6dbd2c5982d9210c138e2462a047c9b8d5543f5d82a9ca8161db7643672d138a61b30c487731dd9a2f6dc6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3ea14357cb7a1fae98cb00350cfec9ab2f591ed69364b4cd69b6b47f286f6b1b66101397067f75e5cdc8279d7f27afe7001d995d7df95a66331922dae3a6c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7216fa872b0473d11c59281cea76158705099820cb2d7e1d20db788a29e54221a7ee027fe9986ebc3b20ba873e8fd339613a4af2d6cd60e61e61f201c391e85f"} build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286c63506019c7d1e77c50bc226b93bc031bc37ea6dbd2c5982d9210c138e2462a047c9b8d5543f5d82a9ca8161db7643672d138a61b30c487731dd9a2f6dc6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3ea14357cb7a1fae98cb00350cfec9ab2f591ed69364b4cd69b6b47f286f6b1b66101397067f75e5cdc8279d7f27afe7001d995d7df95a66331922dae3a6c0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7216fa872b0473d11c59281cea76158705099820cb2d7e1d20db788a29e54221a7ee027fe9986ebc3b20ba873e8fd339613a4af2d6cd60e61e61f201c391e85f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:30.005340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:30.005690) ========= 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=fa44defc139c4ba8574fe040000001db-1467040420.625391-576036337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:30.090304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:39:30.090748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:39:30.091078) ========= ========= Total master_lag: 0.22 =========