builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1466874519.09 results: success (0) buildid: 20160625093624 builduid: 33c7d58e0c4242659b340824c5735d04 revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.091493) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.091886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.092204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.134934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.135291) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 10:08:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.1M=0s 2016-06-25 10:08:39 (97.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158490 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.314934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.315267) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019626 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:39.366093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 10:08:39.366394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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 59bc5cd1caa619e2be168d5fa67803f9e96c4309 --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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 10:08:39,598 truncating revision to first 12 chars 2016-06-25 10:08:39,598 Setting DEBUG logging. 2016-06-25 10:08:39,598 attempt 1/10 2016-06-25 10:08:39,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/59bc5cd1caa6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 10:08:40,252 unpacking tar archive at: fx-team-59bc5cd1caa6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-25 10:08:40.388553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:40.388882) ========= script_repo_revision: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:40.389282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:40.389579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 10:08:40.399871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-25 10:08:40.400167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:40 INFO - MultiFileLogger online at 20160625 10:08:40 in /builds/slave/test 10:08:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:08:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:40 INFO - {'append_to_log': False, 10:08:40 INFO - 'base_work_dir': '/builds/slave/test', 10:08:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:40 INFO - 'branch': 'Fx-Team-Non-PGO', 10:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:40 INFO - 'config_files': ('talos/linux_config.py',), 10:08:40 INFO - 'default_actions': ('clobber', 10:08:40 INFO - 'read-buildbot-config', 10:08:40 INFO - 'download-and-extract', 10:08:40 INFO - 'populate-webroot', 10:08:40 INFO - 'create-virtualenv', 10:08:40 INFO - 'install', 10:08:40 INFO - 'run-tests'), 10:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:40 INFO - 'download_minidump_stackwalk': True, 10:08:40 INFO - 'download_symbols': 'ondemand', 10:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:40 INFO - 'installer_path': 'installer.exe', 10:08:40 INFO - 'log_level': 'info', 10:08:40 INFO - 'log_name': 'talos', 10:08:40 INFO - 'log_to_console': True, 10:08:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:40 INFO - 'opt_config_files': (), 10:08:40 INFO - 'pip_index': False, 10:08:40 INFO - 'sps_profile': False, 10:08:40 INFO - 'sps_profile_interval': 0, 10:08:40 INFO - 'suite': 'dromaeojs-e10s', 10:08:40 INFO - 'system_bits': '32', 10:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:40 INFO - 'title': 'talos-linux64-ix-012', 10:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:40 INFO - 'use_talos_json': True, 10:08:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:40 INFO - 'work_dir': 'build'} 10:08:40 INFO - ##### 10:08:40 INFO - ##### Running clobber step. 10:08:40 INFO - ##### 10:08:40 INFO - Running pre-action listener: _resource_record_pre_action 10:08:40 INFO - Running main action method: clobber 10:08:40 INFO - rmtree: /builds/slave/test/build 10:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:41 INFO - Running post-action listener: _resource_record_post_action 10:08:41 INFO - ##### 10:08:41 INFO - ##### Finished clobber step (success) 10:08:41 INFO - ##### 10:08:41 INFO - ##### 10:08:41 INFO - ##### Running read-buildbot-config step. 10:08:41 INFO - ##### 10:08:41 INFO - Running pre-action listener: _resource_record_pre_action 10:08:41 INFO - Running main action method: read_buildbot_config 10:08:41 INFO - Using buildbot properties: 10:08:41 INFO - { 10:08:41 INFO - "project": "", 10:08:41 INFO - "product": "firefox", 10:08:41 INFO - "script_repo_revision": "production", 10:08:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:08:41 INFO - "repository": "", 10:08:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:08:41 INFO - "buildid": "20160625093624", 10:08:41 INFO - "pgo_build": "False", 10:08:41 INFO - "basedir": "/builds/slave/test", 10:08:41 INFO - "buildnumber": 1613, 10:08:41 INFO - "slavename": "talos-linux64-ix-012", 10:08:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:08:41 INFO - "platform": "ubuntu64_hw", 10:08:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:08:41 INFO - "branch": "fx-team", 10:08:41 INFO - "repo_path": "integration/fx-team", 10:08:41 INFO - "revision": "59bc5cd1caa619e2be168d5fa67803f9e96c4309", 10:08:41 INFO - "stage_platform": "linux64", 10:08:41 INFO - "builduid": "33c7d58e0c4242659b340824c5735d04", 10:08:41 INFO - "slavebuilddir": "test" 10:08:41 INFO - } 10:08:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:08:41 INFO - Running post-action listener: _resource_record_post_action 10:08:41 INFO - ##### 10:08:41 INFO - ##### Finished read-buildbot-config step (success) 10:08:41 INFO - ##### 10:08:41 INFO - ##### 10:08:41 INFO - ##### Running download-and-extract step. 10:08:41 INFO - ##### 10:08:41 INFO - Running pre-action listener: _resource_record_pre_action 10:08:41 INFO - Running main action method: download_and_extract 10:08:41 INFO - mkdir: /builds/slave/test/build/tests 10:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:41 INFO - https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:43 INFO - Downloaded 1361 bytes. 10:08:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:08:43 INFO - Using the following test package requirements: 10:08:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:08:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'jsshell-linux-x86_64.zip'], 10:08:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:08:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:08:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08:43 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')]} 10:08:43 INFO - https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:48 INFO - Downloaded 22713106 bytes. 10:08:48 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'] 10:08:48 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 10:08:49 INFO - Return code: 0 10:08:49 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 10:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:49 INFO - https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:50 INFO - Downloaded 22713106 bytes. 10:08:50 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'] 10:08:50 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 10:08:51 INFO - Return code: 0 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:52 INFO - Downloaded 14405188 bytes. 10:08:52 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'] 10:08:52 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 10:08:52 INFO - Return code: 0 10:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:52 INFO - https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B5RJnMlrREaEB9osItV7cA/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 10:08:54 INFO - Downloaded 56277553 bytes. 10:08:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:08:54 INFO - mkdir: /builds/slave/test/properties 10:08:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:54 INFO - Contents: 10:08:54 INFO - build_url:https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:08:55 INFO - Running post-action listener: _resource_record_post_action 10:08:55 INFO - Running post-action listener: set_extra_try_arguments 10:08:55 INFO - ##### 10:08:55 INFO - ##### Finished download-and-extract step (success) 10:08:55 INFO - ##### 10:08:55 INFO - ##### 10:08:55 INFO - ##### Running populate-webroot step. 10:08:55 INFO - ##### 10:08:55 INFO - Running pre-action listener: _resource_record_pre_action 10:08:55 INFO - Running main action method: populate_webroot 10:08:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:55 INFO - '--tppagecycles', 10:08:55 INFO - '7'], 10:08:55 INFO - 'tests': ['tsvgm']}}, 10:08:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['damp', 'tps']}, 10:08:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'tests': ['damp', 'tps']}, 10:08:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['dromaeo_dom']}, 10:08:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['basic_compositor_video']}, 10:08:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:08:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['a11yr', 10:08:55 INFO - 'ts_paint', 10:08:55 INFO - 'tpaint', 10:08:55 INFO - 'sessionrestore', 10:08:55 INFO - 'sessionrestore_no_auto_restore', 10:08:55 INFO - 'tabpaint']}, 10:08:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['tsvgx', 10:08:55 INFO - 'tsvgr_opacity', 10:08:55 INFO - 'tart', 10:08:55 INFO - 'tscrollx', 10:08:55 INFO - 'cart']}, 10:08:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:55 INFO - 'tsvgr_opacity', 10:08:55 INFO - 'tart', 10:08:55 INFO - 'tscrollx', 10:08:55 INFO - 'cart']}, 10:08:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'talos_options': ['--disable-e10s'], 10:08:55 INFO - 'tests': ['tp5o']}, 10:08:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'tests': ['tp5o']}, 10:08:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'talos_options': ['--disable-e10s', 10:08:55 INFO - '--xperf_path', 10:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:55 INFO - 'tests': ['tp5n']}, 10:08:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:55 INFO - 'talos_options': ['--xperf_path', 10:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:55 INFO - 'tests': ['tp5n']}}, 10:08:55 INFO - 'talos.zip': {'path': '', 10:08:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:55 INFO - Running post-action listener: _resource_record_post_action 10:08:55 INFO - ##### 10:08:55 INFO - ##### Finished populate-webroot step (success) 10:08:55 INFO - ##### 10:08:55 INFO - ##### 10:08:55 INFO - ##### Running create-virtualenv step. 10:08:55 INFO - ##### 10:08:55 INFO - Running pre-action listener: _resource_record_pre_action 10:08:55 INFO - Running main action method: create_virtualenv 10:08:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:08:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:55 INFO - Using real prefix '/usr' 10:08:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:58 INFO - Installing pip.................done. 10:08:58 INFO - Return code: 0 10:08:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:58 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')]} 10:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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')]} 10:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:08:58 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 10:08:58 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 10:08:58 INFO - Using env: {'DISPLAY': ':0', 10:08:58 INFO - 'HOME': '/home/cltbld', 10:08:58 INFO - 'LANG': 'en_US.UTF-8', 10:08:58 INFO - 'LANGUAGE': 'en_US:en', 10:08:58 INFO - 'LOGNAME': 'cltbld', 10:08:58 INFO - 'MAIL': '/var/mail/cltbld', 10:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:58 INFO - 'MOZ_NO_REMOTE': '1', 10:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:58 INFO - 'NO_EM_RESTART': '1', 10:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:58 INFO - 'PWD': '/builds/slave/test', 10:08:58 INFO - 'SHELL': '/bin/bash', 10:08:58 INFO - 'SHLVL': '1', 10:08:58 INFO - 'TERM': 'linux', 10:08:58 INFO - 'TMOUT': '86400', 10:08:58 INFO - 'USER': 'cltbld', 10:08:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:58 INFO - '_': '/tools/buildbot/bin/python'} 10:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:58 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 10:08:58 INFO - Cleaning up... 10:08:58 INFO - Return code: 0 10:08:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:58 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')]} 10:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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')]} 10:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:08:58 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 10:08:58 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 10:08:58 INFO - Using env: {'DISPLAY': ':0', 10:08:58 INFO - 'HOME': '/home/cltbld', 10:08:58 INFO - 'LANG': 'en_US.UTF-8', 10:08:58 INFO - 'LANGUAGE': 'en_US:en', 10:08:58 INFO - 'LOGNAME': 'cltbld', 10:08:58 INFO - 'MAIL': '/var/mail/cltbld', 10:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:58 INFO - 'MOZ_NO_REMOTE': '1', 10:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:58 INFO - 'NO_EM_RESTART': '1', 10:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:58 INFO - 'PWD': '/builds/slave/test', 10:08:58 INFO - 'SHELL': '/bin/bash', 10:08:58 INFO - 'SHLVL': '1', 10:08:58 INFO - 'TERM': 'linux', 10:08:58 INFO - 'TMOUT': '86400', 10:08:58 INFO - 'USER': 'cltbld', 10:08:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:58 INFO - '_': '/tools/buildbot/bin/python'} 10:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:58 INFO - Downloading/unpacking psutil>=3.1.1 10:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:01 INFO - Installing collected packages: psutil 10:09:01 INFO - Running setup.py install for psutil 10:09:01 INFO - building 'psutil._psutil_linux' extension 10:09:01 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 10:09:02 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 10:09:02 INFO - building 'psutil._psutil_posix' extension 10:09:02 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 10:09:02 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 10:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:02 INFO - Successfully installed psutil 10:09:02 INFO - Cleaning up... 10:09:03 INFO - Return code: 0 10:09:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:09:03 INFO - Using env: {'DISPLAY': ':0', 10:09:03 INFO - 'HOME': '/home/cltbld', 10:09:03 INFO - 'LANG': 'en_US.UTF-8', 10:09:03 INFO - 'LANGUAGE': 'en_US:en', 10:09:03 INFO - 'LOGNAME': 'cltbld', 10:09:03 INFO - 'MAIL': '/var/mail/cltbld', 10:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:03 INFO - 'MOZ_NO_REMOTE': '1', 10:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:03 INFO - 'NO_EM_RESTART': '1', 10:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:03 INFO - 'PWD': '/builds/slave/test', 10:09:03 INFO - 'SHELL': '/bin/bash', 10:09:03 INFO - 'SHLVL': '1', 10:09:03 INFO - 'TERM': 'linux', 10:09:03 INFO - 'TMOUT': '86400', 10:09:03 INFO - 'USER': 'cltbld', 10:09:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:03 INFO - '_': '/tools/buildbot/bin/python'} 10:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:05 INFO - Installing collected packages: mozsystemmonitor 10:09:05 INFO - Running setup.py install for mozsystemmonitor 10:09:05 INFO - Successfully installed mozsystemmonitor 10:09:05 INFO - Cleaning up... 10:09:05 INFO - Return code: 0 10:09:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:09:05 INFO - Using env: {'DISPLAY': ':0', 10:09:05 INFO - 'HOME': '/home/cltbld', 10:09:05 INFO - 'LANG': 'en_US.UTF-8', 10:09:05 INFO - 'LANGUAGE': 'en_US:en', 10:09:05 INFO - 'LOGNAME': 'cltbld', 10:09:05 INFO - 'MAIL': '/var/mail/cltbld', 10:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:05 INFO - 'MOZ_NO_REMOTE': '1', 10:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:05 INFO - 'NO_EM_RESTART': '1', 10:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:05 INFO - 'PWD': '/builds/slave/test', 10:09:05 INFO - 'SHELL': '/bin/bash', 10:09:05 INFO - 'SHLVL': '1', 10:09:05 INFO - 'TERM': 'linux', 10:09:05 INFO - 'TMOUT': '86400', 10:09:05 INFO - 'USER': 'cltbld', 10:09:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:05 INFO - '_': '/tools/buildbot/bin/python'} 10:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:05 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:07 INFO - warning: no files found matching '*.txt' 10:09:07 INFO - no previously-included directories found matching 'build' 10:09:07 INFO - no previously-included directories found matching 'dist' 10:09:07 INFO - no previously-included directories found matching '.git*' 10:09:07 INFO - Installing collected packages: jsonschema, functools32 10:09:07 INFO - Running setup.py install for functools32 10:09:07 INFO - warning: no files found matching '*.txt' 10:09:07 INFO - no previously-included directories found matching 'build' 10:09:07 INFO - no previously-included directories found matching 'dist' 10:09:07 INFO - no previously-included directories found matching '.git*' 10:09:07 INFO - Successfully installed jsonschema functools32 10:09:07 INFO - Cleaning up... 10:09:07 INFO - Return code: 0 10:09:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:07 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')]} 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 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')]} 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:07 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 10:09:07 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 10:09:07 INFO - Using env: {'DISPLAY': ':0', 10:09:07 INFO - 'HOME': '/home/cltbld', 10:09:07 INFO - 'LANG': 'en_US.UTF-8', 10:09:07 INFO - 'LANGUAGE': 'en_US:en', 10:09:07 INFO - 'LOGNAME': 'cltbld', 10:09:07 INFO - 'MAIL': '/var/mail/cltbld', 10:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:07 INFO - 'MOZ_NO_REMOTE': '1', 10:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:07 INFO - 'NO_EM_RESTART': '1', 10:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:07 INFO - 'PWD': '/builds/slave/test', 10:09:07 INFO - 'SHELL': '/bin/bash', 10:09:07 INFO - 'SHLVL': '1', 10:09:07 INFO - 'TERM': 'linux', 10:09:07 INFO - 'TMOUT': '86400', 10:09:07 INFO - 'USER': 'cltbld', 10:09:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:07 INFO - '_': '/tools/buildbot/bin/python'} 10:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 INFO - Downloading docopt-0.6.1.tar.gz 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:10 INFO - Running setup.py install for blobuploader 10:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:10 INFO - Running setup.py install for requests 10:09:11 INFO - Running setup.py install for docopt 10:09:11 INFO - Successfully installed blobuploader requests docopt 10:09:11 INFO - Cleaning up... 10:09:11 INFO - Return code: 0 10:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:11 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')]} 10:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:11 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')]} 10:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:11 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:11 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 10:09:11 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 10:09:11 INFO - Using env: {'DISPLAY': ':0', 10:09:11 INFO - 'HOME': '/home/cltbld', 10:09:11 INFO - 'LANG': 'en_US.UTF-8', 10:09:11 INFO - 'LANGUAGE': 'en_US:en', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MAIL': '/var/mail/cltbld', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SHLVL': '1', 10:09:11 INFO - 'TERM': 'linux', 10:09:11 INFO - 'TMOUT': '86400', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - '_': '/tools/buildbot/bin/python'} 10:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:11 INFO - Running setup.py (path:/tmp/pip-4DIWlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:11 INFO - Running setup.py (path:/tmp/pip-tAH0oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:11 INFO - Running setup.py (path:/tmp/pip-8w6wOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:11 INFO - Running setup.py (path:/tmp/pip-vcGodz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:11 INFO - Running setup.py (path:/tmp/pip-z9zP1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:11 INFO - Running setup.py (path:/tmp/pip-IaLk9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:11 INFO - Running setup.py (path:/tmp/pip-IufnTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:12 INFO - Running setup.py (path:/tmp/pip-1Vmb2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:12 INFO - Running setup.py (path:/tmp/pip-u05lb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:12 INFO - Running setup.py (path:/tmp/pip-9twv5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:12 INFO - Running setup.py (path:/tmp/pip-LmfEnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:12 INFO - Running setup.py (path:/tmp/pip-X3qfdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:12 INFO - Running setup.py (path:/tmp/pip-hQQ264-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:12 INFO - Running setup.py (path:/tmp/pip-nhl0W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:12 INFO - Running setup.py (path:/tmp/pip-AILzP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:12 INFO - Running setup.py (path:/tmp/pip-IjCy5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:12 INFO - Running setup.py (path:/tmp/pip-1l9J89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:12 INFO - Running setup.py install for manifestparser 10:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:12 INFO - Running setup.py install for mozcrash 10:09:12 INFO - Running setup.py install for mozdebug 10:09:13 INFO - Running setup.py install for mozdevice 10:09:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozfile 10:09:13 INFO - Running setup.py install for mozhttpd 10:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozinfo 10:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozInstall 10:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozleak 10:09:13 INFO - Running setup.py install for mozlog 10:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for moznetwork 10:09:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:13 INFO - Running setup.py install for mozprocess 10:09:14 INFO - Running setup.py install for mozprofile 10:09:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Running setup.py install for mozrunner 10:09:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Running setup.py install for mozscreenshot 10:09:14 INFO - Running setup.py install for moztest 10:09:14 INFO - Running setup.py install for mozversion 10:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:14 INFO - Cleaning up... 10:09:14 INFO - Return code: 0 10:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:14 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:14 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 10:09:14 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 10:09:14 INFO - Using env: {'DISPLAY': ':0', 10:09:14 INFO - 'HOME': '/home/cltbld', 10:09:14 INFO - 'LANG': 'en_US.UTF-8', 10:09:14 INFO - 'LANGUAGE': 'en_US:en', 10:09:14 INFO - 'LOGNAME': 'cltbld', 10:09:14 INFO - 'MAIL': '/var/mail/cltbld', 10:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:14 INFO - 'MOZ_NO_REMOTE': '1', 10:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:14 INFO - 'NO_EM_RESTART': '1', 10:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:14 INFO - 'PWD': '/builds/slave/test', 10:09:14 INFO - 'SHELL': '/bin/bash', 10:09:14 INFO - 'SHLVL': '1', 10:09:14 INFO - 'TERM': 'linux', 10:09:14 INFO - 'TMOUT': '86400', 10:09:14 INFO - 'USER': 'cltbld', 10:09:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:14 INFO - '_': '/tools/buildbot/bin/python'} 10:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 INFO - Running setup.py (path:/tmp/pip-xczpVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 INFO - Running setup.py (path:/tmp/pip-VNZjpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:14 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)) 10:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:14 INFO - Running setup.py (path:/tmp/pip-lGesgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:15 INFO - Running setup.py (path:/tmp/pip-l20Rix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:15 INFO - Running setup.py (path:/tmp/pip-O62Shr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:15 INFO - Running setup.py (path:/tmp/pip-gV0ECs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:15 INFO - Running setup.py (path:/tmp/pip-SgcdE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 INFO - Running setup.py (path:/tmp/pip-lA1TeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:15 INFO - Running setup.py (path:/tmp/pip-c2swlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:15 INFO - Running setup.py (path:/tmp/pip-StcLx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 INFO - Running setup.py (path:/tmp/pip-LxvKmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 INFO - Running setup.py (path:/tmp/pip-RXkNDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 INFO - Running setup.py (path:/tmp/pip-bhHDiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 INFO - Running setup.py (path:/tmp/pip-kWDVP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 INFO - Running setup.py (path:/tmp/pip-basyWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:15 INFO - Running setup.py (path:/tmp/pip-kaAcfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:15 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)) 10:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:15 INFO - Running setup.py (path:/tmp/pip-X86JNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:16 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)) 10:09:16 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)) 10:09:16 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)) 10:09:16 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)) 10:09:16 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)) 10:09:16 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)) 10:09:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:17 INFO - Downloading blessings-1.6.tar.gz 10:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:18 INFO - Installing collected packages: blessings 10:09:18 INFO - Running setup.py install for blessings 10:09:18 INFO - Successfully installed blessings 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:18 INFO - Reading from file tmpfile_stdout 10:09:18 INFO - Current package versions: 10:09:18 INFO - argparse == 1.2.1 10:09:18 INFO - blessings == 1.6 10:09:18 INFO - blobuploader == 1.2.4 10:09:18 INFO - docopt == 0.6.1 10:09:18 INFO - functools32 == 3.2.3-2 10:09:18 INFO - jsonschema == 2.5.1 10:09:18 INFO - manifestparser == 1.1 10:09:18 INFO - mozInstall == 1.12 10:09:18 INFO - mozcrash == 0.17 10:09:18 INFO - mozdebug == 0.1 10:09:18 INFO - mozdevice == 0.48 10:09:18 INFO - mozfile == 1.2 10:09:18 INFO - mozhttpd == 0.7 10:09:18 INFO - mozinfo == 0.9 10:09:18 INFO - mozleak == 0.1 10:09:18 INFO - mozlog == 3.2 10:09:18 INFO - moznetwork == 0.27 10:09:18 INFO - mozprocess == 0.22 10:09:18 INFO - mozprofile == 0.28 10:09:18 INFO - mozrunner == 6.11 10:09:18 INFO - mozscreenshot == 0.1 10:09:18 INFO - mozsystemmonitor == 0.3 10:09:18 INFO - moztest == 0.7 10:09:18 INFO - mozversion == 1.4 10:09:18 INFO - psutil == 3.1.1 10:09:18 INFO - requests == 1.2.3 10:09:18 INFO - wsgiref == 0.1.2 10:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:18 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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 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)) 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:18 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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:18 INFO - Cleaning up... 10:09:18 INFO - Return code: 0 10:09:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09:18 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')]} 10:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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')]} 10:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:18 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 0x7f9edfd07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2213350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', '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 10:09:18 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 10:09:18 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 10:09:18 INFO - Using env: {'DISPLAY': ':0', 10:09:18 INFO - 'HOME': '/home/cltbld', 10:09:18 INFO - 'LANG': 'en_US.UTF-8', 10:09:18 INFO - 'LANGUAGE': 'en_US:en', 10:09:18 INFO - 'LOGNAME': 'cltbld', 10:09:18 INFO - 'MAIL': '/var/mail/cltbld', 10:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:18 INFO - 'MOZ_NO_REMOTE': '1', 10:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:18 INFO - 'NO_EM_RESTART': '1', 10:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:18 INFO - 'PWD': '/builds/slave/test', 10:09:18 INFO - 'SHELL': '/bin/bash', 10:09:18 INFO - 'SHLVL': '1', 10:09:18 INFO - 'TERM': 'linux', 10:09:18 INFO - 'TMOUT': '86400', 10:09:18 INFO - 'USER': 'cltbld', 10:09:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:18 INFO - '_': '/tools/buildbot/bin/python'} 10:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:19 INFO - Downloading/unpacking flake8 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09:20 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 10:09:20 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 10:09:20 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 10:09:20 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 10:09:20 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 10:09:20 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 10:09:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:21 INFO - no previously-included directories found matching 'docs/_build' 10:09:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:21 INFO - Running setup.py install for pep8 10:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:21 INFO - no previously-included directories found matching 'docs/_build' 10:09:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:09:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:21 INFO - Cleaning up... 10:09:21 INFO - Return code: 0 10:09:21 INFO - Running post-action listener: _resource_record_post_action 10:09:21 INFO - Running post-action listener: _start_resource_monitoring 10:09:21 INFO - Starting resource monitoring. 10:09:21 INFO - ##### 10:09:21 INFO - ##### Finished create-virtualenv step (success) 10:09:21 INFO - ##### 10:09:21 INFO - ##### 10:09:21 INFO - ##### Running install step. 10:09:21 INFO - ##### 10:09:21 INFO - Running pre-action listener: _resource_record_pre_action 10:09:21 INFO - Running main action method: install 10:09:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:22 INFO - Reading from file tmpfile_stdout 10:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:22 INFO - Reading from file tmpfile_stdout 10:09:22 INFO - Output received: 10:09:22 INFO - Usage: mozinstall [options] installer 10:09:22 INFO - Options: 10:09:22 INFO - -h, --help show this help message and exit 10:09:22 INFO - -d DEST, --destination=DEST 10:09:22 INFO - Directory to install application into. [default: 10:09:22 INFO - "/builds/slave/test"] 10:09:22 INFO - --app=APP Application being installed. [default: firefox] 10:09:22 INFO - mkdir: /builds/slave/test/build/application 10:09:22 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'] 10:09:22 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 10:09:38 INFO - Reading from file tmpfile_stdout 10:09:38 INFO - Output received: 10:09:38 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:38 INFO - Running post-action listener: _resource_record_post_action 10:09:38 INFO - ##### 10:09:38 INFO - ##### Finished install step (success) 10:09:38 INFO - ##### 10:09:38 INFO - ##### 10:09:38 INFO - ##### Running run-tests step. 10:09:38 INFO - ##### 10:09:38 INFO - Running pre-action listener: _resource_record_pre_action 10:09:38 INFO - Running main action method: run_tests 10:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:38 INFO - Python 2.7.3 10:09:38 INFO - Return code: 0 10:09:38 INFO - grabbing minidump binary from tooltool 10:09:38 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')]} 10:09:38 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 0x22a21c0>, '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 0x22a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:38 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 10:09:38 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 10:09:38 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 10:09:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:38 INFO - Return code: 0 10:09:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:39 INFO - Return code: 0 10:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 10:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 10:09:39 INFO - Using env: {'DISPLAY': ':0', 10:09:39 INFO - 'HOME': '/home/cltbld', 10:09:39 INFO - 'LANG': 'en_US.UTF-8', 10:09:39 INFO - 'LANGUAGE': 'en_US:en', 10:09:39 INFO - 'LOGNAME': 'cltbld', 10:09:39 INFO - 'MAIL': '/var/mail/cltbld', 10:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:39 INFO - 'MOZ_NO_REMOTE': '1', 10:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:39 INFO - 'NO_EM_RESTART': '1', 10:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:39 INFO - 'PWD': '/builds/slave/test', 10:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:39 INFO - 'SHELL': '/bin/bash', 10:09:39 INFO - 'SHLVL': '1', 10:09:39 INFO - 'TERM': 'linux', 10:09:39 INFO - 'TMOUT': '86400', 10:09:39 INFO - 'USER': 'cltbld', 10:09:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039', 10:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:39 INFO - '_': '/tools/buildbot/bin/python'} 10:09:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 10:09:39 INFO - mozversion application_buildid: 20160625093624 10:09:39 INFO - mozversion application_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 10:09:39 INFO - mozversion application_display_name: Nightly 10:09:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:39 INFO - mozversion application_name: Firefox 10:09:39 INFO - mozversion application_remotingname: firefox 10:09:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:09:39 INFO - mozversion application_vendor: Mozilla 10:09:39 INFO - mozversion application_version: 50.0a1 10:09:39 INFO - mozversion platform_buildid: 20160625093624 10:09:39 INFO - mozversion platform_changeset: 59bc5cd1caa619e2be168d5fa67803f9e96c4309 10:09:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:09:39 INFO - mozversion platform_version: 50.0a1 10:09:39 INFO - using testdate: 1466874579 10:09:39 INFO - actual date: 1466874579 10:09:39 INFO - starting webserver on 'localhost:45729' 10:09:39 INFO - SUITE-START | Running 2 tests 10:09:39 INFO - TEST-START | dromaeo_css 10:09:39 INFO - operating with platform_type : linux_ 10:09:39 INFO - Initialising browser for dromaeo_css test... 10:09:39 INFO - TEST-INFO | started process 3409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNdC87/profile http://localhost:45729/getInfo.html) 10:09:45 INFO - PROCESS | 3409 | __metrics Screen width/height:1600/1200 10:09:45 INFO - PROCESS | 3409 | colorDepth:24 10:09:45 INFO - PROCESS | 3409 | Browser inner width/height: 1024/697 10:09:45 INFO - PROCESS | 3409 | __metrics 10:09:47 ERROR - PROCESS | 3409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:09:48 INFO - TEST-INFO | 3409: exit 0 10:09:48 INFO - Browser initialized. 10:09:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:48 INFO - TEST-INFO | started process 3529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNdC87/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:00 INFO - PROCESS | 3529 | RSS: Main: 185245696 10:10:00 INFO - PROCESS | 3529 | 10:10:50 INFO - PROCESS | 3529 | 1466874650021 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] 10:13:02 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45729/tests/dromaeo/cssquery-ext.html) 10:13:03 INFO - PROCESS | 3529 | RSS: Main: 188051456 10:13:03 INFO - PROCESS | 3529 | 10:16:05 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-ext.html (next: http://localhost:45729/tests/dromaeo/cssquery-jquery.html) 10:16:06 INFO - PROCESS | 3529 | RSS: Main: 187666432 10:16:06 INFO - PROCESS | 3529 | 10:19:08 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45729/tests/dromaeo/cssquery-mootools.html) 10:19:08 INFO - PROCESS | 3529 | RSS: Main: 188784640 10:19:08 INFO - PROCESS | 3529 | 10:22:10 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45729/tests/dromaeo/cssquery-prototype.html) 10:22:11 INFO - PROCESS | 3529 | RSS: Main: 186179584 10:22:11 INFO - PROCESS | 3529 | 10:25:13 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45729/tests/dromaeo/cssquery-yui.html) 10:25:14 INFO - PROCESS | 3529 | RSS: Main: 188456960 10:25:14 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | Cycle 1(1): loaded http://localhost:45729/tests/dromaeo/cssquery-yui.html (next: http://localhost:45729/tests/dromaeo/cssquery-dojo.html) 10:28:17 INFO - PROCESS | 3529 | RSS: Main: 189489152 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | __start_tp_report 10:28:17 INFO - PROCESS | 3529 | _x_x_mozilla_page_load 10:28:17 INFO - PROCESS | 3529 | _x_x_mozilla_page_load_details 10:28:17 INFO - PROCESS | 3529 | |i|pagename|runs| 10:28:17 INFO - PROCESS | 3529 | |0;dojo.html;2617.633531305617;2669.452762183752;2683.449892771982;2694.1648089092396;2696.6494355733753;4889.584385327243;4895.437024742156;4916.4346100198445;4928.802847886081;4993.1511643020685;4803.303520989454;4895.265710143481;4929.728864912428;4941.60467162627;4942.752862356877;4506.031203291292;4526.7283962962165;4633.073385322932;4647.814087436498;4652.488226295121;442.32674638292104;4398.098389830077;4485.259932111214;4488.281874900017;4577.702449340799;4520.638348932078;4527.886802829923;4555.658325625592;4568.200564901129;4583.931241031387;4546;4556.476005259405;4557.521460246693;4562.019165879318;4578.587927086545;4446.133004064209;4461.754603496806;4468.798904049293;4472.217361961676;4495.370648109268;4779.450363208206;4893.437254715682;4922.015596880602;4930.211166213425;4973.15456372414;5239.659422137549;5247.344081989751;5282.577393808486;5309.4955979182305;5358.946410535884;5322.866928326784;5385.192221166856;5386.272853164812;5388.030154572176;5450.073487507133;4966.553010229097;4980.128477516492;4986.077575648516;4995.425526064513;4998.800047998112;5326.360836699543;5364.7049412282695;5393.1370980642905;5393.568514518829;5414.7834086636885;5139.049275883974;5153.819616313411;5173.0688476074665;5210.374755029345;5210.6613070150315;5273.736313184326;5275.525202731696;5284.339457567804;5308.628396012242;5336.973315133399;5086.287919691246;5158.535731784157;5183.714895680774;5229;5230.712310822942;5196.194589838581;5218.373795144531;5220.347456567929;5220.843374698765;5233.685978841282;4431.290993441034;4431.8448854289945;4433.756143412079;4443.133588950188;4459.0413061192;3793.6585707285926;3840.519935008124;3890.5720370759195;3890.8832735017995;3913.5108111486065;4502.234620114588;4541.364209010741;4543.659225558096;4545.749983750926;4625.4911959684405;5284.101702710548;5301.0723123453245;5301.734913254399;5308.177232528964;5371.892562148735;4474.6867719259335;4513.977430112828;4549.727016378962;4553.954460455353;4561.589456948891;4702.553257440538;4707.835225767081;4714.127886341038;4749.833755818529;4761.833335833298;4871.5128487151005;4923.87690307738;4926.827561035347;4930.901381972412;4977.104121258063;5173.534381905646;5249;5258.368995720538;5291.1798671206025;5322.574194064543;4965.726885021359;4966.453690094015;4987.0524600325825;4987.825426110068;5035.5719763819025;5216.504432078947;5220.243064755665;5222.2688823565495;5229.581633469389;5231.267622532772;5107.336046313955;5233.816816411408;5278.155495120763;5286.471352864683;5287.704512394488;5155.5360017597095;5159;5162.225666150108;5171.198464238049;5230.424653288059;5013.298138260573;5168.173092305213;5171.586273098218;5172.870678233075;5174.27560141588;5042.873928151679;5053.29253904461;5062.493750624908;5070.163423035158;5073.289739436408;5196.792128314825;5210.869728256672;5214.869628259172;5230.738463076755;5282.8943421132135;4946.62900282473;4974;5101.4133374660905;5111.795528178831;5126.718030508208 10:28:17 INFO - PROCESS | 3529 | |1;ext.html;542.5797973803568;574.9453801888819;575.6085861614101;594.0999385930315;609.2688773471834;34968.3006339873;38065.809670951676;38124.23751524971;38152.427713584315;38206.23587528248;38343;38950.220995580145;39025.21949561007;39207;39355.212895742065;7761.767146985585;7912.327452166573;7939.206079392073;7953.681852725913;7956.045274567031;7781.922180778176;7877.094134174557;7877.724279650213;7881.881771773428;7894.684212631517;7882.408819338544;7918.287354138127;7928.801779955518;7936.285734283913;7941.20587941207;7807.414443916729;7831.177726338738;7865.252800983897;7876.842463150705;7891.644875980594;7841.764747057598;7859.764207073797;7892.7237546686165;7909.564973926432;7914.406419518559;36732.26535469302;36923.63076369229;37027.4445883312;37082.443763343574;37210.25579488422;2545.8727063646743;2863.3271181272385;2982.8061176023707;3035.514317709156;3067.8619462124257;27469.97578087954;27685.584716229274;27887.581686274723;28091.719082809115;28184;3375.9493607595905;3394.1853955050856;3432.8970130896114;3478.095695119262;3517.716033647726;256999;258527;258817;259109;259287.9999999981;31050.378992420025;54454.18318725222;54640;54983.45016549783;55290;31687.841560792047;33004.1748956278;33069.33861322808;33250.833745831114;33271.66728332734;13206.669833254246;13237;13305.46778128864;13327.533536326182;13364.064515483822;11058.502367393487;11177.385243811506;11200.327980321206;11212.383318917375;11265.380404077854;7710.884336734954;7813.453058285979;7846.489978151402;7868.960655196802;7925.603719813987;3073.3238687488715;3096.969030309713;3154.085315258595;3167.55654208411;3171.5559821624993;854.747849384433;902.8239493298875;905.4024343932973;961.4952150121103;963.4989805301344;28314.150575482767;28686.569701454497;28688.42623147567;29014.854925725238;29083.41833163325;962.6341990043738;969.8351280282369;1011.22135955314;1034.4103860799273;1051.8685164354456;14624.341904614317;14918.40326386954;15247.771283430757;15248.542543723706;15462;384243;386200;387342;389952;390614;48932.75533622309;49579;49646.75176624094;49652.25521617178;49885.50114498881;1164.2199726183478;1196.4855112301793;1201.387292480841;1206.288289908958;1223.5472875036294;26651;27510.17469475919;27765;27966.44067118687;28064.01775937914;42033.57966420297;42224.1555168901;42231.7888410556;42496.36255456232;42603.7869810649;261029;264003;264347;264822;265665;24823.627645585693;24981.125660601792;25173.370665733502;25192.622110668723;25403.87298063498;41449.79275103605;42032.79672032772;42115.368269476596;42215.57784422117;42575.574244257165;35610.93167204988;36301;36672.449913251854;37018.629813702595;37111;35597.46603800893;36493;36574.268514630094;36627.633723662424;36888.6311136896;35287.64712352947;36141.63858361383;36647.26705465929;36676.63323366732;36700.63299366972;31029.224269393446;32299.35401292008;32808.50787238241;32833.34333313368;32884.177895552806;25352.873235633702;25769.484610308064;25785;25882.87058564695;25911.870440647675 10:28:17 INFO - PROCESS | 3529 | |2;jquery.html;356.54006331831937;357.7799653213273;370.50537532394253;375.09976057462086;388.15963439154234;15859.286332115054;16803.327866885324;17723.113844307798;17836.46490605284;17879.821201787978;16299;16740.16299185042;17482.650346993054;17537.123143842822;17564.29742810289;5076.720780357079;5227.21591761237;5268.104422248227;5280.287161233223;5330.280412144369;3748.456473811296;5114.846554603368;5687.2606561146995;6025.246844144482;6026.8493287667725;6026.397360263961;6038.698065096728;6057.182280392135;6066.029435290355;6091.908621370683;5898.705064746746;5965.970170149165;5990.460858522711;6117.296510901237;6127.571070025122;5315.468453154692;5324.9733751331;5341.706206158659;5360.249565060894;5398.838034858961;17452.127393630268;18551.62896742071;20151.193952241894;20858.791412085837;20946.685799712865;1774.086345532052;1825.8174182581636;1891.063923357933;1949.5710943592528;2438.512297540481;9146.77133071672;9208.953955230249;9234.81530369389;9380.577873995686;9388.953055234748;1739.6868563658536;1763.6560870630233;1778.3064604804138;1785.8839175453554;1819.8089200633876;59733.40266597322;63345.36654633441;63382.68308658427;71235.64382178108;71591.64204178998;8396.496210227284;8967.327450441113;9159.313051521163;9402.247820174369;9500.19248363883;11925.045996320274;11956.701082473008;11986.880131198577;12004.819927701092;12067.818982715266;6749.460043196533;6812.591244525245;6882.414994725505;6993.545419547713;7026.92973070273;6956.234814170437;6975.058367120374;7007.509474336849;7088.326608972139;7172.497925145294;3703.8703645372284;3759.4172903200047;3805.904852378713;3826.5408151022057;3890;1658.8755843311799;1701.123921180593;1813.528482594535;1875.1468082022648;1886.1323791056268;844.4848642328175;848.5502683577714;855.9101294364002;862.7023676831483;924.8520236762085;16867.32530698783;16957;16974.405895793836;17373.65252694939;17468.301267949395;882.4837470079947;907.8048219632678;928.8049509602924;930.6417029443713;950.3300173377752;9602.279829012712;9673.613055477703;9704.805903882025;9853.310268281295;9934.354266972623;347652;391043;391393;393268;395923;74384.62807685927;78842;78925.60537197278;78994.6050269745;79299.60350198211;923.5197697197555;951.9952400238093;963.5278713430508;969.6315400147898;973.7711637765119;16009.119498427699;16023.67952640964;16062.759058614363;16323;16352.918235409223;35317.82341088381;35583.46624800682;36869.44695829511;37314.25371492609;38085.42871856869;50141;50726.74636626793;51653.48346516637;52416;52915;7733.613319334123;7783.221677832172;7784.299413052852;7804.102528209329;7889.408294377829;6098.786542470993;8746.781330466789;9391;12264.632061038183;12421.689457763629;9582.377145485521;10331.690049298533;10362.844557331797;10591.576336946437;10930.344179349264;10792.838107428552;10871.891281087088;10901.454927253764;10981.945090274497;11110.333379997226;10874.78250434971;10880.510377032893;10954.507047182737;10982.231243812856;11175.664730058112;7573.9242607573215;7639.503432276884;7810.648520816463;7989.440739148204;8049.718259860877;8876.28989680811;10217.74455638615;10253;10698.465076745975;10778.245522813328 10:28:17 INFO - PROCESS | 3529 | |3;mootools.html;1377.2218696436512;1409.1897159133498;1492.373203254633;1643.8602718768905;1666.4584010196688;6683.398494135527;7514.849703005943;7574.545527268354;8078.353731701472;8082.191780821922;7620.733274335399;7732.884006739903;7776.144624091346;7910.683572657102;7929.286364227219;2165.5127596290868;2194.615942210115;2204.492966617679;2206.8234541236743;2213.656883183109;2093.727815383998;2112.4402033461147;2157.967630485544;2160.567886422714;2165.5993641176356;2131.1688441507827;2140.2081229944865;2158.881261530615;2160.2655097266925;2179.24815938501;2080.4070839810656;2085.4160834966233;2127.2022991378235;2128.138104067855;2133.5839511295303;2093.612681653899;2119.8198153156845;2131.968020479694;2132.701421800949;2135.4661334666334;7945.12603613602;7947.72182973599;8004.599770011476;8011.479253848481;8014.559199244098;4601.815927362902;4698.694584851974;4699.060187962387;4734.526547345273;4752.334673145762;2741.383188782528;2796.2450138462705;2887.2348827560713;2939.030120060375;2952.409518096389;868.0451503346269;903.9096090390974;911.0525053943891;943.6649989253854;947.2280091725222;10789.622363217328;10804.891951080468;10831.945840270828;10845.83731244032;10890.128789696806;4167.97916010418;4210.726302790309;4235.767032813224;4286.89282767927;4294.141171765659;9182.908170918205;9187.26501879848;9191.494467804336;9228.35401521887;9248.26013918885;4697.0840686065885;4697.31888876111;4716.622670186377;4718.976405118021;4719.480857105716;3718.2935242303874;4123.36087906375;4209.431726716915;4297.333913243452;4305.698601097955;3638.1086633774894;3670.476752147882;3770.962290377116;3773.716971227169;3865.980670096688;1182.6274723462082;1199.7060720123625;1202.1404695642482;1206.3847437806783;1214.7934851075338;664.3588936676131;794.4399198564997;795.9044914610283;810.9148539403395;840.2102024097329;5042.899142017139;5178.870528236749;5267.104592219332;5298.549623281987;5361.544268737123;410.4991909870013;433.1099590341878;433.4543434704088;433.71158179810703;433.92406328892315;3674.4488326750666;3712.3132220539287;3746.9625303746616;3749.1002159482073;3778.4521244419407;9181.35730498872;9259.444433334022;9425.575849086808;9446.244300455946;9514.096160864707;9250;9288.071192880792;9292;9314.44113353201;9347.859782103274;7096.574205547684;7124.358807707331;7163.67763450646;7322.0115284435915;7327.303906128909;5141.357330333708;5168.638195326291;5248.343957005374;5354.919676204938;5456.972715136399;9055.411398259092;9135.77160570991;9136.269098471974;9137.5888085035;9193.632254710004;8571.571421428778;9020.14308640678;9026.413283136575;9204.309676774135;9326.06739326062;6025.427584379477;6445.387688169616;6588.670566471753;6827.692753825991;6878.071460352989;7603.657835397531;7679.078510578766;7683.538987660758;7703.614819258903;7726.4205184610255;6586.176727909012;6716.1604799400075;6735.898961515679;6829.4877884157895;6846.554973926679;6464.644444555594;6531.379518945692;6535;6552.3447655234095;6600.570962887397;6098.481629061579;6108.114323423168;6145.4161854623735;6169.413905678954;6217.160683307696;4364.8472303469225;4480.9103817924115;4629.1436084324505;4684.695494792828;4719.268513380432;4754.072955773591;4762.476127626028;4798.064377446504;4822.107910036654;4896.4124305083615 10:28:17 INFO - PROCESS | 3529 | |4;prototype.html;299.1086562045104;307.06804847288475;313.03272886779854;313.9795913265639;314.6916022298149;4955.727434991074;4997.200447928332;5098.158803797373;5203.8959220815605;5228.13735733604;5036.571891389236;5087.720175390352;5091.643584949045;5106.795728170878;5120.3343565336545;3972.7417717848393;3988.3419235826054;3997.1805779815213;3998.4002399639994;4019.3970904364432;3920.3338581102917;3991.1618560102415;4006.879793606182;4014.237294913957;4056.9594304056877;3951.5258169019758;3965.6827453803626;3973.9801300993454;3979.8408063677416;3983.1436241208135;3995.6403923646867;4000.9199816003807;4017.055991841944;4022.2960981828064;4040.828159833645;3553.8045407502577;3572.7141828653644;3579.1588976590742;3589.8743543975834;3596.1009747563107;4832.251001094801;4979.377577802775;4981.875453113665;4982.87542811429;5120.743962801882;4580.90058385985;4583.243764778807;4595.379623750784;4597.931031034537;4599.954000459986;5385.515303622693;5385.838424847222;5408.432114627947;5438.7280635968045;5439.211314359435;3790.924181516354;3871.477350557667;3872.961270387288;3875.9031024224337;3914.64768170866;5671.376148623648;5687.857803554903;5705.6006079574445;5706.400827913092;5723.54211663066;3971.960280397217;3984.7011474139554;3991.2217117661776;4013.7993100344866;4014.578469260744;3943.6253555912144;4028.4561584186345;4040.2525532775944;4042.0501182222156;4051.108756073659;4497.302918047708;4504.256797628354;4510.2783554631105;4510.323451482238;4579.427571553556;5346.144616861284;5350.117230656976;5354.40311448947;5416.133418653076;5477.1510415885605;1296.7795474769312;1363.638635761524;1393.8606139386184;1399.139529189541;1405.156905856478;869.517417833096;880.1638443478721;907.8865141857268;913.0504275553483;920.3649481857497;4227.991703940604;4245.639120674716;4266.253405653998;4279.8872293203995;4302.870913872589;4846.704241116075;4848.903021939542;4890.902181956341;4932.334134891744;4952.603791696655;4245;4245.511766146871;4256.61690447855;4269.573042695768;4287.378330142112;2440.877956102188;2594.4421949280995;2609.673790776153;2617.227917764226;2622.9213123606323;4518.231900576844;4539.251023581138;4560.977195114069;4582.977085114553;4609.870581707503;4868.2210846264425;4915.287283343895;4928.728919909439;4933.481984391659;4971.950280497221;4775.498572649891;5199.66202196856;5208.192730126836;5219.869503262373;5231.985685511182;5517.393086760533;5533.446655334435;5534.6440122170325;5546.944530554804;5549.472800083986;5236.371635403776;5423.674579525241;5423.891522169613;5425.647332923348;5474.534664553557;5211.687298762086;5215.478452154754;5216.5393689766925;5217.426083130928;5225.477452254744;3862.343401621787;3874.457575939427;3881.4177873319227;3888.8833334999995;3889.319369110451;5316.362036555638;5532.944670553243;5543.473370029841;5568.832935011957;5570.275864137636;5245.423003469539;5333.7333133343955;5359.115745901882;5365.022412561066;5380.166074258496;5374.811881584125;5392.948375066824;5393.7033463159905;5408.350997880122;5411.621186516906;5043.234867796388;5286.762095705625;5292.841214763564;5297.093046503179;5309.203619457112;5411.242426060276;5415.566754659697;5419.810306639249;5429.049916264717;5443.918341224806;5252.579793616578;5262.316058861128;5289.894202116013;5297.258383826191;5297.496737809902 10:28:17 INFO - PROCESS | 3529 | |5;yui.html;647.0326861342292;662.7978466567695;666.5101150654269;684.780870121561;728.566502930756;12872.3563821809;13361.198328100309;13367.933160334185;13375.26436046017;13387.062905596587;12387.690307742288;12528.872401483864;12632.873671263285;12676.556320528784;12734.68163295918;638.8402899275181;776.5806464509159;803.9839203215947;808.0586117173515;810.2262339465796;801.3989507869098;810.5339429827843;811.4928169893816;812.760235730458;814.5682788122305;842.7682387343468;846.7417437681505;850.0819115355432;850.4854562989395;852.1861622150863;828.8093738440162;834.4034015678789;836.4061516323418;837.3552364679163;838.7064527415416;615.9599626024294;616.22355831652;616.771794436057;618.4650277509967;618.4742968476804;13749;13751.587452376445;13792;13798.517051903134;13809.585712428643;13431.865681343159;13510.662233444242;13535.864641353559;13922.37349319273;14058.437662493488;10415.895841041569;10427.791444171075;10573.788524229472;10576.206784491194;10647.57409703611;3384.424647809878;3420.2304481491715;3445.207602251496;3450.1202193440763;3450.2064525159353;57233.427665723226;57568.42431575715;57915.42084579142;59688;59812.401875981115;10441;10470.110040646478;10485.895141048644;10562.471876406149;10965.83551246732;19855.30506432297;20095.296664616668;20151.899240503702;20217.89891050535;20332;6914.965425172842;7027.543209691354;7055.506114571931;7067.399271062018;7149.0706208192605;3632.564092308887;3816.6183381662167;3819.8281077351585;3829.4064420014943;3842.2315536892734;2843.38867143561;2965.3328001199557;2970.6435227772804;2972.4798160321857;2977.910662680123;464.8814552289145;487.6513292995525;490.0908814149701;508.9923651145236;541.4558368839291;574.2247965246884;585.2976428286074;589.7139887154813;601.7833579911229;625.9155014073042;7511.06111736033;7740.187280335596;7772.572508511973;8015.318697910627;8265.793355166168;559.35953333433;590.0087852407996;592.5259792166336;608.5223099866583;618.8607563298222;3704.1665625234646;3822.7897465639658;3947.210557888434;4020.4773379460485;4072;88017;101159;103365;103538;106073.46963265134;53324.46675533272;67605.66197168983;87562.56218718993;87810.56094719486;88442.55778721193;48309.75845120752;48330.16698330139;49145.26282105771;68556.6572167136;78900.99999999885;7347.537109150989;7488.363489103487;7542.434317426325;7626;7737.767866963775;46057.539424605326;46158.30762538632;46627.53372466368;46928.29607555821;47053;52467;53903.730481347346;54584.454155457934;61405.38594613997;61860.38139618546;10692.786144276915;10913.732053376847;11470.139739519402;11548.364839933884;11586.304821710724;12982.870171298544;13110.082294239694;13126.671833204246;13350.933245333712;13778.838188681555;10771.299865508718;11413.885861141282;11655.41722913834;12206.389680516117;12908.483660653468;11316.321020738782;11695.649130526097;12157;12307.384630768605;12419.689507762378;11028.172887033345;11478.139139564399;11478.426078696199;11638.825417618911;11931.105167112328;10369;10531.526081326205;10741.46292685347;10911.781764364827;10960.232783705384;10578.15374770032;10940.398278094463;11006.889931100586;11022.724431889266;11193 10:28:17 INFO - PROCESS | 3529 | __end_tp_report 10:28:17 INFO - PROCESS | 3529 | __start_cc_report 10:28:17 INFO - PROCESS | 3529 | _x_x_mozilla_cycle_collect,395 10:28:17 INFO - PROCESS | 3529 | __end_cc_report 10:28:17 INFO - PROCESS | 3529 | __startTimestamp1466875697327__endTimestamp 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | ------- Summary: start ------- 10:28:17 INFO - PROCESS | 3529 | Number of tests: 6 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#0] dojo.html Cycles:165 Average:4844.79 Median:4987.83 stddev:628.70 (12.6%) stddev-sans-first:605.87 10:28:17 INFO - PROCESS | 3529 | Values: 2617.6 2669.5 2683.4 2694.2 2696.6 4889.6 4895.4 4916.4 4928.8 4993.2 4803.3 4895.3 4929.7 4941.6 4942.8 4506.0 4526.7 4633.1 4647.8 4652.5 442.3 4398.1 4485.3 4488.3 4577.7 4520.6 4527.9 4555.7 4568.2 4583.9 4546.0 4556.5 4557.5 4562.0 4578.6 4446.1 4461.8 4468.8 4472.2 4495.4 4779.5 4893.4 4922.0 4930.2 4973.2 5239.7 5247.3 5282.6 5309.5 5358.9 5322.9 5385.2 5386.3 5388.0 5450.1 4966.6 4980.1 4986.1 4995.4 4998.8 5326.4 5364.7 5393.1 5393.6 5414.8 5139.0 5153.8 5173.1 5210.4 5210.7 5273.7 5275.5 5284.3 5308.6 5337.0 5086.3 5158.5 5183.7 5229.0 5230.7 5196.2 5218.4 5220.3 5220.8 5233.7 4431.3 4431.8 4433.8 4443.1 4459.0 3793.7 3840.5 3890.6 3890.9 3913.5 4502.2 4541.4 4543.7 4545.7 4625.5 5284.1 5301.1 5301.7 5308.2 5371.9 4474.7 4514.0 4549.7 4554.0 4561.6 4702.6 4707.8 4714.1 4749.8 4761.8 4871.5 4923.9 4926.8 4930.9 4977.1 5173.5 5249.0 5258.4 5291.2 5322.6 4965.7 4966.5 4987.1 4987.8 5035.6 5216.5 5220.2 5222.3 5229.6 5231.3 5107.3 5233.8 5278.2 5286.5 5287.7 5155.5 5159.0 5162.2 5171.2 5230.4 5013.3 5168.2 5171.6 5172.9 5174.3 5042.9 5053.3 5062.5 5070.2 5073.3 5196.8 5210.9 5214.9 5230.7 5282.9 4946.6 4974.0 5101.4 5111.8 5126.7 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#1] ext.html Cycles:180 Average:44923.72 Median:36533.63 stddev:81499.02 (223.1%) stddev-sans-first:81659.53 10:28:17 INFO - PROCESS | 3529 | Values: 542.6 574.9 575.6 594.1 609.3 34968.3 38065.8 38124.2 38152.4 38206.2 38343.0 38950.2 39025.2 39207.0 39355.2 7761.8 7912.3 7939.2 7953.7 7956.0 7781.9 7877.1 7877.7 7881.9 7894.7 7882.4 7918.3 7928.8 7936.3 7941.2 7807.4 7831.2 7865.3 7876.8 7891.6 7841.8 7859.8 7892.7 7909.6 7914.4 36732.3 36923.6 37027.4 37082.4 37210.3 2545.9 2863.3 2982.8 3035.5 3067.9 27470.0 27685.6 27887.6 28091.7 28184.0 3375.9 3394.2 3432.9 3478.1 3517.7 256999.0 258527.0 258817.0 259109.0 259288.0 31050.4 54454.2 54640.0 54983.5 55290.0 31687.8 33004.2 33069.3 33250.8 33271.7 13206.7 13237.0 13305.5 13327.5 13364.1 11058.5 11177.4 11200.3 11212.4 11265.4 7710.9 7813.5 7846.5 7869.0 7925.6 3073.3 3097.0 3154.1 3167.6 3171.6 854.7 902.8 905.4 961.5 963.5 28314.2 28686.6 28688.4 29014.9 29083.4 962.6 969.8 1011.2 1034.4 1051.9 14624.3 14918.4 15247.8 15248.5 15462.0 384243.0 386200.0 387342.0 389952.0 390614.0 48932.8 49579.0 49646.8 49652.3 49885.5 1164.2 1196.5 1201.4 1206.3 1223.5 26651.0 27510.2 27765.0 27966.4 28064.0 42033.6 42224.2 42231.8 42496.4 42603.8 261029.0 264003.0 264347.0 264822.0 265665.0 24823.6 24981.1 25173.4 25192.6 25403.9 41449.8 42032.8 42115.4 42215.6 42575.6 35610.9 36301.0 36672.4 37018.6 37111.0 35597.5 36493.0 36574.3 36627.6 36888.6 35287.6 36141.6 36647.3 36676.6 36700.6 31029.2 32299.4 32808.5 32833.3 32884.2 25352.9 25769.5 25785.0 25882.9 25911.9 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#2] jquery.html Cycles:180 Average:24042.14 Median:28440.35 stddev:63471.96 (223.2%) stddev-sans-first:63625.10 10:28:17 INFO - PROCESS | 3529 | Values: 356.5 357.8 370.5 375.1 388.2 15859.3 16803.3 17723.1 17836.5 17879.8 16299.0 16740.2 17482.7 17537.1 17564.3 5076.7 5227.2 5268.1 5280.3 5330.3 3748.5 5114.8 5687.3 6025.2 6026.8 6026.4 6038.7 6057.2 6066.0 6091.9 5898.7 5966.0 5990.5 6117.3 6127.6 5315.5 5325.0 5341.7 5360.2 5398.8 17452.1 18551.6 20151.2 20858.8 20946.7 1774.1 1825.8 1891.1 1949.6 2438.5 9146.8 9209.0 9234.8 9380.6 9389.0 1739.7 1763.7 1778.3 1785.9 1819.8 59733.4 63345.4 63382.7 71235.6 71591.6 8396.5 8967.3 9159.3 9402.2 9500.2 11925.0 11956.7 11986.9 12004.8 12067.8 6749.5 6812.6 6882.4 6993.5 7026.9 6956.2 6975.1 7007.5 7088.3 7172.5 3703.9 3759.4 3805.9 3826.5 3890.0 1658.9 1701.1 1813.5 1875.1 1886.1 844.5 848.6 855.9 862.7 924.9 16867.3 16957.0 16974.4 17373.7 17468.3 882.5 907.8 928.8 930.6 950.3 9602.3 9673.6 9704.8 9853.3 9934.4 347652.0 391043.0 391393.0 393268.0 395923.0 74384.6 78842.0 78925.6 78994.6 79299.6 923.5 952.0 963.5 969.6 973.8 16009.1 16023.7 16062.8 16323.0 16352.9 35317.8 35583.5 36869.4 37314.3 38085.4 50141.0 50726.7 51653.5 52416.0 52915.0 7733.6 7783.2 7784.3 7804.1 7889.4 6098.8 8746.8 9391.0 12264.6 12421.7 9582.4 10331.7 10362.8 10591.6 10930.3 10792.8 10871.9 10901.5 10981.9 11110.3 10874.8 10880.5 10954.5 10982.2 11175.7 7573.9 7639.5 7810.6 7989.4 8049.7 8876.3 10217.7 10253.0 10698.5 10778.2 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#3] mootools.html Cycles:180 Average:5129.62 Median:5092.13 stddev:2892.27 (56.8%) stddev-sans-first:2886.64 10:28:17 INFO - PROCESS | 3529 | Values: 1377.2 1409.2 1492.4 1643.9 1666.5 6683.4 7514.8 7574.5 8078.4 8082.2 7620.7 7732.9 7776.1 7910.7 7929.3 2165.5 2194.6 2204.5 2206.8 2213.7 2093.7 2112.4 2158.0 2160.6 2165.6 2131.2 2140.2 2158.9 2160.3 2179.2 2080.4 2085.4 2127.2 2128.1 2133.6 2093.6 2119.8 2132.0 2132.7 2135.5 7945.1 7947.7 8004.6 8011.5 8014.6 4601.8 4698.7 4699.1 4734.5 4752.3 2741.4 2796.2 2887.2 2939.0 2952.4 868.0 903.9 911.1 943.7 947.2 10789.6 10804.9 10831.9 10845.8 10890.1 4168.0 4210.7 4235.8 4286.9 4294.1 9182.9 9187.3 9191.5 9228.4 9248.3 4697.1 4697.3 4716.6 4719.0 4719.5 3718.3 4123.4 4209.4 4297.3 4305.7 3638.1 3670.5 3771.0 3773.7 3866.0 1182.6 1199.7 1202.1 1206.4 1214.8 664.4 794.4 795.9 810.9 840.2 5042.9 5178.9 5267.1 5298.5 5361.5 410.5 433.1 433.5 433.7 433.9 3674.4 3712.3 3747.0 3749.1 3778.5 9181.4 9259.4 9425.6 9446.2 9514.1 9250.0 9288.1 9292.0 9314.4 9347.9 7096.6 7124.4 7163.7 7322.0 7327.3 5141.4 5168.6 5248.3 5354.9 5457.0 9055.4 9135.8 9136.3 9137.6 9193.6 8571.6 9020.1 9026.4 9204.3 9326.1 6025.4 6445.4 6588.7 6827.7 6878.1 7603.7 7679.1 7683.5 7703.6 7726.4 6586.2 6716.2 6735.9 6829.5 6846.6 6464.6 6531.4 6535.0 6552.3 6600.6 6098.5 6108.1 6145.4 6169.4 6217.2 4364.8 4480.9 4629.1 4684.7 4719.3 4754.1 4762.5 4798.1 4822.1 4896.4 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#4] prototype.html Cycles:180 Average:4378.41 Median:4903.09 stddev:1278.35 (26.1%) stddev-sans-first:1244.72 10:28:17 INFO - PROCESS | 3529 | Values: 299.1 307.1 313.0 314.0 314.7 4955.7 4997.2 5098.2 5203.9 5228.1 5036.6 5087.7 5091.6 5106.8 5120.3 3972.7 3988.3 3997.2 3998.4 4019.4 3920.3 3991.2 4006.9 4014.2 4057.0 3951.5 3965.7 3974.0 3979.8 3983.1 3995.6 4000.9 4017.1 4022.3 4040.8 3553.8 3572.7 3579.2 3589.9 3596.1 4832.3 4979.4 4981.9 4982.9 5120.7 4580.9 4583.2 4595.4 4597.9 4600.0 5385.5 5385.8 5408.4 5438.7 5439.2 3790.9 3871.5 3873.0 3875.9 3914.6 5671.4 5687.9 5705.6 5706.4 5723.5 3972.0 3984.7 3991.2 4013.8 4014.6 3943.6 4028.5 4040.3 4042.1 4051.1 4497.3 4504.3 4510.3 4510.3 4579.4 5346.1 5350.1 5354.4 5416.1 5477.2 1296.8 1363.6 1393.9 1399.1 1405.2 869.5 880.2 907.9 913.1 920.4 4228.0 4245.6 4266.3 4279.9 4302.9 4846.7 4848.9 4890.9 4932.3 4952.6 4245.0 4245.5 4256.6 4269.6 4287.4 2440.9 2594.4 2609.7 2617.2 2622.9 4518.2 4539.3 4561.0 4583.0 4609.9 4868.2 4915.3 4928.7 4933.5 4972.0 4775.5 5199.7 5208.2 5219.9 5232.0 5517.4 5533.4 5534.6 5546.9 5549.5 5236.4 5423.7 5423.9 5425.6 5474.5 5211.7 5215.5 5216.5 5217.4 5225.5 3862.3 3874.5 3881.4 3888.9 3889.3 5316.4 5532.9 5543.5 5568.8 5570.3 5245.4 5333.7 5359.1 5365.0 5380.2 5374.8 5392.9 5393.7 5408.4 5411.6 5043.2 5286.8 5292.8 5297.1 5309.2 5411.2 5415.6 5419.8 5429.0 5443.9 5252.6 5262.3 5289.9 5297.3 5297.5 10:28:17 INFO - PROCESS | 3529 | 10:28:17 INFO - PROCESS | 3529 | [#5] yui.html Cycles:180 Average:17130.00 Median:3894.72 stddev:24009.52 (616.5%) stddev-sans-first:24044.97 10:28:17 INFO - PROCESS | 3529 | Values: 647.0 662.8 666.5 684.8 728.6 12872.4 13361.2 13367.9 13375.3 13387.1 12387.7 12528.9 12632.9 12676.6 12734.7 638.8 776.6 804.0 808.1 810.2 801.4 810.5 811.5 812.8 814.6 842.8 846.7 850.1 850.5 852.2 828.8 834.4 836.4 837.4 838.7 616.0 616.2 616.8 618.5 618.5 13749.0 13751.6 13792.0 13798.5 13809.6 13431.9 13510.7 13535.9 13922.4 14058.4 10415.9 10427.8 10573.8 10576.2 10647.6 3384.4 3420.2 3445.2 3450.1 3450.2 57233.4 57568.4 57915.4 59688.0 59812.4 10441.0 10470.1 10485.9 10562.5 10965.8 19855.3 20095.3 20151.9 20217.9 20332.0 6915.0 7027.5 7055.5 7067.4 7149.1 3632.6 3816.6 3819.8 3829.4 3842.2 2843.4 2965.3 2970.6 2972.5 2977.9 464.9 487.7 490.1 509.0 541.5 574.2 585.3 589.7 601.8 625.9 7511.1 7740.2 7772.6 8015.3 8265.8 559.4 590.0 592.5 608.5 618.9 3704.2 3822.8 3947.2 4020.5 4072.0 88017.0 101159.0 103365.0 103538.0 106073.5 53324.5 67605.7 87562.6 87810.6 88442.6 48309.8 48330.2 49145.3 68556.7 78901.0 7347.5 7488.4 7542.4 7626.0 7737.8 46057.5 46158.3 46627.5 46928.3 47053.0 52467.0 53903.7 54584.5 61405.4 61860.4 10692.8 10913.7 11470.1 11548.4 11586.3 12982.9 13110.1 13126.7 13350.9 13778.8 10771.3 11413.9 11655.4 12206.4 12908.5 11316.3 11695.6 12157.0 12307.4 12419.7 11028.2 11478.1 11478.4 11638.8 11931.1 10369.0 10531.5 10741.5 10911.8 10960.2 10578.2 10940.4 11006.9 11022.7 11193.0 10:28:17 INFO - PROCESS | 3529 | -------- Summary: end -------- 10:28:17 INFO - PROCESS | 3529 | 10:28:18 INFO - TEST-INFO | 3529: exit 0 10:28:18 INFO - TEST-OK | dromaeo_css | took 1118366ms 10:28:18 INFO - TEST-START | kraken 10:28:18 INFO - operating with platform_type : linux_ 10:28:18 INFO - Initialising browser for kraken test... 10:28:18 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1WDSu9/profile http://localhost:45729/getInfo.html) 10:28:23 INFO - PROCESS | 3761 | __metrics Screen width/height:1600/1200 10:28:23 INFO - PROCESS | 3761 | colorDepth:24 10:28:23 INFO - PROCESS | 3761 | Browser inner width/height: 1024/697 10:28:23 INFO - PROCESS | 3761 | __metrics 10:28:23 ERROR - PROCESS | 3761 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:28:24 INFO - TEST-INFO | 3761: exit 0 10:28:24 INFO - Browser initialized. 10:28:24 INFO - Running cycle 1/1 for kraken test... 10:28:24 INFO - TEST-INFO | started process 3880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1WDSu9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:36 INFO - PROCESS | 3880 | RSS: Main: 186982400 10:28:36 INFO - PROCESS | 3880 | 10:28:39 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45729/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:40 INFO - PROCESS | 3880 | RSS: Main: 190914560 10:28:40 INFO - PROCESS | 3880 | 10:28:43 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45729/tests/kraken/driver.html?testName=audio-dft) 10:28:43 INFO - PROCESS | 3880 | RSS: Main: 190558208 10:28:43 INFO - PROCESS | 3880 | 10:28:46 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45729/tests/kraken/driver.html?testName=audio-fft) 10:28:47 INFO - PROCESS | 3880 | RSS: Main: 186404864 10:28:47 INFO - PROCESS | 3880 | 10:28:49 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45729/tests/kraken/driver.html?testName=audio-oscillator) 10:28:50 INFO - PROCESS | 3880 | RSS: Main: 186720256 10:28:50 INFO - PROCESS | 3880 | 10:28:52 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:53 INFO - PROCESS | 3880 | RSS: Main: 186773504 10:28:53 INFO - PROCESS | 3880 | 10:28:56 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45729/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:56 INFO - PROCESS | 3880 | RSS: Main: 188391424 10:28:56 INFO - PROCESS | 3880 | 10:29:00 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45729/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:01 INFO - PROCESS | 3880 | RSS: Main: 184901632 10:29:01 INFO - PROCESS | 3880 | 10:29:04 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45729/tests/kraken/driver.html?testName=json-parse-financial) 10:29:04 INFO - PROCESS | 3880 | RSS: Main: 186437632 10:29:04 INFO - PROCESS | 3880 | 10:29:06 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:07 INFO - PROCESS | 3880 | RSS: Main: 186773504 10:29:07 INFO - PROCESS | 3880 | 10:29:08 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:09 INFO - PROCESS | 3880 | RSS: Main: 187301888 10:29:09 INFO - PROCESS | 3880 | 10:29:11 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:12 INFO - PROCESS | 3880 | RSS: Main: 187269120 10:29:12 INFO - PROCESS | 3880 | 10:29:15 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:15 INFO - PROCESS | 3880 | RSS: Main: 187199488 10:29:15 INFO - PROCESS | 3880 | 10:29:18 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:19 INFO - PROCESS | 3880 | RSS: Main: 187076608 10:29:19 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | Cycle 1(1): loaded http://localhost:45729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45729/tests/kraken/driver.html?testName=ai-astar) 10:29:21 INFO - PROCESS | 3880 | RSS: Main: 188239872 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | __start_tp_report 10:29:21 INFO - PROCESS | 3880 | _x_x_mozilla_page_load 10:29:21 INFO - PROCESS | 3880 | _x_x_mozilla_page_load_details 10:29:21 INFO - PROCESS | 3880 | |i|pagename|runs| 10:29:21 INFO - PROCESS | 3880 | |0;ai-astar;104;114;109;114;112;114;114;113;113;113 10:29:21 INFO - PROCESS | 3880 | |1;audio-beat-detection;173;133;157;183;129;165;160;149;207;133 10:29:21 INFO - PROCESS | 3880 | |2;audio-dft;164;172;181;161;162;163;166;162;162;162 10:29:21 INFO - PROCESS | 3880 | |3;audio-fft;76;76;77;170;76;75;78;75;167;76 10:29:21 INFO - PROCESS | 3880 | |4;audio-oscillator;86;87;139;87;87;85;147;86;88;143 10:29:21 INFO - PROCESS | 3880 | |5;imaging-gaussian-blur;118;117;118;118;119;119;117;118;118;117 10:29:21 INFO - PROCESS | 3880 | |6;imaging-darkroom;148;149;147;147;150;152;148;149;148;148 10:29:21 INFO - PROCESS | 3880 | |7;imaging-desaturate;96;97;100;96;96;96;97;96;96;95 10:29:21 INFO - PROCESS | 3880 | |8;json-parse-financial;68;66;65;65;66;65;65;66;64;64 10:29:21 INFO - PROCESS | 3880 | |9;json-stringify-tinderbox;64;64;64;66;64;65;65;66;64;65 10:29:21 INFO - PROCESS | 3880 | |10;stanford-crypto-aes;83;81;82;82;86;87;90;83;101;90 10:29:21 INFO - PROCESS | 3880 | |11;stanford-crypto-ccm;144;138;129;135;142;132;141;144;136;132 10:29:21 INFO - PROCESS | 3880 | |12;stanford-crypto-pbkdf2;169;171;171;169;171;168;172;173;169;174 10:29:21 INFO - PROCESS | 3880 | |13;stanford-crypto-sha256-iterative;67;72;67;66;68;71;67;66;67;67 10:29:21 INFO - PROCESS | 3880 | __end_tp_report 10:29:21 INFO - PROCESS | 3880 | __start_cc_report 10:29:21 INFO - PROCESS | 3880 | _x_x_mozilla_cycle_collect,1004 10:29:21 INFO - PROCESS | 3880 | __end_cc_report 10:29:21 INFO - PROCESS | 3880 | __startTimestamp1466875761541__endTimestamp 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | ------- Summary: start ------- 10:29:21 INFO - PROCESS | 3880 | Number of tests: 14 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.50 stddev:3.20 (2.8%) stddev-sans-first:1.62 10:29:21 INFO - PROCESS | 3880 | Values: 104.0 114.0 109.0 114.0 112.0 114.0 114.0 113.0 113.0 113.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:162.50 stddev:24.65 (15.2%) stddev-sans-first:25.61 10:29:21 INFO - PROCESS | 3880 | Values: 173.0 133.0 157.0 183.0 129.0 165.0 160.0 149.0 207.0 133.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#2] audio-dft Cycles:10 Average:165.50 Median:163.50 stddev:6.33 (3.9%) stddev-sans-first:6.69 10:29:21 INFO - PROCESS | 3880 | Values: 164.0 172.0 181.0 161.0 162.0 163.0 166.0 162.0 162.0 162.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:38.96 (51.3%) stddev-sans-first:40.74 10:29:21 INFO - PROCESS | 3880 | Values: 76.0 76.0 77.0 170.0 76.0 75.0 78.0 75.0 167.0 76.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.50 stddev:27.33 (31.6%) stddev-sans-first:28.25 10:29:21 INFO - PROCESS | 3880 | Values: 86.0 87.0 139.0 87.0 87.0 85.0 147.0 86.0 88.0 143.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 10:29:21 INFO - PROCESS | 3880 | Values: 118.0 117.0 118.0 118.0 119.0 119.0 117.0 118.0 118.0 117.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.51 (1.0%) stddev-sans-first:1.58 10:29:21 INFO - PROCESS | 3880 | Values: 148.0 149.0 147.0 147.0 150.0 152.0 148.0 149.0 148.0 148.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 10:29:21 INFO - PROCESS | 3880 | Values: 96.0 97.0 100.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:0.78 10:29:21 INFO - PROCESS | 3880 | Values: 68.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 64.0 64.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 10:29:21 INFO - PROCESS | 3880 | Values: 64.0 64.0 64.0 66.0 64.0 65.0 65.0 66.0 64.0 65.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.50 stddev:6.06 (7.2%) stddev-sans-first:6.29 10:29:21 INFO - PROCESS | 3880 | Values: 83.0 81.0 82.0 82.0 86.0 87.0 90.0 83.0 101.0 90.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:139.50 stddev:5.36 (3.8%) stddev-sans-first:5.10 10:29:21 INFO - PROCESS | 3880 | Values: 144.0 138.0 129.0 135.0 142.0 132.0 141.0 144.0 136.0 132.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:1.95 (1.1%) stddev-sans-first:1.96 10:29:21 INFO - PROCESS | 3880 | Values: 169.0 171.0 171.0 169.0 171.0 168.0 172.0 173.0 169.0 174.0 10:29:21 INFO - PROCESS | 3880 | 10:29:21 INFO - PROCESS | 3880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.04 (3.1%) stddev-sans-first:2.15 10:29:21 INFO - PROCESS | 3880 | Values: 67.0 72.0 67.0 66.0 68.0 71.0 67.0 66.0 67.0 67.0 10:29:21 INFO - PROCESS | 3880 | -------- Summary: end -------- 10:29:21 INFO - PROCESS | 3880 | 10:29:22 INFO - TEST-INFO | 3880: exit 0 10:29:22 INFO - TEST-OK | kraken | took 64523ms 10:29:22 INFO - SUITE-END | took 1182s 10:29:22 INFO - Completed test suite (00:19:42) 10:29:22 INFO - javascript benchmark 10:29:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6395.292996248302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.633531305617, 2669.452762183752, 2683.449892771982, 2694.1648089092396, 2696.6494355733753, 4889.584385327243, 4895.437024742156, 4916.4346100198445, 4928.802847886081, 4993.1511643020685, 4803.303520989454, 4895.265710143481, 4929.728864912428, 4941.60467162627, 4942.752862356877, 4506.031203291292, 4526.7283962962165, 4633.073385322932, 4647.814087436498, 4652.488226295121, 442.32674638292104, 4398.098389830077, 4485.259932111214, 4488.281874900017, 4577.702449340799, 4520.638348932078, 4527.886802829923, 4555.658325625592, 4568.200564901129, 4583.931241031387, 4546.0, 4556.476005259405, 4557.521460246693, 4562.019165879318, 4578.587927086545, 4446.133004064209, 4461.754603496806, 4468.798904049293, 4472.217361961676, 4495.370648109268, 4779.450363208206, 4893.437254715682, 4922.015596880602, 4930.211166213425, 4973.15456372414, 5239.659422137549, 5247.344081989751, 5282.577393808486, 5309.4955979182305, 5358.946410535884, 5322.866928326784, 5385.192221166856, 5386.272853164812, 5388.030154572176, 5450.073487507133, 4966.553010229097, 4980.128477516492, 4986.077575648516, 4995.425526064513, 4998.800047998112, 5326.360836699543, 5364.7049412282695, 5393.1370980642905, 5393.568514518829, 5414.7834086636885, 5139.049275883974, 5153.819616313411, 5173.0688476074665, 5210.374755029345, 5210.6613070150315, 5273.736313184326, 5275.525202731696, 5284.339457567804, 5308.628396012242, 5336.973315133399, 5086.287919691246, 5158.535731784157, 5183.714895680774, 5229.0, 5230.712310822942, 5196.194589838581, 5218.373795144531, 5220.347456567929, 5220.843374698765, 5233.685978841282, 4431.290993441034, 4431.8448854289945, 4433.756143412079, 4443.133588950188, 4459.0413061192, 3793.6585707285926, 3840.519935008124, 3890.5720370759195, 3890.8832735017995, 3913.5108111486065, 4502.234620114588, 4541.364209010741, 4543.659225558096, 4545.749983750926, 4625.4911959684405, 5284.101702710548, 5301.0723123453245, 5301.734913254399, 5308.177232528964, 5371.892562148735, 4474.6867719259335, 4513.977430112828, 4549.727016378962, 4553.954460455353, 4561.589456948891, 4702.553257440538, 4707.835225767081, 4714.127886341038, 4749.833755818529, 4761.833335833298, 4871.5128487151005, 4923.87690307738, 4926.827561035347, 4930.901381972412, 4977.104121258063, 5173.534381905646, 5249.0, 5258.368995720538, 5291.1798671206025, 5322.574194064543, 4965.726885021359, 4966.453690094015, 4987.0524600325825, 4987.825426110068, 5035.5719763819025, 5216.504432078947, 5220.243064755665, 5222.2688823565495, 5229.581633469389, 5231.267622532772, 5107.336046313955, 5233.816816411408, 5278.155495120763, 5286.471352864683, 5287.704512394488, 5155.5360017597095, 5159.0, 5162.225666150108, 5171.198464238049, 5230.424653288059, 5013.298138260573, 5168.173092305213, 5171.586273098218, 5172.870678233075, 5174.27560141588, 5042.873928151679, 5053.29253904461, 5062.493750624908, 5070.163423035158, 5073.289739436408, 5196.792128314825, 5210.869728256672, 5214.869628259172, 5230.738463076755, 5282.8943421132135, 4946.62900282473, 4974.0, 5101.4133374660905, 5111.795528178831, 5126.718030508208], "value": 4805.019869359281, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.5797973803568, 574.9453801888819, 575.6085861614101, 594.0999385930315, 609.2688773471834, 34968.3006339873, 38065.809670951676, 38124.23751524971, 38152.427713584315, 38206.23587528248, 38343.0, 38950.220995580145, 39025.21949561007, 39207.0, 39355.212895742065, 7761.767146985585, 7912.327452166573, 7939.206079392073, 7953.681852725913, 7956.045274567031, 7781.922180778176, 7877.094134174557, 7877.724279650213, 7881.881771773428, 7894.684212631517, 7882.408819338544, 7918.287354138127, 7928.801779955518, 7936.285734283913, 7941.20587941207, 7807.414443916729, 7831.177726338738, 7865.252800983897, 7876.842463150705, 7891.644875980594, 7841.764747057598, 7859.764207073797, 7892.7237546686165, 7909.564973926432, 7914.406419518559, 36732.26535469302, 36923.63076369229, 37027.4445883312, 37082.443763343574, 37210.25579488422, 2545.8727063646743, 2863.3271181272385, 2982.8061176023707, 3035.514317709156, 3067.8619462124257, 27469.97578087954, 27685.584716229274, 27887.581686274723, 28091.719082809115, 28184.0, 3375.9493607595905, 3394.1853955050856, 3432.8970130896114, 3478.095695119262, 3517.716033647726, 256999.0, 258527.0, 258817.0, 259109.0, 259287.9999999981, 31050.378992420025, 54454.18318725222, 54640.0, 54983.45016549783, 55290.0, 31687.841560792047, 33004.1748956278, 33069.33861322808, 33250.833745831114, 33271.66728332734, 13206.669833254246, 13237.0, 13305.46778128864, 13327.533536326182, 13364.064515483822, 11058.502367393487, 11177.385243811506, 11200.327980321206, 11212.383318917375, 11265.380404077854, 7710.884336734954, 7813.453058285979, 7846.489978151402, 7868.960655196802, 7925.603719813987, 3073.3238687488715, 3096.969030309713, 3154.085315258595, 3167.55654208411, 3171.5559821624993, 854.747849384433, 902.8239493298875, 905.4024343932973, 961.4952150121103, 963.4989805301344, 28314.150575482767, 28686.569701454497, 28688.42623147567, 29014.854925725238, 29083.41833163325, 962.6341990043738, 969.8351280282369, 1011.22135955314, 1034.4103860799273, 1051.8685164354456, 14624.341904614317, 14918.40326386954, 15247.771283430757, 15248.542543723706, 15462.0, 384243.0, 386200.0, 387342.0, 389952.0, 390614.0, 48932.75533622309, 49579.0, 49646.75176624094, 49652.25521617178, 49885.50114498881, 1164.2199726183478, 1196.4855112301793, 1201.387292480841, 1206.288289908958, 1223.5472875036294, 26651.0, 27510.17469475919, 27765.0, 27966.44067118687, 28064.01775937914, 42033.57966420297, 42224.1555168901, 42231.7888410556, 42496.36255456232, 42603.7869810649, 261029.0, 264003.0, 264347.0, 264822.0, 265665.0, 24823.627645585693, 24981.125660601792, 25173.370665733502, 25192.622110668723, 25403.87298063498, 41449.79275103605, 42032.79672032772, 42115.368269476596, 42215.57784422117, 42575.574244257165, 35610.93167204988, 36301.0, 36672.449913251854, 37018.629813702595, 37111.0, 35597.46603800893, 36493.0, 36574.268514630094, 36627.633723662424, 36888.6311136896, 35287.64712352947, 36141.63858361383, 36647.26705465929, 36676.63323366732, 36700.63299366972, 31029.224269393446, 32299.35401292008, 32808.50787238241, 32833.34333313368, 32884.177895552806, 25352.873235633702, 25769.484610308064, 25785.0, 25882.87058564695, 25911.870440647675], "value": 16363.37974231285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.54006331831937, 357.7799653213273, 370.50537532394253, 375.09976057462086, 388.15963439154234, 15859.286332115054, 16803.327866885324, 17723.113844307798, 17836.46490605284, 17879.821201787978, 16299.0, 16740.16299185042, 17482.650346993054, 17537.123143842822, 17564.29742810289, 5076.720780357079, 5227.21591761237, 5268.104422248227, 5280.287161233223, 5330.280412144369, 3748.456473811296, 5114.846554603368, 5687.2606561146995, 6025.246844144482, 6026.8493287667725, 6026.397360263961, 6038.698065096728, 6057.182280392135, 6066.029435290355, 6091.908621370683, 5898.705064746746, 5965.970170149165, 5990.460858522711, 6117.296510901237, 6127.571070025122, 5315.468453154692, 5324.9733751331, 5341.706206158659, 5360.249565060894, 5398.838034858961, 17452.127393630268, 18551.62896742071, 20151.193952241894, 20858.791412085837, 20946.685799712865, 1774.086345532052, 1825.8174182581636, 1891.063923357933, 1949.5710943592528, 2438.512297540481, 9146.77133071672, 9208.953955230249, 9234.81530369389, 9380.577873995686, 9388.953055234748, 1739.6868563658536, 1763.6560870630233, 1778.3064604804138, 1785.8839175453554, 1819.8089200633876, 59733.40266597322, 63345.36654633441, 63382.68308658427, 71235.64382178108, 71591.64204178998, 8396.496210227284, 8967.327450441113, 9159.313051521163, 9402.247820174369, 9500.19248363883, 11925.045996320274, 11956.701082473008, 11986.880131198577, 12004.819927701092, 12067.818982715266, 6749.460043196533, 6812.591244525245, 6882.414994725505, 6993.545419547713, 7026.92973070273, 6956.234814170437, 6975.058367120374, 7007.509474336849, 7088.326608972139, 7172.497925145294, 3703.8703645372284, 3759.4172903200047, 3805.904852378713, 3826.5408151022057, 3890.0, 1658.8755843311799, 1701.123921180593, 1813.528482594535, 1875.1468082022648, 1886.1323791056268, 844.4848642328175, 848.5502683577714, 855.9101294364002, 862.7023676831483, 924.8520236762085, 16867.32530698783, 16957.0, 16974.405895793836, 17373.65252694939, 17468.301267949395, 882.4837470079947, 907.8048219632678, 928.8049509602924, 930.6417029443713, 950.3300173377752, 9602.279829012712, 9673.613055477703, 9704.805903882025, 9853.310268281295, 9934.354266972623, 347652.0, 391043.0, 391393.0, 393268.0, 395923.0, 74384.62807685927, 78842.0, 78925.60537197278, 78994.6050269745, 79299.60350198211, 923.5197697197555, 951.9952400238093, 963.5278713430508, 969.6315400147898, 973.7711637765119, 16009.119498427699, 16023.67952640964, 16062.759058614363, 16323.0, 16352.918235409223, 35317.82341088381, 35583.46624800682, 36869.44695829511, 37314.25371492609, 38085.42871856869, 50141.0, 50726.74636626793, 51653.48346516637, 52416.0, 52915.0, 7733.613319334123, 7783.221677832172, 7784.299413052852, 7804.102528209329, 7889.408294377829, 6098.786542470993, 8746.781330466789, 9391.0, 12264.632061038183, 12421.689457763629, 9582.377145485521, 10331.690049298533, 10362.844557331797, 10591.576336946437, 10930.344179349264, 10792.838107428552, 10871.891281087088, 10901.454927253764, 10981.945090274497, 11110.333379997226, 10874.78250434971, 10880.510377032893, 10954.507047182737, 10982.231243812856, 11175.664730058112, 7573.9242607573215, 7639.503432276884, 7810.648520816463, 7989.440739148204, 8049.718259860877, 8876.28989680811, 10217.74455638615, 10253.0, 10698.465076745975, 10778.245522813328], "value": 8199.76389082059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.2218696436512, 1409.1897159133498, 1492.373203254633, 1643.8602718768905, 1666.4584010196688, 6683.398494135527, 7514.849703005943, 7574.545527268354, 8078.353731701472, 8082.191780821922, 7620.733274335399, 7732.884006739903, 7776.144624091346, 7910.683572657102, 7929.286364227219, 2165.5127596290868, 2194.615942210115, 2204.492966617679, 2206.8234541236743, 2213.656883183109, 2093.727815383998, 2112.4402033461147, 2157.967630485544, 2160.567886422714, 2165.5993641176356, 2131.1688441507827, 2140.2081229944865, 2158.881261530615, 2160.2655097266925, 2179.24815938501, 2080.4070839810656, 2085.4160834966233, 2127.2022991378235, 2128.138104067855, 2133.5839511295303, 2093.612681653899, 2119.8198153156845, 2131.968020479694, 2132.701421800949, 2135.4661334666334, 7945.12603613602, 7947.72182973599, 8004.599770011476, 8011.479253848481, 8014.559199244098, 4601.815927362902, 4698.694584851974, 4699.060187962387, 4734.526547345273, 4752.334673145762, 2741.383188782528, 2796.2450138462705, 2887.2348827560713, 2939.030120060375, 2952.409518096389, 868.0451503346269, 903.9096090390974, 911.0525053943891, 943.6649989253854, 947.2280091725222, 10789.622363217328, 10804.891951080468, 10831.945840270828, 10845.83731244032, 10890.128789696806, 4167.97916010418, 4210.726302790309, 4235.767032813224, 4286.89282767927, 4294.141171765659, 9182.908170918205, 9187.26501879848, 9191.494467804336, 9228.35401521887, 9248.26013918885, 4697.0840686065885, 4697.31888876111, 4716.622670186377, 4718.976405118021, 4719.480857105716, 3718.2935242303874, 4123.36087906375, 4209.431726716915, 4297.333913243452, 4305.698601097955, 3638.1086633774894, 3670.476752147882, 3770.962290377116, 3773.716971227169, 3865.980670096688, 1182.6274723462082, 1199.7060720123625, 1202.1404695642482, 1206.3847437806783, 1214.7934851075338, 664.3588936676131, 794.4399198564997, 795.9044914610283, 810.9148539403395, 840.2102024097329, 5042.899142017139, 5178.870528236749, 5267.104592219332, 5298.549623281987, 5361.544268737123, 410.4991909870013, 433.1099590341878, 433.4543434704088, 433.71158179810703, 433.92406328892315, 3674.4488326750666, 3712.3132220539287, 3746.9625303746616, 3749.1002159482073, 3778.4521244419407, 9181.35730498872, 9259.444433334022, 9425.575849086808, 9446.244300455946, 9514.096160864707, 9250.0, 9288.071192880792, 9292.0, 9314.44113353201, 9347.859782103274, 7096.574205547684, 7124.358807707331, 7163.67763450646, 7322.0115284435915, 7327.303906128909, 5141.357330333708, 5168.638195326291, 5248.343957005374, 5354.919676204938, 5456.972715136399, 9055.411398259092, 9135.77160570991, 9136.269098471974, 9137.5888085035, 9193.632254710004, 8571.571421428778, 9020.14308640678, 9026.413283136575, 9204.309676774135, 9326.06739326062, 6025.427584379477, 6445.387688169616, 6588.670566471753, 6827.692753825991, 6878.071460352989, 7603.657835397531, 7679.078510578766, 7683.538987660758, 7703.614819258903, 7726.4205184610255, 6586.176727909012, 6716.1604799400075, 6735.898961515679, 6829.4877884157895, 6846.554973926679, 6464.644444555594, 6531.379518945692, 6535.0, 6552.3447655234095, 6600.570962887397, 6098.481629061579, 6108.114323423168, 6145.4161854623735, 6169.413905678954, 6217.160683307696, 4364.8472303469225, 4480.9103817924115, 4629.1436084324505, 4684.695494792828, 4719.268513380432, 4754.072955773591, 4762.476127626028, 4798.064377446504, 4822.107910036654, 4896.4124305083615], "value": 4058.2810793055605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.1086562045104, 307.06804847288475, 313.03272886779854, 313.9795913265639, 314.6916022298149, 4955.727434991074, 4997.200447928332, 5098.158803797373, 5203.8959220815605, 5228.13735733604, 5036.571891389236, 5087.720175390352, 5091.643584949045, 5106.795728170878, 5120.3343565336545, 3972.7417717848393, 3988.3419235826054, 3997.1805779815213, 3998.4002399639994, 4019.3970904364432, 3920.3338581102917, 3991.1618560102415, 4006.879793606182, 4014.237294913957, 4056.9594304056877, 3951.5258169019758, 3965.6827453803626, 3973.9801300993454, 3979.8408063677416, 3983.1436241208135, 3995.6403923646867, 4000.9199816003807, 4017.055991841944, 4022.2960981828064, 4040.828159833645, 3553.8045407502577, 3572.7141828653644, 3579.1588976590742, 3589.8743543975834, 3596.1009747563107, 4832.251001094801, 4979.377577802775, 4981.875453113665, 4982.87542811429, 5120.743962801882, 4580.90058385985, 4583.243764778807, 4595.379623750784, 4597.931031034537, 4599.954000459986, 5385.515303622693, 5385.838424847222, 5408.432114627947, 5438.7280635968045, 5439.211314359435, 3790.924181516354, 3871.477350557667, 3872.961270387288, 3875.9031024224337, 3914.64768170866, 5671.376148623648, 5687.857803554903, 5705.6006079574445, 5706.400827913092, 5723.54211663066, 3971.960280397217, 3984.7011474139554, 3991.2217117661776, 4013.7993100344866, 4014.578469260744, 3943.6253555912144, 4028.4561584186345, 4040.2525532775944, 4042.0501182222156, 4051.108756073659, 4497.302918047708, 4504.256797628354, 4510.2783554631105, 4510.323451482238, 4579.427571553556, 5346.144616861284, 5350.117230656976, 5354.40311448947, 5416.133418653076, 5477.1510415885605, 1296.7795474769312, 1363.638635761524, 1393.8606139386184, 1399.139529189541, 1405.156905856478, 869.517417833096, 880.1638443478721, 907.8865141857268, 913.0504275553483, 920.3649481857497, 4227.991703940604, 4245.639120674716, 4266.253405653998, 4279.8872293203995, 4302.870913872589, 4846.704241116075, 4848.903021939542, 4890.902181956341, 4932.334134891744, 4952.603791696655, 4245.0, 4245.511766146871, 4256.61690447855, 4269.573042695768, 4287.378330142112, 2440.877956102188, 2594.4421949280995, 2609.673790776153, 2617.227917764226, 2622.9213123606323, 4518.231900576844, 4539.251023581138, 4560.977195114069, 4582.977085114553, 4609.870581707503, 4868.2210846264425, 4915.287283343895, 4928.728919909439, 4933.481984391659, 4971.950280497221, 4775.498572649891, 5199.66202196856, 5208.192730126836, 5219.869503262373, 5231.985685511182, 5517.393086760533, 5533.446655334435, 5534.6440122170325, 5546.944530554804, 5549.472800083986, 5236.371635403776, 5423.674579525241, 5423.891522169613, 5425.647332923348, 5474.534664553557, 5211.687298762086, 5215.478452154754, 5216.5393689766925, 5217.426083130928, 5225.477452254744, 3862.343401621787, 3874.457575939427, 3881.4177873319227, 3888.8833334999995, 3889.319369110451, 5316.362036555638, 5532.944670553243, 5543.473370029841, 5568.832935011957, 5570.275864137636, 5245.423003469539, 5333.7333133343955, 5359.115745901882, 5365.022412561066, 5380.166074258496, 5374.811881584125, 5392.948375066824, 5393.7033463159905, 5408.350997880122, 5411.621186516906, 5043.234867796388, 5286.762095705625, 5292.841214763564, 5297.093046503179, 5309.203619457112, 5411.242426060276, 5415.566754659697, 5419.810306639249, 5429.049916264717, 5443.918341224806, 5252.579793616578, 5262.316058861128, 5289.894202116013, 5297.258383826191, 5297.496737809902], "value": 3972.0075327209393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.0326861342292, 662.7978466567695, 666.5101150654269, 684.780870121561, 728.566502930756, 12872.3563821809, 13361.198328100309, 13367.933160334185, 13375.26436046017, 13387.062905596587, 12387.690307742288, 12528.872401483864, 12632.873671263285, 12676.556320528784, 12734.68163295918, 638.8402899275181, 776.5806464509159, 803.9839203215947, 808.0586117173515, 810.2262339465796, 801.3989507869098, 810.5339429827843, 811.4928169893816, 812.760235730458, 814.5682788122305, 842.7682387343468, 846.7417437681505, 850.0819115355432, 850.4854562989395, 852.1861622150863, 828.8093738440162, 834.4034015678789, 836.4061516323418, 837.3552364679163, 838.7064527415416, 615.9599626024294, 616.22355831652, 616.771794436057, 618.4650277509967, 618.4742968476804, 13749.0, 13751.587452376445, 13792.0, 13798.517051903134, 13809.585712428643, 13431.865681343159, 13510.662233444242, 13535.864641353559, 13922.37349319273, 14058.437662493488, 10415.895841041569, 10427.791444171075, 10573.788524229472, 10576.206784491194, 10647.57409703611, 3384.424647809878, 3420.2304481491715, 3445.207602251496, 3450.1202193440763, 3450.2064525159353, 57233.427665723226, 57568.42431575715, 57915.42084579142, 59688.0, 59812.401875981115, 10441.0, 10470.110040646478, 10485.895141048644, 10562.471876406149, 10965.83551246732, 19855.30506432297, 20095.296664616668, 20151.899240503702, 20217.89891050535, 20332.0, 6914.965425172842, 7027.543209691354, 7055.506114571931, 7067.399271062018, 7149.0706208192605, 3632.564092308887, 3816.6183381662167, 3819.8281077351585, 3829.4064420014943, 3842.2315536892734, 2843.38867143561, 2965.3328001199557, 2970.6435227772804, 2972.4798160321857, 2977.910662680123, 464.8814552289145, 487.6513292995525, 490.0908814149701, 508.9923651145236, 541.4558368839291, 574.2247965246884, 585.2976428286074, 589.7139887154813, 601.7833579911229, 625.9155014073042, 7511.06111736033, 7740.187280335596, 7772.572508511973, 8015.318697910627, 8265.793355166168, 559.35953333433, 590.0087852407996, 592.5259792166336, 608.5223099866583, 618.8607563298222, 3704.1665625234646, 3822.7897465639658, 3947.210557888434, 4020.4773379460485, 4072.0, 88017.0, 101159.0, 103365.0, 103538.0, 106073.46963265134, 53324.46675533272, 67605.66197168983, 87562.56218718993, 87810.56094719486, 88442.55778721193, 48309.75845120752, 48330.16698330139, 49145.26282105771, 68556.6572167136, 78900.99999999885, 7347.537109150989, 7488.363489103487, 7542.434317426325, 7626.0, 7737.767866963775, 46057.539424605326, 46158.30762538632, 46627.53372466368, 46928.29607555821, 47053.0, 52467.0, 53903.730481347346, 54584.454155457934, 61405.38594613997, 61860.38139618546, 10692.786144276915, 10913.732053376847, 11470.139739519402, 11548.364839933884, 11586.304821710724, 12982.870171298544, 13110.082294239694, 13126.671833204246, 13350.933245333712, 13778.838188681555, 10771.299865508718, 11413.885861141282, 11655.41722913834, 12206.389680516117, 12908.483660653468, 11316.321020738782, 11695.649130526097, 12157.0, 12307.384630768605, 12419.689507762378, 11028.172887033345, 11478.139139564399, 11478.426078696199, 11638.825417618911, 11931.105167112328, 10369.0, 10531.526081326205, 10741.46292685347, 10911.781764364827, 10960.232783705384, 10578.15374770032, 10940.398278094463, 11006.889931100586, 11022.724431889266, 11193.0], "value": 6582.5807083782975, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 109.0, 114.0, 112.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 133.0, 157.0, 183.0, 129.0, 165.0, 160.0, 149.0, 207.0, 133.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 181.0, 161.0, 162.0, 163.0, 166.0, 162.0, 162.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 170.0, 76.0, 75.0, 78.0, 75.0, 167.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 139.0, 87.0, 87.0, 85.0, 147.0, 86.0, 88.0, 143.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 119.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 150.0, 152.0, 148.0, 149.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 100.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 66.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 86.0, 87.0, 90.0, 83.0, 101.0, 90.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 138.0, 129.0, 135.0, 142.0, 132.0, 141.0, 144.0, 136.0, 132.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 169.0, 171.0, 168.0, 172.0, 173.0, 169.0, 174.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 67.0, 66.0, 68.0, 71.0, 67.0, 66.0, 67.0, 67.0], "value": 67.8, "unit": "score"}]}]} 10:29:22 INFO - Return code: 0 10:29:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:22 ERROR - # TBPL SUCCESS # 10:29:22 INFO - Running post-action listener: _resource_record_post_action 10:29:22 INFO - ##### 10:29:22 INFO - ##### Finished run-tests step (success) 10:29:22 INFO - ##### 10:29:22 INFO - Running post-run listener: _resource_record_post_run 10:29:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7909376; Write bytes: 305229824; Read time: 1376; Write time: 171064 10:29:22 INFO - TinderboxPrint: CPU usage
13.4% 10:29:22 INFO - TinderboxPrint: I/O read bytes / time
7,909,376 / 1,376 10:29:22 INFO - TinderboxPrint: I/O write bytes / time
305,229,824 / 171,064 10:29:22 INFO - TinderboxPrint: CPU idle
8,284.5 (86.5%) 10:29:22 INFO - TinderboxPrint: CPU user
1,233.2 (12.9%) 10:29:22 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20684800; Read time: 0; Write time: 15996 10:29:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6148096; Write bytes: 284545024; Read time: 1344; Write time: 155068 10:29:23 INFO - Running post-run listener: _upload_blobber_files 10:29:23 INFO - Blob upload gear active. 10:29:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:23 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 10:29:23 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:23 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:24 INFO - (blobuploader) - INFO - Done attempting. 10:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:28 INFO - (blobuploader) - INFO - Done attempting. 10:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:28 INFO - (blobuploader) - INFO - Done attempting. 10:29:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:28 INFO - Return code: 0 10:29:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f65ffb48bf82eef0984c77b75743d6efbbcac0d0d215d49c5c30c7ea3ce6e70f766e071f157651cc62599d61c49ab49bf1674662b4a391897517cd1384af3003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/471991920817b2a885697c9878628088eb6f0fed6193140758f04e2df5f3f21c4052271ee4882793031fe56fdeee2fbad4589dd557dd4d67a478aec38cb8c2ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09099e065e9084fd606f722b7d9bd2a0457bd05a88d744a8478fef112e734b81b688fef1d0c8d95e1d37072d5ec6894d3d2f4554bf1039243dbd2be2e5e8d2c3"} 10:29:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:28 INFO - Contents: 10:29:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f65ffb48bf82eef0984c77b75743d6efbbcac0d0d215d49c5c30c7ea3ce6e70f766e071f157651cc62599d61c49ab49bf1674662b4a391897517cd1384af3003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/471991920817b2a885697c9878628088eb6f0fed6193140758f04e2df5f3f21c4052271ee4882793031fe56fdeee2fbad4589dd557dd4d67a478aec38cb8c2ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09099e065e9084fd606f722b7d9bd2a0457bd05a88d744a8478fef112e734b81b688fef1d0c8d95e1d37072d5ec6894d3d2f4554bf1039243dbd2be2e5e8d2c3"} 10:29:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:28 INFO - Copying logs to upload dir... 10:29:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.413809 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-25 10:29:28.842610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 10:29:28.846767) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 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-Non-PGO/sha512/f65ffb48bf82eef0984c77b75743d6efbbcac0d0d215d49c5c30c7ea3ce6e70f766e071f157651cc62599d61c49ab49bf1674662b4a391897517cd1384af3003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/471991920817b2a885697c9878628088eb6f0fed6193140758f04e2df5f3f21c4052271ee4882793031fe56fdeee2fbad4589dd557dd4d67a478aec38cb8c2ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09099e065e9084fd606f722b7d9bd2a0457bd05a88d744a8478fef112e734b81b688fef1d0c8d95e1d37072d5ec6894d3d2f4554bf1039243dbd2be2e5e8d2c3"} build_url:https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/B5RJnMlrREaEB9osItV7cA/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-Non-PGO/sha512/f65ffb48bf82eef0984c77b75743d6efbbcac0d0d215d49c5c30c7ea3ce6e70f766e071f157651cc62599d61c49ab49bf1674662b4a391897517cd1384af3003", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/471991920817b2a885697c9878628088eb6f0fed6193140758f04e2df5f3f21c4052271ee4882793031fe56fdeee2fbad4589dd557dd4d67a478aec38cb8c2ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09099e065e9084fd606f722b7d9bd2a0457bd05a88d744a8478fef112e734b81b688fef1d0c8d95e1d37072d5ec6894d3d2f4554bf1039243dbd2be2e5e8d2c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 10:29:28.875974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:29:28.876331) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466859012.579225-616121039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 10:29:28.960777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 10:29:28.961087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 10:29:28.961379) ========= ========= Total master_lag: 0.19 =========