builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1469686874.28 results: success (0) buildid: 20160727204328 builduid: 1986fe8d37264637919ff3ae08d5660b revision: 5d074cab0660484773df4e366149a97f2ff21be5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.284022) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.284495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.284804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.299621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.299890) ========= 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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 23:21:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-27 23:21:14 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.411602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.411932) ========= 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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018426 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.462182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:14.462521) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5d074cab0660484773df4e366149a97f2ff21be5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5d074cab0660484773df4e366149a97f2ff21be5 --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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 23:21:14,620 truncating revision to first 12 chars 2016-07-27 23:21:14,620 Setting DEBUG logging. 2016-07-27 23:21:14,621 attempt 1/10 2016-07-27 23:21:14,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5d074cab0660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 23:21:14,949 unpacking tar archive at: mozilla-aurora-5d074cab0660/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:15.147282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:15.147582) ========= script_repo_revision: 5d074cab0660484773df4e366149a97f2ff21be5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:15.147981) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:15.148381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 23:21:15.158872) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 23:21:15.159163) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:21:15 INFO - MultiFileLogger online at 20160727 23:21:15 in /builds/slave/test 23:21:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:21:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:21:15 INFO - {'append_to_log': False, 23:21:15 INFO - 'base_work_dir': '/builds/slave/test', 23:21:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:21:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:21:15 INFO - 'branch': 'Mozilla-Aurora', 23:21:15 INFO - 'buildbot_json_path': 'buildprops.json', 23:21:15 INFO - 'config_files': ('talos/linux_config.py',), 23:21:15 INFO - 'default_actions': ('clobber', 23:21:15 INFO - 'read-buildbot-config', 23:21:15 INFO - 'download-and-extract', 23:21:15 INFO - 'populate-webroot', 23:21:15 INFO - 'create-virtualenv', 23:21:15 INFO - 'install', 23:21:15 INFO - 'run-tests'), 23:21:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:21:15 INFO - 'download_minidump_stackwalk': True, 23:21:15 INFO - 'download_symbols': 'ondemand', 23:21:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:21:15 INFO - 'tooltool.py': '/tools/tooltool.py', 23:21:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:21:15 INFO - '/tools/misc-python/virtualenv.py')}, 23:21:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:21:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:21:15 INFO - 'installer_path': 'installer.exe', 23:21:15 INFO - 'log_level': 'info', 23:21:15 INFO - 'log_name': 'talos', 23:21:15 INFO - 'log_to_console': True, 23:21:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:21:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:21:15 INFO - 'opt_config_files': (), 23:21:15 INFO - 'pip_index': False, 23:21:15 INFO - 'sps_profile': False, 23:21:15 INFO - 'sps_profile_interval': 0, 23:21:15 INFO - 'suite': 'dromaeojs-e10s', 23:21:15 INFO - 'system_bits': '32', 23:21:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:21:15 INFO - 'title': 'talos-linux64-ix-052', 23:21:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:21:15 INFO - 'use_talos_json': True, 23:21:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:21:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:21:15 INFO - 'work_dir': 'build'} 23:21:15 INFO - ##### 23:21:15 INFO - ##### Running clobber step. 23:21:15 INFO - ##### 23:21:15 INFO - Running pre-action listener: _resource_record_pre_action 23:21:15 INFO - Running main action method: clobber 23:21:15 INFO - rmtree: /builds/slave/test/build 23:21:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:21:15 INFO - Running post-action listener: _resource_record_post_action 23:21:15 INFO - ##### 23:21:15 INFO - ##### Finished clobber step (success) 23:21:15 INFO - ##### 23:21:15 INFO - ##### 23:21:15 INFO - ##### Running read-buildbot-config step. 23:21:15 INFO - ##### 23:21:15 INFO - Running pre-action listener: _resource_record_pre_action 23:21:15 INFO - Running main action method: read_buildbot_config 23:21:15 INFO - Using buildbot properties: 23:21:15 INFO - { 23:21:15 INFO - "project": "", 23:21:15 INFO - "product": "firefox", 23:21:15 INFO - "script_repo_revision": "production", 23:21:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:21:15 INFO - "repository": "", 23:21:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:21:15 INFO - "buildid": "20160727204328", 23:21:15 INFO - "pgo_build": "True", 23:21:15 INFO - "basedir": "/builds/slave/test", 23:21:15 INFO - "buildnumber": 414, 23:21:15 INFO - "slavename": "talos-linux64-ix-052", 23:21:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:21:15 INFO - "platform": "ubuntu64_hw", 23:21:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:21:15 INFO - "branch": "mozilla-aurora", 23:21:15 INFO - "repo_path": "releases/mozilla-aurora", 23:21:15 INFO - "revision": "5d074cab0660484773df4e366149a97f2ff21be5", 23:21:15 INFO - "stage_platform": "linux64-pgo", 23:21:15 INFO - "builduid": "1986fe8d37264637919ff3ae08d5660b", 23:21:15 INFO - "slavebuilddir": "test" 23:21:15 INFO - } 23:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:21:15 INFO - Running post-action listener: _resource_record_post_action 23:21:15 INFO - ##### 23:21:15 INFO - ##### Finished read-buildbot-config step (success) 23:21:15 INFO - ##### 23:21:15 INFO - ##### 23:21:15 INFO - ##### Running download-and-extract step. 23:21:15 INFO - ##### 23:21:15 INFO - Running pre-action listener: _resource_record_pre_action 23:21:15 INFO - Running main action method: download_and_extract 23:21:15 INFO - mkdir: /builds/slave/test/build/tests 23:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:15 INFO - https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:21:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:21:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:21:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:21:16 INFO - Downloaded 1361 bytes. 23:21:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:21:16 INFO - Using the following test package requirements: 23:21:16 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:21:16 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:21:16 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:21:16 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'jsshell-linux-x86_64.zip'], 23:21:16 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:21:16 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:21:16 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:21:16 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:21:16 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:21:16 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:21:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:21:16 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:16 INFO - https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:21:17 INFO - Downloaded 24495051 bytes. 23:21:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:21:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:21:18 INFO - Return code: 0 23:21:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:21: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')]} 23:21:18 INFO - https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:21:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:21:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:21:21 INFO - Downloaded 24495051 bytes. 23:21:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:21:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:21:22 INFO - Return code: 0 23:21:22 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')]} 23:21:22 INFO - https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:21:23 INFO - Downloaded 10833369 bytes. 23:21:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:21:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:21:23 INFO - Return code: 0 23:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:23 INFO - https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:21:24 INFO - Downloaded 63654540 bytes. 23:21:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:21:24 INFO - mkdir: /builds/slave/test/properties 23:21:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:21:24 INFO - Writing to file /builds/slave/test/properties/build_url 23:21:24 INFO - Contents: 23:21:24 INFO - build_url:https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:21:25 INFO - Running post-action listener: _resource_record_post_action 23:21:25 INFO - Running post-action listener: set_extra_try_arguments 23:21:25 INFO - ##### 23:21:25 INFO - ##### Finished download-and-extract step (success) 23:21:25 INFO - ##### 23:21:25 INFO - ##### 23:21:25 INFO - ##### Running populate-webroot step. 23:21:25 INFO - ##### 23:21:25 INFO - Running pre-action listener: _resource_record_pre_action 23:21:25 INFO - Running main action method: populate_webroot 23:21:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:21:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:21:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:21:25 INFO - '--tppagecycles', 23:21:25 INFO - '7'], 23:21:25 INFO - 'tests': ['tsvgm']}}, 23:21:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:21:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:21:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:21:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:21:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:21:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['damp', 'tps']}, 23:21:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'tests': ['damp', 'tps']}, 23:21:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['dromaeo_dom']}, 23:21:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:21:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'other-e10s': {'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['a11yr', 23:21:25 INFO - 'ts_paint', 23:21:25 INFO - 'tpaint', 23:21:25 INFO - 'sessionrestore', 23:21:25 INFO - 'sessionrestore_no_auto_restore', 23:21:25 INFO - 'tabpaint']}, 23:21:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['tsvgx', 23:21:25 INFO - 'tsvgr_opacity', 23:21:25 INFO - 'tart', 23:21:25 INFO - 'tscrollx', 23:21:25 INFO - 'cart']}, 23:21:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:21:25 INFO - 'tsvgr_opacity', 23:21:25 INFO - 'tart', 23:21:25 INFO - 'tscrollx', 23:21:25 INFO - 'cart']}, 23:21:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'talos_options': ['--disable-e10s'], 23:21:25 INFO - 'tests': ['tp5o']}, 23:21:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'tests': ['tp5o']}, 23:21:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'talos_options': ['--disable-e10s', 23:21:25 INFO - '--xperf_path', 23:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:25 INFO - 'tests': ['tp5n']}, 23:21:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:21:25 INFO - 'talos_options': ['--xperf_path', 23:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:21:25 INFO - 'tests': ['tp5n']}}, 23:21:25 INFO - 'talos.zip': {'path': '', 23:21:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:21:25 INFO - Running post-action listener: _resource_record_post_action 23:21:25 INFO - ##### 23:21:25 INFO - ##### Finished populate-webroot step (success) 23:21:25 INFO - ##### 23:21:25 INFO - ##### 23:21:25 INFO - ##### Running create-virtualenv step. 23:21:25 INFO - ##### 23:21:25 INFO - Running pre-action listener: _resource_record_pre_action 23:21:25 INFO - Running main action method: create_virtualenv 23:21:25 INFO - Creating virtualenv /builds/slave/test/build/venv 23:21:25 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 23:21:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:21:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:21:25 INFO - Using real prefix '/usr' 23:21:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:21:26 INFO - Installing distribute.............................................................................................................................................................................................done. 23:21:28 INFO - Installing pip.................done. 23:21:28 INFO - Return code: 0 23:21:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:21:28 INFO - Using env: {'DISPLAY': ':0', 23:21:28 INFO - 'HOME': '/home/cltbld', 23:21:28 INFO - 'LANG': 'en_US.UTF-8', 23:21:28 INFO - 'LANGUAGE': 'en_US:en', 23:21:28 INFO - 'LOGNAME': 'cltbld', 23:21:28 INFO - 'MAIL': '/var/mail/cltbld', 23:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:28 INFO - 'MOZ_NO_REMOTE': '1', 23:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:28 INFO - 'NO_EM_RESTART': '1', 23:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:28 INFO - 'PWD': '/builds/slave/test', 23:21:28 INFO - 'SHELL': '/bin/bash', 23:21:28 INFO - 'SHLVL': '1', 23:21:28 INFO - 'TERM': 'linux', 23:21:28 INFO - 'TMOUT': '86400', 23:21:28 INFO - 'USER': 'cltbld', 23:21:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:28 INFO - '_': '/tools/buildbot/bin/python'} 23:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:28 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 23:21:28 INFO - Cleaning up... 23:21:28 INFO - Return code: 0 23:21:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:21:28 INFO - Using env: {'DISPLAY': ':0', 23:21:28 INFO - 'HOME': '/home/cltbld', 23:21:28 INFO - 'LANG': 'en_US.UTF-8', 23:21:28 INFO - 'LANGUAGE': 'en_US:en', 23:21:28 INFO - 'LOGNAME': 'cltbld', 23:21:28 INFO - 'MAIL': '/var/mail/cltbld', 23:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:28 INFO - 'MOZ_NO_REMOTE': '1', 23:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:28 INFO - 'NO_EM_RESTART': '1', 23:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:28 INFO - 'PWD': '/builds/slave/test', 23:21:28 INFO - 'SHELL': '/bin/bash', 23:21:28 INFO - 'SHLVL': '1', 23:21:28 INFO - 'TERM': 'linux', 23:21:28 INFO - 'TMOUT': '86400', 23:21:28 INFO - 'USER': 'cltbld', 23:21:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:28 INFO - '_': '/tools/buildbot/bin/python'} 23:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:28 INFO - Downloading/unpacking psutil>=3.1.1 23:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:21:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:30 INFO - Installing collected packages: psutil 23:21:30 INFO - Running setup.py install for psutil 23:21:30 INFO - building 'psutil._psutil_linux' extension 23:21:30 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 23:21:30 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 23:21:30 INFO - building 'psutil._psutil_posix' extension 23:21:30 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 23:21:30 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 23:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:21:31 INFO - Successfully installed psutil 23:21:31 INFO - Cleaning up... 23:21:31 INFO - Return code: 0 23:21:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:31 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 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:31 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 23:21:31 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 23:21:31 INFO - Using env: {'DISPLAY': ':0', 23:21:31 INFO - 'HOME': '/home/cltbld', 23:21:31 INFO - 'LANG': 'en_US.UTF-8', 23:21:31 INFO - 'LANGUAGE': 'en_US:en', 23:21:31 INFO - 'LOGNAME': 'cltbld', 23:21:31 INFO - 'MAIL': '/var/mail/cltbld', 23:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:31 INFO - 'MOZ_NO_REMOTE': '1', 23:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:31 INFO - 'NO_EM_RESTART': '1', 23:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:31 INFO - 'PWD': '/builds/slave/test', 23:21:31 INFO - 'SHELL': '/bin/bash', 23:21:31 INFO - 'SHLVL': '1', 23:21:31 INFO - 'TERM': 'linux', 23:21:31 INFO - 'TMOUT': '86400', 23:21:31 INFO - 'USER': 'cltbld', 23:21:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:31 INFO - '_': '/tools/buildbot/bin/python'} 23:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:21:31 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 23:21:31 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 23:21:31 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 23:21:31 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 23:21:31 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 23:21:31 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 23:21:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:21:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:21:33 INFO - Installing collected packages: mozsystemmonitor 23:21:33 INFO - Running setup.py install for mozsystemmonitor 23:21:33 INFO - Successfully installed mozsystemmonitor 23:21:33 INFO - Cleaning up... 23:21:33 INFO - Return code: 0 23:21:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:21:33 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')]} 23:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:33 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')]} 23:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:33 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 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:33 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 23:21:33 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 23:21:33 INFO - Using env: {'DISPLAY': ':0', 23:21:33 INFO - 'HOME': '/home/cltbld', 23:21:33 INFO - 'LANG': 'en_US.UTF-8', 23:21:33 INFO - 'LANGUAGE': 'en_US:en', 23:21:33 INFO - 'LOGNAME': 'cltbld', 23:21:33 INFO - 'MAIL': '/var/mail/cltbld', 23:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:33 INFO - 'MOZ_NO_REMOTE': '1', 23:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:33 INFO - 'NO_EM_RESTART': '1', 23:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:33 INFO - 'PWD': '/builds/slave/test', 23:21:33 INFO - 'SHELL': '/bin/bash', 23:21:33 INFO - 'SHLVL': '1', 23:21:33 INFO - 'TERM': 'linux', 23:21:33 INFO - 'TMOUT': '86400', 23:21:33 INFO - 'USER': 'cltbld', 23:21:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:33 INFO - '_': '/tools/buildbot/bin/python'} 23:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:33 INFO - Downloading/unpacking jsonschema==2.5.1 23:21:33 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 23:21:33 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 23:21:33 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 23:21:33 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 23:21:33 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 23:21:33 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 23:21:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:21:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:35 INFO - Downloading functools32-3.2.3-2.tar.gz 23:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:21:36 INFO - warning: no files found matching '*.txt' 23:21:36 INFO - no previously-included directories found matching 'build' 23:21:36 INFO - no previously-included directories found matching 'dist' 23:21:36 INFO - no previously-included directories found matching '.git*' 23:21:36 INFO - Installing collected packages: jsonschema, functools32 23:21:37 INFO - Running setup.py install for functools32 23:21:37 INFO - warning: no files found matching '*.txt' 23:21:37 INFO - no previously-included directories found matching 'build' 23:21:37 INFO - no previously-included directories found matching 'dist' 23:21:37 INFO - no previously-included directories found matching '.git*' 23:21:37 INFO - Successfully installed jsonschema functools32 23:21:37 INFO - Cleaning up... 23:21:37 INFO - Return code: 0 23:21:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:21:37 INFO - Using env: {'DISPLAY': ':0', 23:21:37 INFO - 'HOME': '/home/cltbld', 23:21:37 INFO - 'LANG': 'en_US.UTF-8', 23:21:37 INFO - 'LANGUAGE': 'en_US:en', 23:21:37 INFO - 'LOGNAME': 'cltbld', 23:21:37 INFO - 'MAIL': '/var/mail/cltbld', 23:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:37 INFO - 'MOZ_NO_REMOTE': '1', 23:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:37 INFO - 'NO_EM_RESTART': '1', 23:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:37 INFO - 'PWD': '/builds/slave/test', 23:21:37 INFO - 'SHELL': '/bin/bash', 23:21:37 INFO - 'SHLVL': '1', 23:21:37 INFO - 'TERM': 'linux', 23:21:37 INFO - 'TMOUT': '86400', 23:21:37 INFO - 'USER': 'cltbld', 23:21:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:37 INFO - '_': '/tools/buildbot/bin/python'} 23:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:37 INFO - Downloading/unpacking blobuploader==1.2.4 23:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:39 INFO - Downloading blobuploader-1.2.4.tar.gz 23:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:21:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:21:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:40 INFO - Downloading docopt-0.6.1.tar.gz 23:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:21:40 INFO - Installing collected packages: blobuploader, requests, docopt 23:21:40 INFO - Running setup.py install for blobuploader 23:21:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:21:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:21:40 INFO - Running setup.py install for requests 23:21:41 INFO - Running setup.py install for docopt 23:21:41 INFO - Successfully installed blobuploader requests docopt 23:21:41 INFO - Cleaning up... 23:21:41 INFO - Return code: 0 23:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21: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')]} 23:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21: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')]} 23:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:41 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 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:41 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 23:21:41 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 23:21:41 INFO - Using env: {'DISPLAY': ':0', 23:21:41 INFO - 'HOME': '/home/cltbld', 23:21:41 INFO - 'LANG': 'en_US.UTF-8', 23:21:41 INFO - 'LANGUAGE': 'en_US:en', 23:21:41 INFO - 'LOGNAME': 'cltbld', 23:21:41 INFO - 'MAIL': '/var/mail/cltbld', 23:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:41 INFO - 'MOZ_NO_REMOTE': '1', 23:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:41 INFO - 'NO_EM_RESTART': '1', 23:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:41 INFO - 'PWD': '/builds/slave/test', 23:21:41 INFO - 'SHELL': '/bin/bash', 23:21:41 INFO - 'SHLVL': '1', 23:21:41 INFO - 'TERM': 'linux', 23:21:41 INFO - 'TMOUT': '86400', 23:21:41 INFO - 'USER': 'cltbld', 23:21:41 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:41 INFO - '_': '/tools/buildbot/bin/python'} 23:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:41 INFO - Running setup.py (path:/tmp/pip-CiQ5jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:41 INFO - Running setup.py (path:/tmp/pip-peIQL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:41 INFO - Running setup.py (path:/tmp/pip-YcHWNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:41 INFO - Running setup.py (path:/tmp/pip-IqqQfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:41 INFO - Running setup.py (path:/tmp/pip-Yyugo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:41 INFO - Running setup.py (path:/tmp/pip-GUEUW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:41 INFO - Running setup.py (path:/tmp/pip-DBlbzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:41 INFO - Running setup.py (path:/tmp/pip-wAE39P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:41 INFO - Running setup.py (path:/tmp/pip-XVjPe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:42 INFO - Running setup.py (path:/tmp/pip-KeJlHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:42 INFO - Running setup.py (path:/tmp/pip-FQWhiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:42 INFO - Running setup.py (path:/tmp/pip-rWx8l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:42 INFO - Running setup.py (path:/tmp/pip-X1x3A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:42 INFO - Running setup.py (path:/tmp/pip-OXSRZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:42 INFO - Running setup.py (path:/tmp/pip-h7Alig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:42 INFO - Running setup.py (path:/tmp/pip-z4ZOju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:42 INFO - Running setup.py (path:/tmp/pip-qhVtWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:21:42 INFO - Running setup.py install for manifestparser 23:21:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:21:42 INFO - Running setup.py install for mozcrash 23:21:42 INFO - Running setup.py install for mozdebug 23:21:42 INFO - Running setup.py install for mozdevice 23:21:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozfile 23:21:43 INFO - Running setup.py install for mozhttpd 23:21:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozinfo 23:21:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozInstall 23:21:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozleak 23:21:43 INFO - Running setup.py install for mozlog 23:21:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for moznetwork 23:21:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozprocess 23:21:43 INFO - Running setup.py install for mozprofile 23:21:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:21:43 INFO - Running setup.py install for mozrunner 23:21:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:21:44 INFO - Running setup.py install for mozscreenshot 23:21:44 INFO - Running setup.py install for moztest 23:21:44 INFO - Running setup.py install for mozversion 23:21:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:21:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:21:44 INFO - Cleaning up... 23:21:44 INFO - Return code: 0 23:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:21:44 INFO - Using env: {'DISPLAY': ':0', 23:21:44 INFO - 'HOME': '/home/cltbld', 23:21:44 INFO - 'LANG': 'en_US.UTF-8', 23:21:44 INFO - 'LANGUAGE': 'en_US:en', 23:21:44 INFO - 'LOGNAME': 'cltbld', 23:21:44 INFO - 'MAIL': '/var/mail/cltbld', 23:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:44 INFO - 'MOZ_NO_REMOTE': '1', 23:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:44 INFO - 'NO_EM_RESTART': '1', 23:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:44 INFO - 'PWD': '/builds/slave/test', 23:21:44 INFO - 'SHELL': '/bin/bash', 23:21:44 INFO - 'SHLVL': '1', 23:21:44 INFO - 'TERM': 'linux', 23:21:44 INFO - 'TMOUT': '86400', 23:21:44 INFO - 'USER': 'cltbld', 23:21:44 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:44 INFO - '_': '/tools/buildbot/bin/python'} 23:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:21:44 INFO - Running setup.py (path:/tmp/pip-7ERPm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:21:44 INFO - Running setup.py (path:/tmp/pip-Nx15B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:21:44 INFO - Running setup.py (path:/tmp/pip-pkgTcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:21:44 INFO - Running setup.py (path:/tmp/pip-FmcSn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:21:44 INFO - Running setup.py (path:/tmp/pip-vMv7Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:21:45 INFO - Running setup.py (path:/tmp/pip-tLDZ4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:21:45 INFO - Running setup.py (path:/tmp/pip-4etsWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:21:45 INFO - Running setup.py (path:/tmp/pip-Qs3aPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:21:45 INFO - Running setup.py (path:/tmp/pip-cb6vRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:21:45 INFO - Running setup.py (path:/tmp/pip-naOoPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:21:45 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:21:45 INFO - Running setup.py (path:/tmp/pip-od1yWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:21:45 INFO - Running setup.py (path:/tmp/pip-NNl1BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:21:45 INFO - Running setup.py (path:/tmp/pip-dXgjSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:21:45 INFO - Running setup.py (path:/tmp/pip-IIhHfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:45 INFO - Running setup.py (path:/tmp/pip-CyxHdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:21:45 INFO - Running setup.py (path:/tmp/pip-7mhMlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:21:45 INFO - Running setup.py (path:/tmp/pip-KIMK3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:21:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:47 INFO - Downloading blessings-1.6.tar.gz 23:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:21:47 INFO - Installing collected packages: blessings 23:21:47 INFO - Running setup.py install for blessings 23:21:47 INFO - Successfully installed blessings 23:21:47 INFO - Cleaning up... 23:21:48 INFO - Return code: 0 23:21:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:21:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:21:48 INFO - Reading from file tmpfile_stdout 23:21:48 INFO - Current package versions: 23:21:48 INFO - argparse == 1.2.1 23:21:48 INFO - blessings == 1.6 23:21:48 INFO - blobuploader == 1.2.4 23:21:48 INFO - docopt == 0.6.1 23:21:48 INFO - functools32 == 3.2.3-2 23:21:48 INFO - jsonschema == 2.5.1 23:21:48 INFO - manifestparser == 1.1 23:21:48 INFO - mozInstall == 1.12 23:21:48 INFO - mozcrash == 0.17 23:21:48 INFO - mozdebug == 0.1 23:21:48 INFO - mozdevice == 0.48 23:21:48 INFO - mozfile == 1.2 23:21:48 INFO - mozhttpd == 0.7 23:21:48 INFO - mozinfo == 0.9 23:21:48 INFO - mozleak == 0.1 23:21:48 INFO - mozlog == 3.2 23:21:48 INFO - moznetwork == 0.27 23:21:48 INFO - mozprocess == 0.23 23:21:48 INFO - mozprofile == 0.28 23:21:48 INFO - mozrunner == 6.12 23:21:48 INFO - mozscreenshot == 0.1 23:21:48 INFO - mozsystemmonitor == 0.3 23:21:48 INFO - moztest == 0.7 23:21:48 INFO - mozversion == 1.4 23:21:48 INFO - psutil == 3.1.1 23:21:48 INFO - requests == 1.2.3 23:21:48 INFO - wsgiref == 0.1.2 23:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 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 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:48 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 23:21:48 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 23:21:48 INFO - Using env: {'DISPLAY': ':0', 23:21:48 INFO - 'HOME': '/home/cltbld', 23:21:48 INFO - 'LANG': 'en_US.UTF-8', 23:21:48 INFO - 'LANGUAGE': 'en_US:en', 23:21:48 INFO - 'LOGNAME': 'cltbld', 23:21:48 INFO - 'MAIL': '/var/mail/cltbld', 23:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:48 INFO - 'MOZ_NO_REMOTE': '1', 23:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:48 INFO - 'NO_EM_RESTART': '1', 23:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:48 INFO - 'PWD': '/builds/slave/test', 23:21:48 INFO - 'SHELL': '/bin/bash', 23:21:48 INFO - 'SHLVL': '1', 23:21:48 INFO - 'TERM': 'linux', 23:21:48 INFO - 'TMOUT': '86400', 23:21:48 INFO - 'USER': 'cltbld', 23:21:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:48 INFO - '_': '/tools/buildbot/bin/python'} 23:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:21:48 INFO - Cleaning up... 23:21:48 INFO - Return code: 0 23:21:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:21:48 INFO - Using env: {'DISPLAY': ':0', 23:21:48 INFO - 'HOME': '/home/cltbld', 23:21:48 INFO - 'LANG': 'en_US.UTF-8', 23:21:48 INFO - 'LANGUAGE': 'en_US:en', 23:21:48 INFO - 'LOGNAME': 'cltbld', 23:21:48 INFO - 'MAIL': '/var/mail/cltbld', 23:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:48 INFO - 'MOZ_NO_REMOTE': '1', 23:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:48 INFO - 'NO_EM_RESTART': '1', 23:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:48 INFO - 'PWD': '/builds/slave/test', 23:21:48 INFO - 'SHELL': '/bin/bash', 23:21:48 INFO - 'SHLVL': '1', 23:21:48 INFO - 'TERM': 'linux', 23:21:48 INFO - 'TMOUT': '86400', 23:21:48 INFO - 'USER': 'cltbld', 23:21:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:48 INFO - '_': '/tools/buildbot/bin/python'} 23:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:21:48 INFO - Cleaning up... 23:21:48 INFO - Return code: 0 23:21:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:21:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe560d32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e70020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', '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 23:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:21:48 INFO - Using env: {'DISPLAY': ':0', 23:21:48 INFO - 'HOME': '/home/cltbld', 23:21:48 INFO - 'LANG': 'en_US.UTF-8', 23:21:48 INFO - 'LANGUAGE': 'en_US:en', 23:21:48 INFO - 'LOGNAME': 'cltbld', 23:21:48 INFO - 'MAIL': '/var/mail/cltbld', 23:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:21:48 INFO - 'MOZ_NO_REMOTE': '1', 23:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:21:48 INFO - 'NO_EM_RESTART': '1', 23:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:21:48 INFO - 'PWD': '/builds/slave/test', 23:21:48 INFO - 'SHELL': '/bin/bash', 23:21:48 INFO - 'SHLVL': '1', 23:21:48 INFO - 'TERM': 'linux', 23:21:48 INFO - 'TMOUT': '86400', 23:21:48 INFO - 'USER': 'cltbld', 23:21:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:21:48 INFO - '_': '/tools/buildbot/bin/python'} 23:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:21:48 INFO - Downloading/unpacking flake8 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:21:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:21:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:21:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 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 23:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:21:51 INFO - no previously-included directories found matching 'docs/_build' 23:21:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:21:51 INFO - Running setup.py install for pep8 23:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:21:51 INFO - no previously-included directories found matching 'docs/_build' 23:21:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:21:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:21:51 INFO - Cleaning up... 23:21:51 INFO - Return code: 0 23:21:51 INFO - Running post-action listener: _resource_record_post_action 23:21:51 INFO - Running post-action listener: _start_resource_monitoring 23:21:51 INFO - Starting resource monitoring. 23:21:51 INFO - ##### 23:21:51 INFO - ##### Finished create-virtualenv step (success) 23:21:51 INFO - ##### 23:21:51 INFO - ##### 23:21:51 INFO - ##### Running install step. 23:21:51 INFO - ##### 23:21:51 INFO - Running pre-action listener: _resource_record_pre_action 23:21:51 INFO - Running main action method: install 23:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:21:52 INFO - Reading from file tmpfile_stdout 23:21:52 INFO - Detecting whether we're running mozinstall >=1.0... 23:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:21:52 INFO - Reading from file tmpfile_stdout 23:21:52 INFO - Output received: 23:21:52 INFO - Usage: mozinstall [options] installer 23:21:52 INFO - Options: 23:21:52 INFO - -h, --help show this help message and exit 23:21:52 INFO - -d DEST, --destination=DEST 23:21:52 INFO - Directory to install application into. [default: 23:21:52 INFO - "/builds/slave/test"] 23:21:52 INFO - --app=APP Application being installed. [default: firefox] 23:21:52 INFO - mkdir: /builds/slave/test/build/application 23:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:22:07 INFO - Reading from file tmpfile_stdout 23:22:07 INFO - Output received: 23:22:07 INFO - /builds/slave/test/build/application/firefox/firefox 23:22:07 INFO - Running post-action listener: _resource_record_post_action 23:22:07 INFO - ##### 23:22:07 INFO - ##### Finished install step (success) 23:22:07 INFO - ##### 23:22:07 INFO - ##### 23:22:07 INFO - ##### Running run-tests step. 23:22:07 INFO - ##### 23:22:07 INFO - Running pre-action listener: _resource_record_pre_action 23:22:07 INFO - Running main action method: run_tests 23:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:22:07 INFO - Python 2.7.3 23:22:07 INFO - Return code: 0 23:22:07 INFO - grabbing minidump binary from tooltool 23:22: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')]} 23:22:07 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 0x1f022e0>, '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 0x1e6e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:22:07 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 23:22:07 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 23:22:07 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 23:22:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:22:08 INFO - Return code: 0 23:22:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:22:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:22:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:22:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:22:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:22:08 INFO - Return code: 0 23:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 23:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 23:22:08 INFO - Using env: {'DISPLAY': ':0', 23:22:08 INFO - 'HOME': '/home/cltbld', 23:22:08 INFO - 'LANG': 'en_US.UTF-8', 23:22:08 INFO - 'LANGUAGE': 'en_US:en', 23:22:08 INFO - 'LOGNAME': 'cltbld', 23:22:08 INFO - 'MAIL': '/var/mail/cltbld', 23:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:08 INFO - 'MOZ_NO_REMOTE': '1', 23:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:08 INFO - 'NO_EM_RESTART': '1', 23:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:08 INFO - 'PWD': '/builds/slave/test', 23:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:22:08 INFO - 'SHELL': '/bin/bash', 23:22:08 INFO - 'SHLVL': '1', 23:22:08 INFO - 'TERM': 'linux', 23:22:08 INFO - 'TMOUT': '86400', 23:22:08 INFO - 'USER': 'cltbld', 23:22:08 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708', 23:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:08 INFO - '_': '/tools/buildbot/bin/python'} 23:22:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 23:22:09 INFO - mozversion application_buildid: 20160727204328 23:22:09 INFO - mozversion application_changeset: 5d074cab0660484773df4e366149a97f2ff21be5 23:22:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:22:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:22:09 INFO - mozversion application_name: Firefox 23:22:09 INFO - mozversion application_remotingname: firefox-dev 23:22:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:22:09 INFO - mozversion application_vendor: Mozilla 23:22:09 INFO - mozversion application_version: 49.0a2 23:22:09 INFO - mozversion platform_buildid: 20160727204328 23:22:09 INFO - mozversion platform_changeset: 5d074cab0660484773df4e366149a97f2ff21be5 23:22:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:22:09 INFO - mozversion platform_version: 49.0a2 23:22:09 INFO - using testdate: 1469686929 23:22:09 INFO - actual date: 1469686929 23:22:09 INFO - starting webserver on 'localhost:55881' 23:22:09 INFO - SUITE-START | Running 2 tests 23:22:09 INFO - TEST-START | dromaeo_css 23:22:09 INFO - operating with platform_type : linux_ 23:22:09 INFO - Initialising browser for dromaeo_css test... 23:22:09 INFO - TEST-INFO | started process 5973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCDhX1/profile http://localhost:55881/getInfo.html) 23:22:13 INFO - PROCESS | 5973 | __metrics Screen width/height:1600/1200 23:22:13 INFO - PROCESS | 5973 | colorDepth:24 23:22:13 INFO - PROCESS | 5973 | Browser inner width/height: 1024/697 23:22:13 INFO - PROCESS | 5973 | __metrics 23:22:14 ERROR - PROCESS | 5973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:22:15 INFO - TEST-INFO | 5973: exit 0 23:22:15 INFO - Browser initialized. 23:22:15 INFO - Running cycle 1/1 for dromaeo_css test... 23:22:15 INFO - TEST-INFO | started process 6102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphCDhX1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:27 INFO - PROCESS | 6102 | RSS: Main: 156225536 23:22:27 INFO - PROCESS | 6102 | 23:23:16 INFO - PROCESS | 6102 | 1469686996607 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] 23:25:24 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55881/tests/dromaeo/cssquery-ext.html) 23:25:25 INFO - PROCESS | 6102 | RSS: Main: 159993856 23:25:25 INFO - PROCESS | 6102 | 23:28:27 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-ext.html (next: http://localhost:55881/tests/dromaeo/cssquery-jquery.html) 23:28:28 INFO - PROCESS | 6102 | RSS: Main: 157536256 23:28:28 INFO - PROCESS | 6102 | 23:31:29 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55881/tests/dromaeo/cssquery-mootools.html) 23:31:30 INFO - PROCESS | 6102 | RSS: Main: 157691904 23:31:30 INFO - PROCESS | 6102 | 23:34:32 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55881/tests/dromaeo/cssquery-prototype.html) 23:34:32 INFO - PROCESS | 6102 | RSS: Main: 156573696 23:34:32 INFO - PROCESS | 6102 | 23:37:35 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55881/tests/dromaeo/cssquery-yui.html) 23:37:35 INFO - PROCESS | 6102 | RSS: Main: 159277056 23:37:35 INFO - PROCESS | 6102 | 23:40:37 INFO - PROCESS | 6102 | Cycle 1(1): loaded http://localhost:55881/tests/dromaeo/cssquery-yui.html (next: http://localhost:55881/tests/dromaeo/cssquery-dojo.html) 23:40:38 INFO - PROCESS | 6102 | RSS: Main: 159416320 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | __start_tp_report 23:40:38 INFO - PROCESS | 6102 | _x_x_mozilla_page_load 23:40:38 INFO - PROCESS | 6102 | _x_x_mozilla_page_load_details 23:40:38 INFO - PROCESS | 6102 | |i|pagename|runs| 23:40:38 INFO - PROCESS | 6102 | |0;dojo.html;3332.566766320378;3368.1242876852025;3376.358491886541;3378.0710304666213;3383.171123074847;5465.453454654533;5470.480304371084;5505.449455054492;5530.751116199771;5550.389457159709;5441.401445840955;5544.667319960805;5550.500454959053;5556.6943818089985;5589.74846131924;5018.322526458936;5059.974700126512;5100.5154510321645;5127.051495473349;5158.942416804565;5021.046001259749;5027.044861476326;5069.771860266278;5092.108880945838;5156.046131465672;5081.339425874631;5099.898002039957;5103.974480127594;5117.692938423706;5131.204663277179;5076.213186956009;5157.303763991888;5173.611979101583;5193.558547523465;5228.660137091077;4944.8763780905765;4987.576056035241;5085.974570127163;5096.337476128117;5149.150390185615;5407.107827208506;5474.37044739856;5506.724663766836;5510.201020851994;5542.944570554283;5929.555283353766;5958.851028724273;5977.940220597825;5979.701014949279;5985.1022346647915;5790.015697331463;5864.1203819427;5890.764369425217;5975.581709280352;6014.097885317194;5530.281063461724;5575.526080283181;5576.665400076008;5578.86052848678;5606.831795046155;6051.4553690168095;6057.939420605738;6066.211392518944;6069.484093851984;6069.514438844882;5661.886762264731;5777.3933736957015;5814.215080964101;5818.5345172386105;5830.912536311958;5968.134620480093;5991;5991.760329586855;5999.910001349983;5999.970000149971;5867.970660146672;5957.851053723605;5979.6711180884595;5979.880402392015;5988.730507127189;5746.942530574641;5840.5035571976005;5863.706814659336;5896.498797602166;5928.466438020599;4571.314302854598;4573.679842410999;4598.931016034762;4600.769961501912;4623.491415944311;4034.7780872052317;4074.1851629674184;4087.2029954159248;4091.1817636472824;4112.650424713873;5520.779168833282;5631.4087020863035;5740.741666625012;5814.59297849155;5836.474717275466;5912.201852749909;5917.437843404869;5928.496077833346;5936.910946335808;5984.581079324493;5558.221848941152;5606.6636001840025;5770.076787713946;5776.884462310731;5777.133429985452;5092.312537807423;5129.846104616868;5131.050755610224;5135.589152867761;5166.5866730661455;6218.471429928416;6262.467690246289;6287.717052732638;6292.244930608356;6298.244210694746;5799.217105690678;5858.677772722541;5886.793962211302;6020.1270815730595;6021.2473440819895;6222.533310001678;6223.937760622336;6225.564210505221;6230.7819226326865;6254.499640028877;5850.970745146247;5873.4126587340925;5875.471207591338;5876.206712093984;5939.406059394026;5780.855478613068;5853.326867410302;5884.264466941632;5923.111533270044;5977.671228082323;5779.248697669276;5794.391588883106;5794.884102318014;5795.797147099831;5799.3040835100055;5733.684647344436;5757.827265182052;5791.913121303268;5811.883762324815;5814.244148260699;5486.6982315973;5577.024020796425;5605.215269862304;5614.017546929189;5673.205751194753;5800.9419905800405;5825.0679891217205;5855.824325270249;5864.794732184353;5873.500752436091;5602.4957753802355;5726.627769194989;5731.398203188605;5732.914006289992;5736.4550367715 23:40:38 INFO - PROCESS | 6102 | |1;ext.html;599.1252770954407;654.417568364156;657.8618490117078;659.7756762700681;671.100725028462;44336.778316108415;45457.545424545744;45820.77089614556;45891.541084589146;49363.50636493634;46942.53057469424;47118.76440617801;47358.57924262269;47381;47531.524684753145;9171.082891710825;9192.126747958933;9234.953825230865;9284.721458356227;9304.395214311047;9065.04816994216;9116.8632470513;9146.039665835091;9157.267418606496;9176.954115229415;9261.981182069967;9281.839770028746;9317.068293170696;9331.53342332884;9350.298727595458;9231.123043310909;9258;9274.44353338802;9278.72163835086;9279.21126704231;9093.681721139794;9120.635174593008;9151;9159.542022898828;9163.862542061874;43495.13009739787;43834;43977.78011109956;44006.55993440057;44015.77992110019;3599.4600809878466;3941.1526521797664;3941.2905676978135;4008.098177909976;4148.896277593054;33672;34272.82863585691;34367.6563234367;34535.82732086324;34695.653043469494;4700.660765490587;4807.254875494269;4857.028594281158;4858.29554714568;4930.087933732271;343669;343858.9999999975;344698;345175;346415;62183;62631.37368626347;62819.6859015702;62841;62939.37060629335;39421.60578394237;40153.19693606112;40420.595794042274;42000.369994450106;42197;19248;19565;19665.410037698894;19672.409827705193;19683.409497715093;14678.706425871424;14704.191269480281;14754.926225368805;14755.55733328002;14802.925985370004;21012.579748405253;21335.46661333448;21409.464763381042;21437.249696260555;21493.57012859734;7288.489805713549;7397.889031664529;7425.868419872168;7462.10454745434;7679.2704693054075;999.3054826895238;1048.0619845238468;1071.6372676220963;1101.7961677089763;1188.8335633011386;33001.17497062545;33071.33857322888;33137.83431082829;33335;33676.83161584225;1131.2759833706434;1173.2608456672242;1194.9283043017447;1196.8204769284503;1227.9079069069855;15805;16578.75131872999;16864.57838554046;16871;16882.831171688125;572399;575619;621203;622109;623916;57733.42266577281;63349;63431.365686343466;63494.36505634977;63649;1529.45704274983;1549.403479660339;1552.4100841680315;1553.122485795522;1561.3130222701975;32787.67212327846;33467.83266083654;33645.83177084099;33863.028969855346;34214.82892585521;55828.441715582325;56590.7170464145;56624.433755661914;56705.71647141738;56744;512358;516041;520763;522294;523476;30583.23541911381;30799;31589.52615710812;31835.363292733553;33021.83489082539;51419.48580514147;52250.477495224564;52988.73505632447;53565.732171338896;53736;43693.12613747771;43749;43868.78065609652;44426.777866111755;45904.852378689466;43515.56484435115;43545.56454435415;43873.56126438823;44148;44220.336694950245;43204.56795432005;44307.55692443034;44376;44486.88782780457;44543.33185002163;37456.438153427174;37534.6246537542;37710.24579508449;37727.245455091295;38492;28976.565351520167;29287.828486860286;29963.55054674138;30153.698463015968;30335 23:40:38 INFO - PROCESS | 6102 | |2;jquery.html;397.2491990138637;406.5690368209698;426.8292682926829;426.8719384184744;427.3589615576635;18974;19771.406857794253;20447.897760511176;20532.281370152068;20747.377578672644;18567.81432185678;18829.52926176846;19510.804891951077;19587.216511339528;19597.70603440946;5316.707581083048;5950.79172228972;5983.192269043667;6006.609570377911;6015.368386319439;5659.943400565983;5672;5875.559333050017;5931.703414829263;5943.257092863392;5847.386024467433;5848.356680765112;5848.736806843681;5855.707214639272;5888;5469.945300546983;5748.97125514374;5839.854003649922;5845.357010728816;5849.7660093596205;5527.309086364205;5603.635763675348;5613.382527921925;5666.716664166775;5672.5178359839465;13671.589852304347;13886.583402497941;13984.95112866539;14068.788968165383;14129.78805317921;2381.452265978817;2386.1648423051965;2474.7896428803574;2525.7580511027777;2668.586369112771;9944.900550994469;9983.101520863085;10425.322354046963;13091.738165236737;14477;2028.523297025198;2045.0286114095834;2053.394248696638;2067.1937944201773;2069.244725675133;84627;87256.56371718165;88062.55968720115;90733;91082;9775.169110625535;10290.228232882564;11280.841364417976;11558.826617600742;11621.418929053683;16382.590435238975;16448.424305149263;16455;16466.83533164653;16482.505524834272;8375.916240837514;8687.826243475096;8767.342449316327;8810.20708136258;8877.289816814638;8394.538300393415;8401.95799021001;8480.363972702073;8537.274331681752;8569.528675922884;4745.857624271277;4754.21555443348;4848.393950756155;4910.950890491049;4943.604511639061;2008.7890771469079;2079.0332495389716;2102.684597310385;2133.5946170227608;2150.623640862843;1018.7402212435929;1079.2067830144838;1092.6995076353908;1129.1869853705318;1176.8528933883265;18874.339398121276;19110.140043698066;19224;19538.511537211685;19566.70649940252;1046.9633562825265;1064.4411683866033;1074.333912973961;1091.5088210305394;1121.7083558274744;10360.119389851796;10456.111230545488;10770.56917723298;10916.101449420012;11573.958343749104;511739;515373;543611;556792;566357;101535;103416;103856;104383;105144;1141.7374003979132;1142.9199956003167;1148.5979907032638;1154.5093335332617;1167.772284404533;17413.82586174122;17597.472075837744;17841;17869.195886185415;17956.820431796037;44416.333754994346;44800.77599611981;44959.32561011653;45181.77409113065;45669;50916;54377.72811135919;59624;62518;62699;7423.183449820407;7445.255474452511;8649.56752162402;8804.207621314112;8920.375573710038;13230.66923326886;13804.447822087004;13858.514951976633;13860.653483662585;13886.305684715926;11487.655370338904;11585.07319414428;11587.246828956091;11721.765564688829;11788.587399440978;11266.94366528195;11347.092232621206;11517.42412879336;11779.941100294787;11788.174827761974;11685.649430517098;11818.40907954616;11881.881181188077;12117.757644846877;12184;8642.395032347675;8693.47839129629;8713.52075635846;8815.250703690259;8969.955150224207;8174.141715119827;11075.335479870912;11408.429578521207;11421.428928553705;11472.426378680866 23:40:38 INFO - PROCESS | 6102 | |3;mootools.html;1538.6076550479622;1571.9764203536945;1761.4187318185;1818.154558130469;1862.9534261643466;7942.285194332523;8633.48199108053;8698.130186981298;9312.115349041847;9322.394044387118;8799.780005499866;8972.8654070189;9018.864717029233;9024;9039.276857851373;2366.0890557135453;2381.4641705616186;2391.2228525729206;2393.86833724146;2399.6040653292184;2373.727021392545;2375.3111597636753;2383.856968581882;2396.18529699902;2400.1839374612628;2361.917332893349;2374.905003799846;2388.199953015742;2417.685700858886;2423.612222044473;2308.3998160478395;2313.144136669426;2322.5587138443725;2336.894839732216;2344.37873963399;2291.576058429196;2292.89681964312;2295.173737454515;2302.873341966191;2303.470201853583;8891.822163556757;8978.281737460988;8982.550872456351;8985.23625491834;9050.094990500964;5060.645754797166;5160.5097515736325;5178.14560597501;5183.5853131749745;5193.63644544882;3434.107132145635;3519.6480351964597;3550.9644903550893;3577.749557530974;3590;1206.234041383719;1213.7147770274066;1262.7663882181826;1269.6698858296818;1270.30133426615;12360.381980900918;12473.875261247453;12497.437615307334;12507.437165327583;12529.122961392706;4460.0633866887665;4601.562851529099;4608.769561521911;4652.278896771006;4670.229412146958;10369.32599381053;10402.843957340647;10421.478926053818;10451.790964180675;10462.058414742709;5145.974270128625;5146.639735218499;5179.352580927384;5208.479152084761;5330.280412144389;4359.411479450297;4757.595604373667;4832.613390928717;4923.064617722621;4930.21116621346;3956.22853543562;3966.2662407454714;3979.403089536535;4077.1845630873945;4088.4071809587444;1242.6458459339044;1253.529926277646;1256.9622911312674;1259.4836117191908;1266.8796464335874;1071.6195750508457;1078.563181911327;1082.1775450657558;1094.4199574225672;1106.6790630717162;6181.81454556364;6407.103005579223;6417.614943103429;6421.1652485177565;6589.0116482528;444.38674629012405;452.3712040264036;461.78757771424847;465.22883628587425;465.95806377425515;4412.0955204183065;4449.3326001100095;4453.977730111329;4467.463904331436;4507.661925355612;10763.515641796137;11041.779164416666;11089.722756931142;11109.722256943642;11148.219624626197;10447.425391603534;10860.185486088574;10861.076808471369;11063.668089957153;11216;8234.217749313926;8314.792130196673;8396.790080248044;8412.579371031425;8418.410711250153;6261.812145635638;6306.274778400542;6379.3301703320485;6423.357664233539;6586.341365863567;10044.899551004688;10201.438920859424;10262.281640285408;10333.793324133625;10389.37663740178;10431.68704938853;10460.68617941463;10516.842247366449;10546.20903432261;10558.102561282378;7349.448791340564;7767.844643106993;7947.205279472007;8044.396670249637;8046.356291496549;8982.191602755522;8996.91003089987;8997.685081022133;9021.594028268875;9100.317476189444;7899.407544434305;8092.635831387484;8133.06469755962;8159.592020398837;8166.918330816853;7566.583837888969;7770.222977702185;7926.682932682628;7941.523508589503;8057.798555035936;6985;7002.579845209304;7076.681549330396;7077.398421134261;7134.536255143399;5031.84904452867;5132.7433628317685;5602.663840169603;5610.7755689773585;5616.129499927518;5584.916226256691;5606.439356064524;5608.971955140199;5665.12190610456;5919.526437885045 23:40:38 INFO - PROCESS | 6102 | |4;prototype.html;349.78138663335415;351.6940261972084;352.0617554218009;353.3145697347145;360.80516521078636;5751.958054890516;5805.912911306334;5831.300243970724;5851.3270973838025;5882.235309409771;5614.9157762633595;5669.291338582677;5689.715514224283;5737.885242295162;5745.971270143654;4308.633766129875;4460.353248778925;4463.620592249663;4470.687051906368;4502.883644686992;4424.491183513889;4470.843520476784;4478.104379124188;4479.037007043485;4480.215962206617;4388.100439409929;4456.799444025027;4482.529334419888;4501.099780043988;4519;4401.735895846244;4459.665525085616;4459.955400446019;4483.260262056757;4483.730976141442;3931.3709806430834;3940.9014774630577;3943.7830919299427;3947.7631342119566;3954.980225098856;5515.283013208257;5550.77796888124;5590.664560126364;5596.188552659883;5612.943870561283;5002.549770520634;5072.137736584789;5074.035933172685;5074.974625126851;5109.821156259551;5953.2856057272975;5968.880622387528;5984.251968503937;6018.428249316352;6037.366076561942;4298.699091063627;4304.160688665712;4321.870343889688;4321.891952701176;4325.697201195886;5956.851078723023;6049.455549000611;6223.439890409885;6227;6233.376662333731;4355.346697995326;4359.607635312837;4373.671974601854;4391.099824535962;4410.6030457259;4411.845585404495;4428.734275943454;4430.291153415503;4446.244138496463;4456.086502267028;4903.705777653352;5033.597312215014;5075.365579302587;5100.948990510047;5109.4379618241965;5983.521318294526;5991.760329586855;6022;6043.36544662804;6061.363431873369;1499.167961781222;1510.9848901511064;1512.1305249481593;1513.1526345246477;1517.1124891938118;959.510649568725;985.7929834734786;994.5027486256871;994.8607194992707;1001.2190491416707;5203.84388468339;5246.711430871263;5289.619671147999;5353.57171426285;5358.2498450217;5409.972950135224;5481.123020316731;5551.084875717871;5554.944450555524;5555.583331250173;4989.877277612581;5128.79484820603;5295.788168473295;5310.362756469249;5313.256144139824;2926.619539459899;2954.3943491584173;2957.689442608495;2983.4033193361415;2996.9100926972224;5677.290338707661;5683.431656834367;5687.146927960756;5756;5770.769169233184;5797.797077102281;6328.6835658216905;6354.618722876642;6359.777407790705;6381.489480841522;6361.809145725636;6418.967905160444;6429.742810287629;6509.349065093453;6529.836754081091;6049.425304596057;6280.811575652738;6281.623102613858;6281.811545653638;6304.621722696653;5955.731992060281;6149.323574406722;6150.846228844136;6164.6745949621045;6176.3514830943905;6429.913641452035;6436.742530298923;6452.419282264619;6483.708233129615;6497.31778163305;4326.718763280503;4362.94941377552;4366.978165109154;4402.7358358498595;4409.40473036136;6149.723262453111;6161.969190154021;6224.221972253468;6227.813165605039;6301.747930082745;6014.578979471395;6067.878642427038;6070.514358851193;6081.239845019372;6098.140067279523;5932.940670593239;5945.821625351246;6041.6375017499095;6053.818385448443;6106.755729770759;5811.651300921789;5879.353271140257;5907.17299578068;5945.197398351167;5971.7611295547695;5946.405359464019;5977.6114552553945;6009.278886533644;6015.135308054517;6025.403268134036;5671.461211184931;5913.5564832636865;5919.319278283053;5922;5971.970140149271 23:40:38 INFO - PROCESS | 6102 | |5;yui.html;703.2756261051119;762.774981380493;788.3141666749929;845.3642202338475;845.9848182181383;14553.708925821476;15184.316705748226;15252.313645885934;15360.231988400577;15439.69120617587;14437.855621443783;14465.059771114897;14480.493182738606;14506.129632222073;14515.201663908507;723.724984505887;854.8204876975842;857.8327226190879;880.053942012336;882.1090698394636;873.9694110706126;875.2604049578097;875.3128793896792;879.4283715584857;883.041899539001;934.3552948465571;935.2938531408777;938.5541867612898;938.8873335199786;939.3565407695717;926.5691453474133;927.8515437529962;931.729798358482;932.6595792535743;933.7385532051003;676.1548064918851;679.0628932073756;681.2302098628518;682.4676752133344;685.9142607174103;13850;13905.235212063333;13921.30393480332;13947.721045579134;14009.08940918837;14883.627909302246;15121.773173402407;15147.394104235816;15232;15296.235188240544;12742.554010609676;13146.802797958038;13208.933955330258;13211.33943302831;13401.46394144233;4157.225987403574;4166.833286679735;4186.120914607936;4203.348480985452;4306.289462238727;67370.3262967369;69906.30093698998;70462;74664;75002.62498687471;12334.136610437363;12581.496740130475;12787.040971927143;12825.935870320589;12835.294058826667;21160.78839211619;22565;22584.435389115402;22654.207102751654;22716;8758.474491530402;8967.10328967098;9005.549722513848;9031.458112513139;9244.953775231215;5087.26234695967;5156.8968620627375;5158.587313014949;5177.559907407837;5209.270702101709;3672.6143754905884;3779.4519794630173;3780.243951209769;3781.243751249761;3781.773093614392;687.7249100359796;691.7475121580587;704.6476761619191;706.0926709178681;711.1572786248312;683.0505597219868;748.5359077372065;769.1308821032197;792.8691765858684;799.1129845871078;9839.852402213972;10318.277720559488;10354.378737275787;10432.113270372103;10519.84220236697;690.8549204667077;731.2906480713806;754.1026178847154;775.7478819383723;792.5244853088101;4762.190427627312;4776.379070720854;4778.832740854054;4796.688215266066;4893.853184404474;110236.448817757;118318;119222.40388798;120640;121505.39247303706;97036;97973.51013244888;100921;103658.48170759098;104794.47602761937;83454.5827270872;90146.54926725324;91422.08577914268;94677.52661236787;95865.52067239759;9861.309708320348;10067.798644027225;10140.594376225163;10250.97490250969;10252.487375631337;49863.501364987336;53643.731781340844;54073.45926540842;54474.18288725593;55414.44585554093;74256;74552.62723686347;75659.24340756521;77215.61392193002;78156.21843781717;13877.722445551235;14288.35702393374;14417.351219194952;14576.635584110058;14596.85403145955;14941.327640256432;14959.401623935357;15277.388904443698;15932.283047262668;16352.754708679617;14599.270036498345;14611.123332600078;14842.554723358317;15162.924185379003;15222.923885380502;13786.93106534501;15028.849711502746;15083.924580377028;15183.772243416579;15357.846421535642;13727.862721372658;14813.333399997242;14860.554183374516;15210.695786083996;15355.385784568938;10839.67480975572;11424.807729449578;11512.769744604893;11672.883271167519;11848.407579621156;11448.828267575826;11702.590409335633;11966.22219555726;12109.636710898687;12147.635570932885 23:40:38 INFO - PROCESS | 6102 | __end_tp_report 23:40:38 INFO - PROCESS | 6102 | __start_cc_report 23:40:38 INFO - PROCESS | 6102 | _x_x_mozilla_cycle_collect,363 23:40:38 INFO - PROCESS | 6102 | __end_cc_report 23:40:38 INFO - PROCESS | 6102 | __startTimestamp1469688038162__endTimestamp 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | ------- Summary: start ------- 23:40:38 INFO - PROCESS | 6102 | Number of tests: 6 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#0] dojo.html Cycles:165 Average:5531.20 Median:5746.94 stddev:603.65 (10.5%) stddev-sans-first:580.33 23:40:38 INFO - PROCESS | 6102 | Values: 3332.6 3368.1 3376.4 3378.1 3383.2 5465.5 5470.5 5505.4 5530.8 5550.4 5441.4 5544.7 5550.5 5556.7 5589.7 5018.3 5060.0 5100.5 5127.1 5158.9 5021.0 5027.0 5069.8 5092.1 5156.0 5081.3 5099.9 5104.0 5117.7 5131.2 5076.2 5157.3 5173.6 5193.6 5228.7 4944.9 4987.6 5086.0 5096.3 5149.2 5407.1 5474.4 5506.7 5510.2 5542.9 5929.6 5958.9 5977.9 5979.7 5985.1 5790.0 5864.1 5890.8 5975.6 6014.1 5530.3 5575.5 5576.7 5578.9 5606.8 6051.5 6057.9 6066.2 6069.5 6069.5 5661.9 5777.4 5814.2 5818.5 5830.9 5968.1 5991.0 5991.8 5999.9 6000.0 5868.0 5957.9 5979.7 5979.9 5988.7 5746.9 5840.5 5863.7 5896.5 5928.5 4571.3 4573.7 4598.9 4600.8 4623.5 4034.8 4074.2 4087.2 4091.2 4112.7 5520.8 5631.4 5740.7 5814.6 5836.5 5912.2 5917.4 5928.5 5936.9 5984.6 5558.2 5606.7 5770.1 5776.9 5777.1 5092.3 5129.8 5131.1 5135.6 5166.6 6218.5 6262.5 6287.7 6292.2 6298.2 5799.2 5858.7 5886.8 6020.1 6021.2 6222.5 6223.9 6225.6 6230.8 6254.5 5851.0 5873.4 5875.5 5876.2 5939.4 5780.9 5853.3 5884.3 5923.1 5977.7 5779.2 5794.4 5794.9 5795.8 5799.3 5733.7 5757.8 5791.9 5811.9 5814.2 5486.7 5577.0 5605.2 5614.0 5673.2 5800.9 5825.1 5855.8 5864.8 5873.5 5602.5 5726.6 5731.4 5732.9 5736.5 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#1] ext.html Cycles:180 Average:65301.72 Median:44081.89 stddev:133195.02 (302.2%) stddev-sans-first:133480.08 23:40:38 INFO - PROCESS | 6102 | Values: 599.1 654.4 657.9 659.8 671.1 44336.8 45457.5 45820.8 45891.5 49363.5 46942.5 47118.8 47358.6 47381.0 47531.5 9171.1 9192.1 9235.0 9284.7 9304.4 9065.0 9116.9 9146.0 9157.3 9177.0 9262.0 9281.8 9317.1 9331.5 9350.3 9231.1 9258.0 9274.4 9278.7 9279.2 9093.7 9120.6 9151.0 9159.5 9163.9 43495.1 43834.0 43977.8 44006.6 44015.8 3599.5 3941.2 3941.3 4008.1 4148.9 33672.0 34272.8 34367.7 34535.8 34695.7 4700.7 4807.3 4857.0 4858.3 4930.1 343669.0 343859.0 344698.0 345175.0 346415.0 62183.0 62631.4 62819.7 62841.0 62939.4 39421.6 40153.2 40420.6 42000.4 42197.0 19248.0 19565.0 19665.4 19672.4 19683.4 14678.7 14704.2 14754.9 14755.6 14802.9 21012.6 21335.5 21409.5 21437.2 21493.6 7288.5 7397.9 7425.9 7462.1 7679.3 999.3 1048.1 1071.6 1101.8 1188.8 33001.2 33071.3 33137.8 33335.0 33676.8 1131.3 1173.3 1194.9 1196.8 1227.9 15805.0 16578.8 16864.6 16871.0 16882.8 572399.0 575619.0 621203.0 622109.0 623916.0 57733.4 63349.0 63431.4 63494.4 63649.0 1529.5 1549.4 1552.4 1553.1 1561.3 32787.7 33467.8 33645.8 33863.0 34214.8 55828.4 56590.7 56624.4 56705.7 56744.0 512358.0 516041.0 520763.0 522294.0 523476.0 30583.2 30799.0 31589.5 31835.4 33021.8 51419.5 52250.5 52988.7 53565.7 53736.0 43693.1 43749.0 43868.8 44426.8 45904.9 43515.6 43545.6 43873.6 44148.0 44220.3 43204.6 44307.6 44376.0 44486.9 44543.3 37456.4 37534.6 37710.2 37727.2 38492.0 28976.6 29287.8 29963.6 30153.7 30335.0 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#2] jquery.html Cycles:180 Average:30880.63 Median:11408.31 stddev:89054.13 (780.6%) stddev-sans-first:89274.54 23:40:38 INFO - PROCESS | 6102 | Values: 397.2 406.6 426.8 426.9 427.4 18974.0 19771.4 20447.9 20532.3 20747.4 18567.8 18829.5 19510.8 19587.2 19597.7 5316.7 5950.8 5983.2 6006.6 6015.4 5659.9 5672.0 5875.6 5931.7 5943.3 5847.4 5848.4 5848.7 5855.7 5888.0 5469.9 5749.0 5839.9 5845.4 5849.8 5527.3 5603.6 5613.4 5666.7 5672.5 13671.6 13886.6 13985.0 14068.8 14129.8 2381.5 2386.2 2474.8 2525.8 2668.6 9944.9 9983.1 10425.3 13091.7 14477.0 2028.5 2045.0 2053.4 2067.2 2069.2 84627.0 87256.6 88062.6 90733.0 91082.0 9775.2 10290.2 11280.8 11558.8 11621.4 16382.6 16448.4 16455.0 16466.8 16482.5 8375.9 8687.8 8767.3 8810.2 8877.3 8394.5 8402.0 8480.4 8537.3 8569.5 4745.9 4754.2 4848.4 4911.0 4943.6 2008.8 2079.0 2102.7 2133.6 2150.6 1018.7 1079.2 1092.7 1129.2 1176.9 18874.3 19110.1 19224.0 19538.5 19566.7 1047.0 1064.4 1074.3 1091.5 1121.7 10360.1 10456.1 10770.6 10916.1 11574.0 511739.0 515373.0 543611.0 556792.0 566357.0 101535.0 103416.0 103856.0 104383.0 105144.0 1141.7 1142.9 1148.6 1154.5 1167.8 17413.8 17597.5 17841.0 17869.2 17956.8 44416.3 44800.8 44959.3 45181.8 45669.0 50916.0 54377.7 59624.0 62518.0 62699.0 7423.2 7445.3 8649.6 8804.2 8920.4 13230.7 13804.4 13858.5 13860.7 13886.3 11487.7 11585.1 11587.2 11721.8 11788.6 11266.9 11347.1 11517.4 11779.9 11788.2 11685.6 11818.4 11881.9 12117.8 12184.0 8642.4 8693.5 8713.5 8815.3 8970.0 8174.1 11075.3 11408.4 11421.4 11472.4 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#3] mootools.html Cycles:180 Average:5934.33 Median:4463.76 stddev:3361.94 (75.3%) stddev-sans-first:3355.14 23:40:38 INFO - PROCESS | 6102 | Values: 1538.6 1572.0 1761.4 1818.2 1863.0 7942.3 8633.5 8698.1 9312.1 9322.4 8799.8 8972.9 9018.9 9024.0 9039.3 2366.1 2381.5 2391.2 2393.9 2399.6 2373.7 2375.3 2383.9 2396.2 2400.2 2361.9 2374.9 2388.2 2417.7 2423.6 2308.4 2313.1 2322.6 2336.9 2344.4 2291.6 2292.9 2295.2 2302.9 2303.5 8891.8 8978.3 8982.6 8985.2 9050.1 5060.6 5160.5 5178.1 5183.6 5193.6 3434.1 3519.6 3551.0 3577.7 3590.0 1206.2 1213.7 1262.8 1269.7 1270.3 12360.4 12473.9 12497.4 12507.4 12529.1 4460.1 4601.6 4608.8 4652.3 4670.2 10369.3 10402.8 10421.5 10451.8 10462.1 5146.0 5146.6 5179.4 5208.5 5330.3 4359.4 4757.6 4832.6 4923.1 4930.2 3956.2 3966.3 3979.4 4077.2 4088.4 1242.6 1253.5 1257.0 1259.5 1266.9 1071.6 1078.6 1082.2 1094.4 1106.7 6181.8 6407.1 6417.6 6421.2 6589.0 444.4 452.4 461.8 465.2 466.0 4412.1 4449.3 4454.0 4467.5 4507.7 10763.5 11041.8 11089.7 11109.7 11148.2 10447.4 10860.2 10861.1 11063.7 11216.0 8234.2 8314.8 8396.8 8412.6 8418.4 6261.8 6306.3 6379.3 6423.4 6586.3 10044.9 10201.4 10262.3 10333.8 10389.4 10431.7 10460.7 10516.8 10546.2 10558.1 7349.4 7767.8 7947.2 8044.4 8046.4 8982.2 8996.9 8997.7 9021.6 9100.3 7899.4 8092.6 8133.1 8159.6 8166.9 7566.6 7770.2 7926.7 7941.5 8057.8 6985.0 7002.6 7076.7 7077.4 7134.5 5031.8 5132.7 5602.7 5610.8 5616.1 5584.9 5606.4 5609.0 5665.1 5919.5 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#4] prototype.html Cycles:180 Average:4993.23 Median:5613.93 stddev:1481.10 (26.4%) stddev-sans-first:1443.67 23:40:38 INFO - PROCESS | 6102 | Values: 349.8 351.7 352.1 353.3 360.8 5752.0 5805.9 5831.3 5851.3 5882.2 5614.9 5669.3 5689.7 5737.9 5746.0 4308.6 4460.4 4463.6 4470.7 4502.9 4424.5 4470.8 4478.1 4479.0 4480.2 4388.1 4456.8 4482.5 4501.1 4519.0 4401.7 4459.7 4460.0 4483.3 4483.7 3931.4 3940.9 3943.8 3947.8 3955.0 5515.3 5550.8 5590.7 5596.2 5612.9 5002.5 5072.1 5074.0 5075.0 5109.8 5953.3 5968.9 5984.3 6018.4 6037.4 4298.7 4304.2 4321.9 4321.9 4325.7 5956.9 6049.5 6223.4 6227.0 6233.4 4355.3 4359.6 4373.7 4391.1 4410.6 4411.8 4428.7 4430.3 4446.2 4456.1 4903.7 5033.6 5075.4 5100.9 5109.4 5983.5 5991.8 6022.0 6043.4 6061.4 1499.2 1511.0 1512.1 1513.2 1517.1 959.5 985.8 994.5 994.9 1001.2 5203.8 5246.7 5289.6 5353.6 5358.2 5410.0 5481.1 5551.1 5554.9 5555.6 4989.9 5128.8 5295.8 5310.4 5313.3 2926.6 2954.4 2957.7 2983.4 2996.9 5677.3 5683.4 5687.1 5756.0 5770.8 5797.8 6328.7 6354.6 6359.8 6381.5 6361.8 6419.0 6429.7 6509.3 6529.8 6049.4 6280.8 6281.6 6281.8 6304.6 5955.7 6149.3 6150.8 6164.7 6176.4 6429.9 6436.7 6452.4 6483.7 6497.3 4326.7 4362.9 4367.0 4402.7 4409.4 6149.7 6162.0 6224.2 6227.8 6301.7 6014.6 6067.9 6070.5 6081.2 6098.1 5932.9 5945.8 6041.6 6053.8 6106.8 5811.7 5879.4 5907.2 5945.2 5971.8 5946.4 5977.6 6009.3 6015.1 6025.4 5671.5 5913.6 5919.3 5922.0 5972.0 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - PROCESS | 6102 | [#5] yui.html Cycles:180 Average:21392.02 Median:3969.50 stddev:30443.13 (766.9%) stddev-sans-first:30488.90 23:40:38 INFO - PROCESS | 6102 | Values: 703.3 762.8 788.3 845.4 846.0 14553.7 15184.3 15252.3 15360.2 15439.7 14437.9 14465.1 14480.5 14506.1 14515.2 723.7 854.8 857.8 880.1 882.1 874.0 875.3 875.3 879.4 883.0 934.4 935.3 938.6 938.9 939.4 926.6 927.9 931.7 932.7 933.7 676.2 679.1 681.2 682.5 685.9 13850.0 13905.2 13921.3 13947.7 14009.1 14883.6 15121.8 15147.4 15232.0 15296.2 12742.6 13146.8 13208.9 13211.3 13401.5 4157.2 4166.8 4186.1 4203.3 4306.3 67370.3 69906.3 70462.0 74664.0 75002.6 12334.1 12581.5 12787.0 12825.9 12835.3 21160.8 22565.0 22584.4 22654.2 22716.0 8758.5 8967.1 9005.5 9031.5 9245.0 5087.3 5156.9 5158.6 5177.6 5209.3 3672.6 3779.5 3780.2 3781.2 3781.8 687.7 691.7 704.6 706.1 711.2 683.1 748.5 769.1 792.9 799.1 9839.9 10318.3 10354.4 10432.1 10519.8 690.9 731.3 754.1 775.7 792.5 4762.2 4776.4 4778.8 4796.7 4893.9 110236.4 118318.0 119222.4 120640.0 121505.4 97036.0 97973.5 100921.0 103658.5 104794.5 83454.6 90146.5 91422.1 94677.5 95865.5 9861.3 10067.8 10140.6 10251.0 10252.5 49863.5 53643.7 54073.5 54474.2 55414.4 74256.0 74552.6 75659.2 77215.6 78156.2 13877.7 14288.4 14417.4 14576.6 14596.9 14941.3 14959.4 15277.4 15932.3 16352.8 14599.3 14611.1 14842.6 15162.9 15222.9 13786.9 15028.8 15083.9 15183.8 15357.8 13727.9 14813.3 14860.6 15210.7 15355.4 10839.7 11424.8 11512.8 11672.9 11848.4 11448.8 11702.6 11966.2 12109.6 12147.6 23:40:38 INFO - PROCESS | 6102 | -------- Summary: end -------- 23:40:38 INFO - PROCESS | 6102 | 23:40:38 INFO - TEST-INFO | 6102: exit 0 23:40:38 INFO - TEST-OK | dromaeo_css | took 1109783ms 23:40:38 INFO - TEST-START | kraken 23:40:38 INFO - operating with platform_type : linux_ 23:40:38 INFO - Initialising browser for kraken test... 23:40:38 INFO - TEST-INFO | started process 6347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6KvF7X/profile http://localhost:55881/getInfo.html) 23:40:43 INFO - PROCESS | 6347 | __metrics Screen width/height:1600/1200 23:40:43 INFO - PROCESS | 6347 | colorDepth:24 23:40:43 INFO - PROCESS | 6347 | Browser inner width/height: 1024/697 23:40:43 INFO - PROCESS | 6347 | __metrics 23:40:43 ERROR - PROCESS | 6347 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:40:44 INFO - TEST-INFO | 6347: exit 0 23:40:44 INFO - Browser initialized. 23:40:44 INFO - Running cycle 1/1 for kraken test... 23:40:44 INFO - TEST-INFO | started process 6474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6KvF7X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:56 INFO - PROCESS | 6474 | RSS: Main: 156061696 23:40:56 INFO - PROCESS | 6474 | 23:40:59 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55881/tests/kraken/driver.html?testName=audio-beat-detection) 23:40:59 INFO - PROCESS | 6474 | RSS: Main: 161357824 23:40:59 INFO - PROCESS | 6474 | 23:41:02 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55881/tests/kraken/driver.html?testName=audio-dft) 23:41:03 INFO - PROCESS | 6474 | RSS: Main: 160702464 23:41:03 INFO - PROCESS | 6474 | 23:41:06 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55881/tests/kraken/driver.html?testName=audio-fft) 23:41:06 INFO - PROCESS | 6474 | RSS: Main: 161759232 23:41:06 INFO - PROCESS | 6474 | 23:41:08 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55881/tests/kraken/driver.html?testName=audio-oscillator) 23:41:09 INFO - PROCESS | 6474 | RSS: Main: 161071104 23:41:09 INFO - PROCESS | 6474 | 23:41:11 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:41:12 INFO - PROCESS | 6474 | RSS: Main: 161230848 23:41:12 INFO - PROCESS | 6474 | 23:41:15 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55881/tests/kraken/driver.html?testName=imaging-darkroom) 23:41:15 INFO - PROCESS | 6474 | RSS: Main: 160919552 23:41:15 INFO - PROCESS | 6474 | 23:41:19 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55881/tests/kraken/driver.html?testName=imaging-desaturate) 23:41:20 INFO - PROCESS | 6474 | RSS: Main: 161439744 23:41:20 INFO - PROCESS | 6474 | 23:41:22 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55881/tests/kraken/driver.html?testName=json-parse-financial) 23:41:23 INFO - PROCESS | 6474 | RSS: Main: 160894976 23:41:23 INFO - PROCESS | 6474 | 23:41:24 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:41:25 INFO - PROCESS | 6474 | RSS: Main: 161165312 23:41:25 INFO - PROCESS | 6474 | 23:41:27 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:41:27 INFO - PROCESS | 6474 | RSS: Main: 161341440 23:41:27 INFO - PROCESS | 6474 | 23:41:29 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:41:30 INFO - PROCESS | 6474 | RSS: Main: 161808384 23:41:30 INFO - PROCESS | 6474 | 23:41:33 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:41:33 INFO - PROCESS | 6474 | RSS: Main: 162238464 23:41:33 INFO - PROCESS | 6474 | 23:41:36 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:41:37 INFO - PROCESS | 6474 | RSS: Main: 161886208 23:41:37 INFO - PROCESS | 6474 | 23:41:38 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:55881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55881/tests/kraken/driver.html?testName=ai-astar) 23:41:39 INFO - PROCESS | 6474 | RSS: Main: 162480128 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | __start_tp_report 23:41:39 INFO - PROCESS | 6474 | _x_x_mozilla_page_load 23:41:39 INFO - PROCESS | 6474 | _x_x_mozilla_page_load_details 23:41:39 INFO - PROCESS | 6474 | |i|pagename|runs| 23:41:39 INFO - PROCESS | 6474 | |0;ai-astar;114;106;113;113;110;111;111;113;112;113 23:41:39 INFO - PROCESS | 6474 | |1;audio-beat-detection;161;125;153;189;126;156;151;125;200;123 23:41:39 INFO - PROCESS | 6474 | |2;audio-dft;164;162;161;160;163;163;160;160;163;161 23:41:39 INFO - PROCESS | 6474 | |3;audio-fft;76;76;77;175;75;75;76;75;172;75 23:41:39 INFO - PROCESS | 6474 | |4;audio-oscillator;84;83;154;84;84;83;144;83;84;147 23:41:39 INFO - PROCESS | 6474 | |5;imaging-gaussian-blur;117;119;117;119;118;117;117;118;117;118 23:41:39 INFO - PROCESS | 6474 | |6;imaging-darkroom;146;147;147;147;147;148;146;147;147;148 23:41:39 INFO - PROCESS | 6474 | |7;imaging-desaturate;96;97;95;97;95;98;95;94;95;95 23:41:39 INFO - PROCESS | 6474 | |8;json-parse-financial;54;55;53;51;54;63;51;53;52;53 23:41:39 INFO - PROCESS | 6474 | |9;json-stringify-tinderbox;59;60;59;59;59;58;59;60;60;60 23:41:39 INFO - PROCESS | 6474 | |10;stanford-crypto-aes;77;76;77;76;83;83;78;76;107;75 23:41:39 INFO - PROCESS | 6474 | |11;stanford-crypto-ccm;132;117;117;128;122;125;121;117;132;124 23:41:39 INFO - PROCESS | 6474 | |12;stanford-crypto-pbkdf2;156;157;157;158;156;155;157;156;156;173 23:41:39 INFO - PROCESS | 6474 | |13;stanford-crypto-sha256-iterative;63;64;64;64;66;66;65;62;62;61 23:41:39 INFO - PROCESS | 6474 | __end_tp_report 23:41:39 INFO - PROCESS | 6474 | __start_cc_report 23:41:39 INFO - PROCESS | 6474 | _x_x_mozilla_cycle_collect,898 23:41:39 INFO - PROCESS | 6474 | __end_cc_report 23:41:39 INFO - PROCESS | 6474 | __startTimestamp1469688099055__endTimestamp 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | ------- Summary: start ------- 23:41:39 INFO - PROCESS | 6474 | Number of tests: 14 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:2.29 23:41:39 INFO - PROCESS | 6474 | Values: 114.0 106.0 113.0 113.0 110.0 111.0 111.0 113.0 112.0 113.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.50 stddev:27.36 (17.7%) stddev-sans-first:28.77 23:41:39 INFO - PROCESS | 6474 | Values: 161.0 125.0 153.0 189.0 126.0 156.0 151.0 125.0 200.0 123.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.33 23:41:39 INFO - PROCESS | 6474 | Values: 164.0 162.0 161.0 160.0 163.0 163.0 160.0 160.0 163.0 161.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:41.28 (54.7%) stddev-sans-first:43.19 23:41:39 INFO - PROCESS | 6474 | Values: 76.0 76.0 77.0 175.0 75.0 75.0 76.0 75.0 172.0 75.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.50 stddev:31.38 (37.6%) stddev-sans-first:32.52 23:41:39 INFO - PROCESS | 6474 | Values: 84.0 83.0 154.0 84.0 84.0 83.0 144.0 83.0 84.0 147.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 23:41:39 INFO - PROCESS | 6474 | Values: 117.0 119.0 117.0 119.0 118.0 117.0 117.0 118.0 117.0 118.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 23:41:39 INFO - PROCESS | 6474 | Values: 146.0 147.0 147.0 147.0 147.0 148.0 146.0 147.0 147.0 148.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.25 (1.3%) stddev-sans-first:1.32 23:41:39 INFO - PROCESS | 6474 | Values: 96.0 97.0 95.0 97.0 95.0 98.0 95.0 94.0 95.0 95.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:3.45 (6.4%) stddev-sans-first:3.66 23:41:39 INFO - PROCESS | 6474 | Values: 54.0 55.0 53.0 51.0 54.0 63.0 51.0 53.0 52.0 53.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 23:41:39 INFO - PROCESS | 6474 | Values: 59.0 60.0 59.0 59.0 59.0 58.0 59.0 60.0 60.0 60.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:10.12 23:41:39 INFO - PROCESS | 6474 | Values: 77.0 76.0 77.0 76.0 83.0 83.0 78.0 76.0 107.0 75.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.50 stddev:5.80 (4.7%) stddev-sans-first:5.27 23:41:39 INFO - PROCESS | 6474 | Values: 132.0 117.0 117.0 128.0 122.0 125.0 121.0 117.0 132.0 124.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:157.00 stddev:5.30 (3.4%) stddev-sans-first:5.57 23:41:39 INFO - PROCESS | 6474 | Values: 156.0 157.0 157.0 158.0 156.0 155.0 157.0 156.0 156.0 173.0 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - PROCESS | 6474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 23:41:39 INFO - PROCESS | 6474 | Values: 63.0 64.0 64.0 64.0 66.0 66.0 65.0 62.0 62.0 61.0 23:41:39 INFO - PROCESS | 6474 | -------- Summary: end -------- 23:41:39 INFO - PROCESS | 6474 | 23:41:39 INFO - TEST-INFO | 6474: exit 0 23:41:40 INFO - TEST-OK | kraken | took 61080ms 23:41:40 INFO - SUITE-END | took 1170s 23:41:40 INFO - Completed test suite (00:19:31) 23:41:40 INFO - javascript benchmark 23:41:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7560.334512828938, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.566766320378, 3368.1242876852025, 3376.358491886541, 3378.0710304666213, 3383.171123074847, 5465.453454654533, 5470.480304371084, 5505.449455054492, 5530.751116199771, 5550.389457159709, 5441.401445840955, 5544.667319960805, 5550.500454959053, 5556.6943818089985, 5589.74846131924, 5018.322526458936, 5059.974700126512, 5100.5154510321645, 5127.051495473349, 5158.942416804565, 5021.046001259749, 5027.044861476326, 5069.771860266278, 5092.108880945838, 5156.046131465672, 5081.339425874631, 5099.898002039957, 5103.974480127594, 5117.692938423706, 5131.204663277179, 5076.213186956009, 5157.303763991888, 5173.611979101583, 5193.558547523465, 5228.660137091077, 4944.8763780905765, 4987.576056035241, 5085.974570127163, 5096.337476128117, 5149.150390185615, 5407.107827208506, 5474.37044739856, 5506.724663766836, 5510.201020851994, 5542.944570554283, 5929.555283353766, 5958.851028724273, 5977.940220597825, 5979.701014949279, 5985.1022346647915, 5790.015697331463, 5864.1203819427, 5890.764369425217, 5975.581709280352, 6014.097885317194, 5530.281063461724, 5575.526080283181, 5576.665400076008, 5578.86052848678, 5606.831795046155, 6051.4553690168095, 6057.939420605738, 6066.211392518944, 6069.484093851984, 6069.514438844882, 5661.886762264731, 5777.3933736957015, 5814.215080964101, 5818.5345172386105, 5830.912536311958, 5968.134620480093, 5991.0, 5991.760329586855, 5999.910001349983, 5999.970000149971, 5867.970660146672, 5957.851053723605, 5979.6711180884595, 5979.880402392015, 5988.730507127189, 5746.942530574641, 5840.5035571976005, 5863.706814659336, 5896.498797602166, 5928.466438020599, 4571.314302854598, 4573.679842410999, 4598.931016034762, 4600.769961501912, 4623.491415944311, 4034.7780872052317, 4074.1851629674184, 4087.2029954159248, 4091.1817636472824, 4112.650424713873, 5520.779168833282, 5631.4087020863035, 5740.741666625012, 5814.59297849155, 5836.474717275466, 5912.201852749909, 5917.437843404869, 5928.496077833346, 5936.910946335808, 5984.581079324493, 5558.221848941152, 5606.6636001840025, 5770.076787713946, 5776.884462310731, 5777.133429985452, 5092.312537807423, 5129.846104616868, 5131.050755610224, 5135.589152867761, 5166.5866730661455, 6218.471429928416, 6262.467690246289, 6287.717052732638, 6292.244930608356, 6298.244210694746, 5799.217105690678, 5858.677772722541, 5886.793962211302, 6020.1270815730595, 6021.2473440819895, 6222.533310001678, 6223.937760622336, 6225.564210505221, 6230.7819226326865, 6254.499640028877, 5850.970745146247, 5873.4126587340925, 5875.471207591338, 5876.206712093984, 5939.406059394026, 5780.855478613068, 5853.326867410302, 5884.264466941632, 5923.111533270044, 5977.671228082323, 5779.248697669276, 5794.391588883106, 5794.884102318014, 5795.797147099831, 5799.3040835100055, 5733.684647344436, 5757.827265182052, 5791.913121303268, 5811.883762324815, 5814.244148260699, 5486.6982315973, 5577.024020796425, 5605.215269862304, 5614.017546929189, 5673.205751194753, 5800.9419905800405, 5825.0679891217205, 5855.824325270249, 5864.794732184353, 5873.500752436091, 5602.4957753802355, 5726.627769194989, 5731.398203188605, 5732.914006289992, 5736.4550367715], "value": 5492.788873904348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1252770954407, 654.417568364156, 657.8618490117078, 659.7756762700681, 671.100725028462, 44336.778316108415, 45457.545424545744, 45820.77089614556, 45891.541084589146, 49363.50636493634, 46942.53057469424, 47118.76440617801, 47358.57924262269, 47381.0, 47531.524684753145, 9171.082891710825, 9192.126747958933, 9234.953825230865, 9284.721458356227, 9304.395214311047, 9065.04816994216, 9116.8632470513, 9146.039665835091, 9157.267418606496, 9176.954115229415, 9261.981182069967, 9281.839770028746, 9317.068293170696, 9331.53342332884, 9350.298727595458, 9231.123043310909, 9258.0, 9274.44353338802, 9278.72163835086, 9279.21126704231, 9093.681721139794, 9120.635174593008, 9151.0, 9159.542022898828, 9163.862542061874, 43495.13009739787, 43834.0, 43977.78011109956, 44006.55993440057, 44015.77992110019, 3599.4600809878466, 3941.1526521797664, 3941.2905676978135, 4008.098177909976, 4148.896277593054, 33672.0, 34272.82863585691, 34367.6563234367, 34535.82732086324, 34695.653043469494, 4700.660765490587, 4807.254875494269, 4857.028594281158, 4858.29554714568, 4930.087933732271, 343669.0, 343858.9999999975, 344698.0, 345175.0, 346415.0, 62183.0, 62631.37368626347, 62819.6859015702, 62841.0, 62939.37060629335, 39421.60578394237, 40153.19693606112, 40420.595794042274, 42000.369994450106, 42197.0, 19248.0, 19565.0, 19665.410037698894, 19672.409827705193, 19683.409497715093, 14678.706425871424, 14704.191269480281, 14754.926225368805, 14755.55733328002, 14802.925985370004, 21012.579748405253, 21335.46661333448, 21409.464763381042, 21437.249696260555, 21493.57012859734, 7288.489805713549, 7397.889031664529, 7425.868419872168, 7462.10454745434, 7679.2704693054075, 999.3054826895238, 1048.0619845238468, 1071.6372676220963, 1101.7961677089763, 1188.8335633011386, 33001.17497062545, 33071.33857322888, 33137.83431082829, 33335.0, 33676.83161584225, 1131.2759833706434, 1173.2608456672242, 1194.9283043017447, 1196.8204769284503, 1227.9079069069855, 15805.0, 16578.75131872999, 16864.57838554046, 16871.0, 16882.831171688125, 572399.0, 575619.0, 621203.0, 622109.0, 623916.0, 57733.42266577281, 63349.0, 63431.365686343466, 63494.36505634977, 63649.0, 1529.45704274983, 1549.403479660339, 1552.4100841680315, 1553.122485795522, 1561.3130222701975, 32787.67212327846, 33467.83266083654, 33645.83177084099, 33863.028969855346, 34214.82892585521, 55828.441715582325, 56590.7170464145, 56624.433755661914, 56705.71647141738, 56744.0, 512358.0, 516041.0, 520763.0, 522294.0, 523476.0, 30583.23541911381, 30799.0, 31589.52615710812, 31835.363292733553, 33021.83489082539, 51419.48580514147, 52250.477495224564, 52988.73505632447, 53565.732171338896, 53736.0, 43693.12613747771, 43749.0, 43868.78065609652, 44426.777866111755, 45904.852378689466, 43515.56484435115, 43545.56454435415, 43873.56126438823, 44148.0, 44220.336694950245, 43204.56795432005, 44307.55692443034, 44376.0, 44486.88782780457, 44543.33185002163, 37456.438153427174, 37534.6246537542, 37710.24579508449, 37727.245455091295, 38492.0, 28976.565351520167, 29287.828486860286, 29963.55054674138, 30153.698463015968, 30335.0], "value": 21342.538880073043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.2491990138637, 406.5690368209698, 426.8292682926829, 426.8719384184744, 427.3589615576635, 18974.0, 19771.406857794253, 20447.897760511176, 20532.281370152068, 20747.377578672644, 18567.81432185678, 18829.52926176846, 19510.804891951077, 19587.216511339528, 19597.70603440946, 5316.707581083048, 5950.79172228972, 5983.192269043667, 6006.609570377911, 6015.368386319439, 5659.943400565983, 5672.0, 5875.559333050017, 5931.703414829263, 5943.257092863392, 5847.386024467433, 5848.356680765112, 5848.736806843681, 5855.707214639272, 5888.0, 5469.945300546983, 5748.97125514374, 5839.854003649922, 5845.357010728816, 5849.7660093596205, 5527.309086364205, 5603.635763675348, 5613.382527921925, 5666.716664166775, 5672.5178359839465, 13671.589852304347, 13886.583402497941, 13984.95112866539, 14068.788968165383, 14129.78805317921, 2381.452265978817, 2386.1648423051965, 2474.7896428803574, 2525.7580511027777, 2668.586369112771, 9944.900550994469, 9983.101520863085, 10425.322354046963, 13091.738165236737, 14477.0, 2028.523297025198, 2045.0286114095834, 2053.394248696638, 2067.1937944201773, 2069.244725675133, 84627.0, 87256.56371718165, 88062.55968720115, 90733.0, 91082.0, 9775.169110625535, 10290.228232882564, 11280.841364417976, 11558.826617600742, 11621.418929053683, 16382.590435238975, 16448.424305149263, 16455.0, 16466.83533164653, 16482.505524834272, 8375.916240837514, 8687.826243475096, 8767.342449316327, 8810.20708136258, 8877.289816814638, 8394.538300393415, 8401.95799021001, 8480.363972702073, 8537.274331681752, 8569.528675922884, 4745.857624271277, 4754.21555443348, 4848.393950756155, 4910.950890491049, 4943.604511639061, 2008.7890771469079, 2079.0332495389716, 2102.684597310385, 2133.5946170227608, 2150.623640862843, 1018.7402212435929, 1079.2067830144838, 1092.6995076353908, 1129.1869853705318, 1176.8528933883265, 18874.339398121276, 19110.140043698066, 19224.0, 19538.511537211685, 19566.70649940252, 1046.9633562825265, 1064.4411683866033, 1074.333912973961, 1091.5088210305394, 1121.7083558274744, 10360.119389851796, 10456.111230545488, 10770.56917723298, 10916.101449420012, 11573.958343749104, 511739.0, 515373.0, 543611.0, 556792.0, 566357.0, 101535.0, 103416.0, 103856.0, 104383.0, 105144.0, 1141.7374003979132, 1142.9199956003167, 1148.5979907032638, 1154.5093335332617, 1167.772284404533, 17413.82586174122, 17597.472075837744, 17841.0, 17869.195886185415, 17956.820431796037, 44416.333754994346, 44800.77599611981, 44959.32561011653, 45181.77409113065, 45669.0, 50916.0, 54377.72811135919, 59624.0, 62518.0, 62699.0, 7423.183449820407, 7445.255474452511, 8649.56752162402, 8804.207621314112, 8920.375573710038, 13230.66923326886, 13804.447822087004, 13858.514951976633, 13860.653483662585, 13886.305684715926, 11487.655370338904, 11585.07319414428, 11587.246828956091, 11721.765564688829, 11788.587399440978, 11266.94366528195, 11347.092232621206, 11517.42412879336, 11779.941100294787, 11788.174827761974, 11685.649430517098, 11818.40907954616, 11881.881181188077, 12117.757644846877, 12184.0, 8642.395032347675, 8693.47839129629, 8713.52075635846, 8815.250703690259, 8969.955150224207, 8174.141715119827, 11075.335479870912, 11408.429578521207, 11421.428928553705, 11472.426378680866], "value": 9445.02952639186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.6076550479622, 1571.9764203536945, 1761.4187318185, 1818.154558130469, 1862.9534261643466, 7942.285194332523, 8633.48199108053, 8698.130186981298, 9312.115349041847, 9322.394044387118, 8799.780005499866, 8972.8654070189, 9018.864717029233, 9024.0, 9039.276857851373, 2366.0890557135453, 2381.4641705616186, 2391.2228525729206, 2393.86833724146, 2399.6040653292184, 2373.727021392545, 2375.3111597636753, 2383.856968581882, 2396.18529699902, 2400.1839374612628, 2361.917332893349, 2374.905003799846, 2388.199953015742, 2417.685700858886, 2423.612222044473, 2308.3998160478395, 2313.144136669426, 2322.5587138443725, 2336.894839732216, 2344.37873963399, 2291.576058429196, 2292.89681964312, 2295.173737454515, 2302.873341966191, 2303.470201853583, 8891.822163556757, 8978.281737460988, 8982.550872456351, 8985.23625491834, 9050.094990500964, 5060.645754797166, 5160.5097515736325, 5178.14560597501, 5183.5853131749745, 5193.63644544882, 3434.107132145635, 3519.6480351964597, 3550.9644903550893, 3577.749557530974, 3590.0, 1206.234041383719, 1213.7147770274066, 1262.7663882181826, 1269.6698858296818, 1270.30133426615, 12360.381980900918, 12473.875261247453, 12497.437615307334, 12507.437165327583, 12529.122961392706, 4460.0633866887665, 4601.562851529099, 4608.769561521911, 4652.278896771006, 4670.229412146958, 10369.32599381053, 10402.843957340647, 10421.478926053818, 10451.790964180675, 10462.058414742709, 5145.974270128625, 5146.639735218499, 5179.352580927384, 5208.479152084761, 5330.280412144389, 4359.411479450297, 4757.595604373667, 4832.613390928717, 4923.064617722621, 4930.21116621346, 3956.22853543562, 3966.2662407454714, 3979.403089536535, 4077.1845630873945, 4088.4071809587444, 1242.6458459339044, 1253.529926277646, 1256.9622911312674, 1259.4836117191908, 1266.8796464335874, 1071.6195750508457, 1078.563181911327, 1082.1775450657558, 1094.4199574225672, 1106.6790630717162, 6181.81454556364, 6407.103005579223, 6417.614943103429, 6421.1652485177565, 6589.0116482528, 444.38674629012405, 452.3712040264036, 461.78757771424847, 465.22883628587425, 465.95806377425515, 4412.0955204183065, 4449.3326001100095, 4453.977730111329, 4467.463904331436, 4507.661925355612, 10763.515641796137, 11041.779164416666, 11089.722756931142, 11109.722256943642, 11148.219624626197, 10447.425391603534, 10860.185486088574, 10861.076808471369, 11063.668089957153, 11216.0, 8234.217749313926, 8314.792130196673, 8396.790080248044, 8412.579371031425, 8418.410711250153, 6261.812145635638, 6306.274778400542, 6379.3301703320485, 6423.357664233539, 6586.341365863567, 10044.899551004688, 10201.438920859424, 10262.281640285408, 10333.793324133625, 10389.37663740178, 10431.68704938853, 10460.68617941463, 10516.842247366449, 10546.20903432261, 10558.102561282378, 7349.448791340564, 7767.844643106993, 7947.205279472007, 8044.396670249637, 8046.356291496549, 8982.191602755522, 8996.91003089987, 8997.685081022133, 9021.594028268875, 9100.317476189444, 7899.407544434305, 8092.635831387484, 8133.06469755962, 8159.592020398837, 8166.918330816853, 7566.583837888969, 7770.222977702185, 7926.682932682628, 7941.523508589503, 8057.798555035936, 6985.0, 7002.579845209304, 7076.681549330396, 7077.398421134261, 7134.536255143399, 5031.84904452867, 5132.7433628317685, 5602.663840169603, 5610.7755689773585, 5616.129499927518, 5584.916226256691, 5606.439356064524, 5608.971955140199, 5665.12190610456, 5919.526437885045], "value": 4687.301555317167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.78138663335415, 351.6940261972084, 352.0617554218009, 353.3145697347145, 360.80516521078636, 5751.958054890516, 5805.912911306334, 5831.300243970724, 5851.3270973838025, 5882.235309409771, 5614.9157762633595, 5669.291338582677, 5689.715514224283, 5737.885242295162, 5745.971270143654, 4308.633766129875, 4460.353248778925, 4463.620592249663, 4470.687051906368, 4502.883644686992, 4424.491183513889, 4470.843520476784, 4478.104379124188, 4479.037007043485, 4480.215962206617, 4388.100439409929, 4456.799444025027, 4482.529334419888, 4501.099780043988, 4519.0, 4401.735895846244, 4459.665525085616, 4459.955400446019, 4483.260262056757, 4483.730976141442, 3931.3709806430834, 3940.9014774630577, 3943.7830919299427, 3947.7631342119566, 3954.980225098856, 5515.283013208257, 5550.77796888124, 5590.664560126364, 5596.188552659883, 5612.943870561283, 5002.549770520634, 5072.137736584789, 5074.035933172685, 5074.974625126851, 5109.821156259551, 5953.2856057272975, 5968.880622387528, 5984.251968503937, 6018.428249316352, 6037.366076561942, 4298.699091063627, 4304.160688665712, 4321.870343889688, 4321.891952701176, 4325.697201195886, 5956.851078723023, 6049.455549000611, 6223.439890409885, 6227.0, 6233.376662333731, 4355.346697995326, 4359.607635312837, 4373.671974601854, 4391.099824535962, 4410.6030457259, 4411.845585404495, 4428.734275943454, 4430.291153415503, 4446.244138496463, 4456.086502267028, 4903.705777653352, 5033.597312215014, 5075.365579302587, 5100.948990510047, 5109.4379618241965, 5983.521318294526, 5991.760329586855, 6022.0, 6043.36544662804, 6061.363431873369, 1499.167961781222, 1510.9848901511064, 1512.1305249481593, 1513.1526345246477, 1517.1124891938118, 959.510649568725, 985.7929834734786, 994.5027486256871, 994.8607194992707, 1001.2190491416707, 5203.84388468339, 5246.711430871263, 5289.619671147999, 5353.57171426285, 5358.2498450217, 5409.972950135224, 5481.123020316731, 5551.084875717871, 5554.944450555524, 5555.583331250173, 4989.877277612581, 5128.79484820603, 5295.788168473295, 5310.362756469249, 5313.256144139824, 2926.619539459899, 2954.3943491584173, 2957.689442608495, 2983.4033193361415, 2996.9100926972224, 5677.290338707661, 5683.431656834367, 5687.146927960756, 5756.0, 5770.769169233184, 5797.797077102281, 6328.6835658216905, 6354.618722876642, 6359.777407790705, 6381.489480841522, 6361.809145725636, 6418.967905160444, 6429.742810287629, 6509.349065093453, 6529.836754081091, 6049.425304596057, 6280.811575652738, 6281.623102613858, 6281.811545653638, 6304.621722696653, 5955.731992060281, 6149.323574406722, 6150.846228844136, 6164.6745949621045, 6176.3514830943905, 6429.913641452035, 6436.742530298923, 6452.419282264619, 6483.708233129615, 6497.31778163305, 4326.718763280503, 4362.94941377552, 4366.978165109154, 4402.7358358498595, 4409.40473036136, 6149.723262453111, 6161.969190154021, 6224.221972253468, 6227.813165605039, 6301.747930082745, 6014.578979471395, 6067.878642427038, 6070.514358851193, 6081.239845019372, 6098.140067279523, 5932.940670593239, 5945.821625351246, 6041.6375017499095, 6053.818385448443, 6106.755729770759, 5811.651300921789, 5879.353271140257, 5907.17299578068, 5945.197398351167, 5971.7611295547695, 5946.405359464019, 5977.6114552553945, 6009.278886533644, 6015.135308054517, 6025.403268134036, 5671.461211184931, 5913.5564832636865, 5919.319278283053, 5922.0, 5971.970140149271], "value": 4518.669673051123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.2756261051119, 762.774981380493, 788.3141666749929, 845.3642202338475, 845.9848182181383, 14553.708925821476, 15184.316705748226, 15252.313645885934, 15360.231988400577, 15439.69120617587, 14437.855621443783, 14465.059771114897, 14480.493182738606, 14506.129632222073, 14515.201663908507, 723.724984505887, 854.8204876975842, 857.8327226190879, 880.053942012336, 882.1090698394636, 873.9694110706126, 875.2604049578097, 875.3128793896792, 879.4283715584857, 883.041899539001, 934.3552948465571, 935.2938531408777, 938.5541867612898, 938.8873335199786, 939.3565407695717, 926.5691453474133, 927.8515437529962, 931.729798358482, 932.6595792535743, 933.7385532051003, 676.1548064918851, 679.0628932073756, 681.2302098628518, 682.4676752133344, 685.9142607174103, 13850.0, 13905.235212063333, 13921.30393480332, 13947.721045579134, 14009.08940918837, 14883.627909302246, 15121.773173402407, 15147.394104235816, 15232.0, 15296.235188240544, 12742.554010609676, 13146.802797958038, 13208.933955330258, 13211.33943302831, 13401.46394144233, 4157.225987403574, 4166.833286679735, 4186.120914607936, 4203.348480985452, 4306.289462238727, 67370.3262967369, 69906.30093698998, 70462.0, 74664.0, 75002.62498687471, 12334.136610437363, 12581.496740130475, 12787.040971927143, 12825.935870320589, 12835.294058826667, 21160.78839211619, 22565.0, 22584.435389115402, 22654.207102751654, 22716.0, 8758.474491530402, 8967.10328967098, 9005.549722513848, 9031.458112513139, 9244.953775231215, 5087.26234695967, 5156.8968620627375, 5158.587313014949, 5177.559907407837, 5209.270702101709, 3672.6143754905884, 3779.4519794630173, 3780.243951209769, 3781.243751249761, 3781.773093614392, 687.7249100359796, 691.7475121580587, 704.6476761619191, 706.0926709178681, 711.1572786248312, 683.0505597219868, 748.5359077372065, 769.1308821032197, 792.8691765858684, 799.1129845871078, 9839.852402213972, 10318.277720559488, 10354.378737275787, 10432.113270372103, 10519.84220236697, 690.8549204667077, 731.2906480713806, 754.1026178847154, 775.7478819383723, 792.5244853088101, 4762.190427627312, 4776.379070720854, 4778.832740854054, 4796.688215266066, 4893.853184404474, 110236.448817757, 118318.0, 119222.40388798, 120640.0, 121505.39247303706, 97036.0, 97973.51013244888, 100921.0, 103658.48170759098, 104794.47602761937, 83454.5827270872, 90146.54926725324, 91422.08577914268, 94677.52661236787, 95865.52067239759, 9861.309708320348, 10067.798644027225, 10140.594376225163, 10250.97490250969, 10252.487375631337, 49863.501364987336, 53643.731781340844, 54073.45926540842, 54474.18288725593, 55414.44585554093, 74256.0, 74552.62723686347, 75659.24340756521, 77215.61392193002, 78156.21843781717, 13877.722445551235, 14288.35702393374, 14417.351219194952, 14576.635584110058, 14596.85403145955, 14941.327640256432, 14959.401623935357, 15277.388904443698, 15932.283047262668, 16352.754708679617, 14599.270036498345, 14611.123332600078, 14842.554723358317, 15162.924185379003, 15222.923885380502, 13786.93106534501, 15028.849711502746, 15083.924580377028, 15183.772243416579, 15357.846421535642, 13727.862721372658, 14813.333399997242, 14860.554183374516, 15210.695786083996, 15355.385784568938, 10839.67480975572, 11424.807729449578, 11512.769744604893, 11672.883271167519, 11848.407579621156, 11448.828267575826, 11702.590409335633, 11966.22219555726, 12109.636710898687, 12147.635570932885], "value": 7962.074577030259, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 113.0, 113.0, 110.0, 111.0, 111.0, 113.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 153.0, 189.0, 126.0, 156.0, 151.0, 125.0, 200.0, 123.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 160.0, 163.0, 163.0, 160.0, 160.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 175.0, 75.0, 75.0, 76.0, 75.0, 172.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 154.0, 84.0, 84.0, 83.0, 144.0, 83.0, 84.0, 147.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 97.0, 95.0, 98.0, 95.0, 94.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 51.0, 54.0, 63.0, 51.0, 53.0, 52.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 58.0, 59.0, 60.0, 60.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 83.0, 83.0, 78.0, 76.0, 107.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 117.0, 117.0, 128.0, 122.0, 125.0, 121.0, 117.0, 132.0, 124.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 157.0, 158.0, 156.0, 155.0, 157.0, 156.0, 156.0, 173.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 66.0, 66.0, 65.0, 62.0, 62.0, 61.0], "value": 63.7, "unit": "score"}]}]} 23:41:40 INFO - Return code: 0 23:41:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:41:40 ERROR - # TBPL SUCCESS # 23:41:40 INFO - Running post-action listener: _resource_record_post_action 23:41:40 INFO - ##### 23:41:40 INFO - ##### Finished run-tests step (success) 23:41:40 INFO - ##### 23:41:40 INFO - Running post-run listener: _resource_record_post_run 23:41:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 299008; Write bytes: 252092416; Read time: 292; Write time: 173324 23:41:40 INFO - TinderboxPrint: CPU usage
13.4% 23:41:40 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 292 23:41:40 INFO - TinderboxPrint: I/O write bytes / time
252,092,416 / 173,324 23:41:40 INFO - TinderboxPrint: CPU idle
8,210.6 (86.6%) 23:41:40 INFO - TinderboxPrint: CPU user
1,213.4 (12.8%) 23:41:40 INFO - TinderboxPrint: Swap in / out
0 / 0 23:41:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1433600; Read time: 0; Write time: 48 23:41:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 274432; Write bytes: 250658816; Read time: 276; Write time: 173276 23:41:40 INFO - Running post-run listener: _upload_blobber_files 23:41:40 INFO - Blob upload gear active. 23:41:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:41:40 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 23:41:40 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:41:40 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:41:41 INFO - (blobuploader) - INFO - Open directory for files ... 23:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:42 INFO - (blobuploader) - INFO - Done attempting. 23:41:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:41:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:45 INFO - (blobuploader) - INFO - Done attempting. 23:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:41:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:41:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:41:46 INFO - (blobuploader) - INFO - Done attempting. 23:41:46 INFO - (blobuploader) - INFO - Iteration through files over. 23:41:46 INFO - Return code: 0 23:41:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:41:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:41:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3bd7cd2763bb8e5751abd6122f6787a7a7f74fc66871fbe7382f12feef5b8a0b8682a80572bdf195e3f04ba4e0aec5604539f06fecc95497fb6e16262bb0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6423d58409ed577797ce61786934bc8b36ed055729a8603d685288f36ff5c1d5a7fc60d61206412f3c5329966e6c7373231d58d46591b17d37d67e1260d53dae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7ad1cb11b5c830a21af5f2022dc5ba99fdb21c25bbf516351970fea39281ef564923c2ab2a56fed7d88ac3ef20d6267e9f2924738603a92f262c4f2e5e4c90a"} 23:41:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:41:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:41:46 INFO - Contents: 23:41:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3bd7cd2763bb8e5751abd6122f6787a7a7f74fc66871fbe7382f12feef5b8a0b8682a80572bdf195e3f04ba4e0aec5604539f06fecc95497fb6e16262bb0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6423d58409ed577797ce61786934bc8b36ed055729a8603d685288f36ff5c1d5a7fc60d61206412f3c5329966e6c7373231d58d46591b17d37d67e1260d53dae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7ad1cb11b5c830a21af5f2022dc5ba99fdb21c25bbf516351970fea39281ef564923c2ab2a56fed7d88ac3ef20d6267e9f2924738603a92f262c4f2e5e4c90a"} 23:41:46 INFO - Running post-run listener: copy_logs_to_upload_dir 23:41:46 INFO - Copying logs to upload dir... 23:41:46 INFO - mkdir: /builds/slave/test/build/upload/logs 23:41:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.949216 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-27 23:41:46.123190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 23:41:46.126442) ========= 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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 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/Mozilla-Aurora/sha512/2c3bd7cd2763bb8e5751abd6122f6787a7a7f74fc66871fbe7382f12feef5b8a0b8682a80572bdf195e3f04ba4e0aec5604539f06fecc95497fb6e16262bb0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6423d58409ed577797ce61786934bc8b36ed055729a8603d685288f36ff5c1d5a7fc60d61206412f3c5329966e6c7373231d58d46591b17d37d67e1260d53dae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7ad1cb11b5c830a21af5f2022dc5ba99fdb21c25bbf516351970fea39281ef564923c2ab2a56fed7d88ac3ef20d6267e9f2924738603a92f262c4f2e5e4c90a"} build_url:https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/OdMebpN_SP2gO_yBAT-8dg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3bd7cd2763bb8e5751abd6122f6787a7a7f74fc66871fbe7382f12feef5b8a0b8682a80572bdf195e3f04ba4e0aec5604539f06fecc95497fb6e16262bb0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6423d58409ed577797ce61786934bc8b36ed055729a8603d685288f36ff5c1d5a7fc60d61206412f3c5329966e6c7373231d58d46591b17d37d67e1260d53dae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7ad1cb11b5c830a21af5f2022dc5ba99fdb21c25bbf516351970fea39281ef564923c2ab2a56fed7d88ac3ef20d6267e9f2924738603a92f262c4f2e5e4c90a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 23:41:46.156669) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:41:46.157107) ========= 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=826874ccc97bd7bf541b4875000001d5-1469685293.775903-875248708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 23:41:46.237232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 23:41:46.237580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 23:41:46.237918) ========= ========= Total master_lag: 0.17 =========