builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1468342070.59 results: success (0) buildid: 20160712071125 builduid: 9d5121683529498f8824e102bdd8d305 revision: 50dfed915c24291922414771d3622c336d28b87e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.590990) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.591952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.592573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.609661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.609973) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 09:47:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-07-12 09:47:50 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174771 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.825296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.825649) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.066469 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.903863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:50.904273) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 50dfed915c24291922414771d3622c336d28b87e --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 50dfed915c24291922414771d3622c336d28b87e --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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 09:47:51,047 truncating revision to first 12 chars 2016-07-12 09:47:51,047 Setting DEBUG logging. 2016-07-12 09:47:51,047 attempt 1/10 2016-07-12 09:47:51,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/50dfed915c24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 09:47:51,370 unpacking tar archive at: mozilla-aurora-50dfed915c24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:51.586452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:51.586826) ========= script_repo_revision: 50dfed915c24291922414771d3622c336d28b87e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:51.587359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:51.587682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:47:51.598900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-12 09:47:51.599348) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:47:51 INFO - MultiFileLogger online at 20160712 09:47:51 in /builds/slave/test 09:47:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:47:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:51 INFO - {'append_to_log': False, 09:47:51 INFO - 'base_work_dir': '/builds/slave/test', 09:47:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:47:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:51 INFO - 'branch': 'Mozilla-Aurora', 09:47:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:51 INFO - 'config_files': ('talos/linux_config.py',), 09:47:51 INFO - 'default_actions': ('clobber', 09:47:51 INFO - 'read-buildbot-config', 09:47:51 INFO - 'download-and-extract', 09:47:51 INFO - 'populate-webroot', 09:47:51 INFO - 'create-virtualenv', 09:47:51 INFO - 'install', 09:47:51 INFO - 'run-tests'), 09:47:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:51 INFO - 'download_minidump_stackwalk': True, 09:47:51 INFO - 'download_symbols': 'ondemand', 09:47:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:51 INFO - 'installer_path': 'installer.exe', 09:47:51 INFO - 'log_level': 'info', 09:47:51 INFO - 'log_name': 'talos', 09:47:51 INFO - 'log_to_console': True, 09:47:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:47:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:47:51 INFO - 'opt_config_files': (), 09:47:51 INFO - 'pip_index': False, 09:47:51 INFO - 'sps_profile': False, 09:47:51 INFO - 'sps_profile_interval': 0, 09:47:51 INFO - 'suite': 'dromaeojs', 09:47:51 INFO - 'system_bits': '32', 09:47:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:51 INFO - 'title': 'talos-linux64-ix-022', 09:47:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:51 INFO - 'use_talos_json': True, 09:47:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:51 INFO - 'work_dir': 'build'} 09:47:51 INFO - ##### 09:47:51 INFO - ##### Running clobber step. 09:47:51 INFO - ##### 09:47:51 INFO - Running pre-action listener: _resource_record_pre_action 09:47:51 INFO - Running main action method: clobber 09:47:51 INFO - rmtree: /builds/slave/test/build 09:47:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - ##### 09:47:57 INFO - ##### Finished clobber step (success) 09:47:57 INFO - ##### 09:47:57 INFO - ##### 09:47:57 INFO - ##### Running read-buildbot-config step. 09:47:57 INFO - ##### 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: read_buildbot_config 09:47:57 INFO - Using buildbot properties: 09:47:57 INFO - { 09:47:57 INFO - "project": "", 09:47:57 INFO - "product": "firefox", 09:47:57 INFO - "script_repo_revision": "production", 09:47:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:47:57 INFO - "repository": "", 09:47:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:47:57 INFO - "buildid": "20160712071125", 09:47:57 INFO - "pgo_build": "True", 09:47:57 INFO - "basedir": "/builds/slave/test", 09:47:57 INFO - "buildnumber": 602, 09:47:57 INFO - "slavename": "talos-linux64-ix-022", 09:47:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:47:57 INFO - "platform": "ubuntu64_hw", 09:47:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:47:57 INFO - "branch": "mozilla-aurora", 09:47:57 INFO - "repo_path": "releases/mozilla-aurora", 09:47:57 INFO - "revision": "50dfed915c24291922414771d3622c336d28b87e", 09:47:57 INFO - "stage_platform": "linux64-pgo", 09:47:57 INFO - "builduid": "9d5121683529498f8824e102bdd8d305", 09:47:57 INFO - "slavebuilddir": "test" 09:47:57 INFO - } 09:47:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - ##### 09:47:57 INFO - ##### Finished read-buildbot-config step (success) 09:47:57 INFO - ##### 09:47:57 INFO - ##### 09:47:57 INFO - ##### Running download-and-extract step. 09:47:57 INFO - ##### 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: download_and_extract 09:47:57 INFO - mkdir: /builds/slave/test/build/tests 09:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:57 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:47:57 INFO - Downloaded 1361 bytes. 09:47:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:47:57 INFO - Using the following test package requirements: 09:47:57 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:47:57 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:47:57 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:47:57 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'jsshell-linux-x86_64.zip'], 09:47:57 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:47:57 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:47:57 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:47:57 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:47:57 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:47:57 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:47:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:47:57 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:57 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:47:59 INFO - Downloaded 24527633 bytes. 09:47:59 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'] 09:47:59 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 09:48:00 INFO - Return code: 0 09:48:00 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 09:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:00 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:01 INFO - Downloaded 24527633 bytes. 09:48:01 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'] 09:48:01 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 09:48:03 INFO - Return code: 0 09:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:03 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:04 INFO - Downloaded 10833369 bytes. 09:48:04 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'] 09:48:04 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 09:48:04 INFO - Return code: 0 09:48:04 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')]} 09:48:04 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/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 09:48:06 INFO - Downloaded 63639154 bytes. 09:48:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:48:06 INFO - mkdir: /builds/slave/test/properties 09:48:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:06 INFO - Contents: 09:48:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:48:07 INFO - Running post-action listener: _resource_record_post_action 09:48:07 INFO - Running post-action listener: set_extra_try_arguments 09:48:07 INFO - ##### 09:48:07 INFO - ##### Finished download-and-extract step (success) 09:48:07 INFO - ##### 09:48:07 INFO - ##### 09:48:07 INFO - ##### Running populate-webroot step. 09:48:07 INFO - ##### 09:48:07 INFO - Running pre-action listener: _resource_record_pre_action 09:48:07 INFO - Running main action method: populate_webroot 09:48:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:07 INFO - '--tppagecycles', 09:48:07 INFO - '7'], 09:48:07 INFO - 'tests': ['tsvgm']}}, 09:48:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['damp', 'tps']}, 09:48:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'tests': ['damp', 'tps']}, 09:48:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['dromaeo_dom']}, 09:48:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['a11yr', 09:48:07 INFO - 'ts_paint', 09:48:07 INFO - 'tpaint', 09:48:07 INFO - 'sessionrestore', 09:48:07 INFO - 'sessionrestore_no_auto_restore', 09:48:07 INFO - 'tabpaint']}, 09:48:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['tsvgx', 09:48:07 INFO - 'tsvgr_opacity', 09:48:07 INFO - 'tart', 09:48:07 INFO - 'tscrollx', 09:48:07 INFO - 'cart']}, 09:48:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:07 INFO - 'tsvgr_opacity', 09:48:07 INFO - 'tart', 09:48:07 INFO - 'tscrollx', 09:48:07 INFO - 'cart']}, 09:48:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'talos_options': ['--disable-e10s'], 09:48:07 INFO - 'tests': ['tp5o']}, 09:48:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'tests': ['tp5o']}, 09:48:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'talos_options': ['--disable-e10s', 09:48:07 INFO - '--xperf_path', 09:48:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:07 INFO - 'tests': ['tp5n']}, 09:48:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:07 INFO - 'talos_options': ['--xperf_path', 09:48:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:07 INFO - 'tests': ['tp5n']}}, 09:48:07 INFO - 'talos.zip': {'path': '', 09:48:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:07 INFO - Running post-action listener: _resource_record_post_action 09:48:07 INFO - ##### 09:48:07 INFO - ##### Finished populate-webroot step (success) 09:48:07 INFO - ##### 09:48:07 INFO - ##### 09:48:07 INFO - ##### Running create-virtualenv step. 09:48:07 INFO - ##### 09:48:07 INFO - Running pre-action listener: _resource_record_pre_action 09:48:07 INFO - Running main action method: create_virtualenv 09:48:07 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:07 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 09:48:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:07 INFO - Using real prefix '/usr' 09:48:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:10 INFO - Installing pip.................done. 09:48:10 INFO - Return code: 0 09:48:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:10 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')]} 09:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 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')]} 09:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:10 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 09:48:10 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 09:48:10 INFO - Using env: {'DISPLAY': ':0', 09:48:10 INFO - 'HOME': '/home/cltbld', 09:48:10 INFO - 'LANG': 'en_US.UTF-8', 09:48:10 INFO - 'LANGUAGE': 'en_US:en', 09:48:10 INFO - 'LOGNAME': 'cltbld', 09:48:10 INFO - 'MAIL': '/var/mail/cltbld', 09:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:10 INFO - 'MOZ_NO_REMOTE': '1', 09:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:10 INFO - 'NO_EM_RESTART': '1', 09:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:10 INFO - 'PWD': '/builds/slave/test', 09:48:10 INFO - 'SHELL': '/bin/bash', 09:48:10 INFO - 'SHLVL': '1', 09:48:10 INFO - 'TERM': 'linux', 09:48:10 INFO - 'TMOUT': '86400', 09:48:10 INFO - 'USER': 'cltbld', 09:48:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:10 INFO - '_': '/tools/buildbot/bin/python'} 09:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:10 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 09:48:10 INFO - Cleaning up... 09:48:10 INFO - Return code: 0 09:48:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:10 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')]} 09:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 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')]} 09:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:10 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 09:48:10 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 09:48:10 INFO - Using env: {'DISPLAY': ':0', 09:48:10 INFO - 'HOME': '/home/cltbld', 09:48:10 INFO - 'LANG': 'en_US.UTF-8', 09:48:10 INFO - 'LANGUAGE': 'en_US:en', 09:48:10 INFO - 'LOGNAME': 'cltbld', 09:48:10 INFO - 'MAIL': '/var/mail/cltbld', 09:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:10 INFO - 'MOZ_NO_REMOTE': '1', 09:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:10 INFO - 'NO_EM_RESTART': '1', 09:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:10 INFO - 'PWD': '/builds/slave/test', 09:48:10 INFO - 'SHELL': '/bin/bash', 09:48:10 INFO - 'SHLVL': '1', 09:48:10 INFO - 'TERM': 'linux', 09:48:10 INFO - 'TMOUT': '86400', 09:48:10 INFO - 'USER': 'cltbld', 09:48:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:10 INFO - '_': '/tools/buildbot/bin/python'} 09:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:11 INFO - Downloading/unpacking psutil>=3.1.1 09:48:11 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 09:48:11 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 09:48:11 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 09:48:11 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 09:48:11 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 09:48:11 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 09:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:13 INFO - Installing collected packages: psutil 09:48:13 INFO - Running setup.py install for psutil 09:48:13 INFO - building 'psutil._psutil_linux' extension 09:48:13 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 09:48:14 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 09:48:14 INFO - building 'psutil._psutil_posix' extension 09:48:14 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 09:48:14 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 09:48:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:14 INFO - Successfully installed psutil 09:48:14 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:15 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 09:48:15 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 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:15 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 09:48:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:17 INFO - Installing collected packages: mozsystemmonitor 09:48:17 INFO - Running setup.py install for mozsystemmonitor 09:48:17 INFO - Successfully installed mozsystemmonitor 09:48:17 INFO - Cleaning up... 09:48:17 INFO - Return code: 0 09:48:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:48:17 INFO - Using env: {'DISPLAY': ':0', 09:48:17 INFO - 'HOME': '/home/cltbld', 09:48:17 INFO - 'LANG': 'en_US.UTF-8', 09:48:17 INFO - 'LANGUAGE': 'en_US:en', 09:48:17 INFO - 'LOGNAME': 'cltbld', 09:48:17 INFO - 'MAIL': '/var/mail/cltbld', 09:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:17 INFO - 'MOZ_NO_REMOTE': '1', 09:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:17 INFO - 'NO_EM_RESTART': '1', 09:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:17 INFO - 'PWD': '/builds/slave/test', 09:48:17 INFO - 'SHELL': '/bin/bash', 09:48:17 INFO - 'SHLVL': '1', 09:48:17 INFO - 'TERM': 'linux', 09:48:17 INFO - 'TMOUT': '86400', 09:48:17 INFO - 'USER': 'cltbld', 09:48:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:17 INFO - '_': '/tools/buildbot/bin/python'} 09:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:19 INFO - warning: no files found matching '*.txt' 09:48:19 INFO - no previously-included directories found matching 'build' 09:48:19 INFO - no previously-included directories found matching 'dist' 09:48:19 INFO - no previously-included directories found matching '.git*' 09:48:19 INFO - Installing collected packages: jsonschema, functools32 09:48:19 INFO - Running setup.py install for functools32 09:48:19 INFO - warning: no files found matching '*.txt' 09:48:19 INFO - no previously-included directories found matching 'build' 09:48:19 INFO - no previously-included directories found matching 'dist' 09:48:19 INFO - no previously-included directories found matching '.git*' 09:48:19 INFO - Successfully installed jsonschema functools32 09:48:19 INFO - Cleaning up... 09:48:19 INFO - Return code: 0 09:48:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:19 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')]} 09:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 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')]} 09:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:19 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:19 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 09:48:19 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 09:48:19 INFO - Using env: {'DISPLAY': ':0', 09:48:19 INFO - 'HOME': '/home/cltbld', 09:48:19 INFO - 'LANG': 'en_US.UTF-8', 09:48:19 INFO - 'LANGUAGE': 'en_US:en', 09:48:19 INFO - 'LOGNAME': 'cltbld', 09:48:19 INFO - 'MAIL': '/var/mail/cltbld', 09:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:19 INFO - 'MOZ_NO_REMOTE': '1', 09:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:19 INFO - 'NO_EM_RESTART': '1', 09:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:19 INFO - 'PWD': '/builds/slave/test', 09:48:19 INFO - 'SHELL': '/bin/bash', 09:48:19 INFO - 'SHLVL': '1', 09:48:19 INFO - 'TERM': 'linux', 09:48:19 INFO - 'TMOUT': '86400', 09:48:19 INFO - 'USER': 'cltbld', 09:48:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:19 INFO - '_': '/tools/buildbot/bin/python'} 09:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 INFO - Downloading docopt-0.6.1.tar.gz 09:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:22 INFO - Running setup.py install for blobuploader 09:48:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:23 INFO - Running setup.py install for requests 09:48:23 INFO - Running setup.py install for docopt 09:48:23 INFO - Successfully installed blobuploader requests docopt 09:48:23 INFO - Cleaning up... 09:48:23 INFO - Return code: 0 09:48:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:23 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:23 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 09:48:23 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 09:48:23 INFO - Using env: {'DISPLAY': ':0', 09:48:23 INFO - 'HOME': '/home/cltbld', 09:48:23 INFO - 'LANG': 'en_US.UTF-8', 09:48:23 INFO - 'LANGUAGE': 'en_US:en', 09:48:23 INFO - 'LOGNAME': 'cltbld', 09:48:23 INFO - 'MAIL': '/var/mail/cltbld', 09:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:23 INFO - 'MOZ_NO_REMOTE': '1', 09:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:23 INFO - 'NO_EM_RESTART': '1', 09:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:23 INFO - 'PWD': '/builds/slave/test', 09:48:23 INFO - 'SHELL': '/bin/bash', 09:48:23 INFO - 'SHLVL': '1', 09:48:23 INFO - 'TERM': 'linux', 09:48:23 INFO - 'TMOUT': '86400', 09:48:23 INFO - 'USER': 'cltbld', 09:48:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:23 INFO - '_': '/tools/buildbot/bin/python'} 09:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:23 INFO - Running setup.py (path:/tmp/pip-UdUc81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:23 INFO - Running setup.py (path:/tmp/pip-dVD9_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:23 INFO - Running setup.py (path:/tmp/pip-yW7wpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:23 INFO - Running setup.py (path:/tmp/pip-WSZ0BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:24 INFO - Running setup.py (path:/tmp/pip-OXmdTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:24 INFO - Running setup.py (path:/tmp/pip-7XXWQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:24 INFO - Running setup.py (path:/tmp/pip-n8Tfgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:24 INFO - Running setup.py (path:/tmp/pip-rRpqfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:24 INFO - Running setup.py (path:/tmp/pip-4GWTOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:24 INFO - Running setup.py (path:/tmp/pip-vptgiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:24 INFO - Running setup.py (path:/tmp/pip-B4aXsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:24 INFO - Running setup.py (path:/tmp/pip-dkpYHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:24 INFO - Running setup.py (path:/tmp/pip-LBWHjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:24 INFO - Running setup.py (path:/tmp/pip-r4Y8qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:24 INFO - Running setup.py (path:/tmp/pip-E3mI7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:24 INFO - Running setup.py (path:/tmp/pip-JfvrjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:24 INFO - Running setup.py (path:/tmp/pip-pxzIzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:24 INFO - Running setup.py install for manifestparser 09:48:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for mozcrash 09:48:25 INFO - Running setup.py install for mozdebug 09:48:25 INFO - Running setup.py install for mozdevice 09:48:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for mozfile 09:48:25 INFO - Running setup.py install for mozhttpd 09:48:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for mozinfo 09:48:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for mozInstall 09:48:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for mozleak 09:48:25 INFO - Running setup.py install for mozlog 09:48:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:25 INFO - Running setup.py install for moznetwork 09:48:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Running setup.py install for mozprocess 09:48:26 INFO - Running setup.py install for mozprofile 09:48:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Running setup.py install for mozrunner 09:48:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Running setup.py install for mozscreenshot 09:48:26 INFO - Running setup.py install for moztest 09:48:26 INFO - Running setup.py install for mozversion 09:48:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:26 INFO - Cleaning up... 09:48:26 INFO - Return code: 0 09:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:26 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')]} 09:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 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')]} 09:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:26 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 09:48:26 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 09:48:26 INFO - Using env: {'DISPLAY': ':0', 09:48:26 INFO - 'HOME': '/home/cltbld', 09:48:26 INFO - 'LANG': 'en_US.UTF-8', 09:48:26 INFO - 'LANGUAGE': 'en_US:en', 09:48:26 INFO - 'LOGNAME': 'cltbld', 09:48:26 INFO - 'MAIL': '/var/mail/cltbld', 09:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:26 INFO - 'MOZ_NO_REMOTE': '1', 09:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:26 INFO - 'NO_EM_RESTART': '1', 09:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:26 INFO - 'PWD': '/builds/slave/test', 09:48:26 INFO - 'SHELL': '/bin/bash', 09:48:26 INFO - 'SHLVL': '1', 09:48:26 INFO - 'TERM': 'linux', 09:48:26 INFO - 'TMOUT': '86400', 09:48:26 INFO - 'USER': 'cltbld', 09:48:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:26 INFO - '_': '/tools/buildbot/bin/python'} 09:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:26 INFO - Running setup.py (path:/tmp/pip-mU73hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:27 INFO - Running setup.py (path:/tmp/pip-sfuLNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:27 INFO - Running setup.py (path:/tmp/pip-34bPQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:27 INFO - Running setup.py (path:/tmp/pip-4ma36X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:27 INFO - Running setup.py (path:/tmp/pip-xPwZ6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:27 INFO - Running setup.py (path:/tmp/pip-7iJL6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:27 INFO - Running setup.py (path:/tmp/pip-oRFMfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:27 INFO - Running setup.py (path:/tmp/pip-mryfQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:27 INFO - Running setup.py (path:/tmp/pip-_Slszh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:27 INFO - Running setup.py (path:/tmp/pip-SZ686y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:27 INFO - Running setup.py (path:/tmp/pip-XAohhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:27 INFO - Running setup.py (path:/tmp/pip-18xT6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:27 INFO - Running setup.py (path:/tmp/pip-smc1nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:27 INFO - Running setup.py (path:/tmp/pip-oGtWWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:27 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)) 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:27 INFO - Running setup.py (path:/tmp/pip-VDmN_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:28 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)) 09:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:28 INFO - Running setup.py (path:/tmp/pip-xPPvxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:28 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)) 09:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:28 INFO - Running setup.py (path:/tmp/pip-L2b0He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:28 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)) 09:48:28 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)) 09:48:28 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)) 09:48:28 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)) 09:48:28 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)) 09:48:28 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)) 09:48:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:30 INFO - Downloading blessings-1.6.tar.gz 09:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:30 INFO - Installing collected packages: blessings 09:48:30 INFO - Running setup.py install for blessings 09:48:30 INFO - Successfully installed blessings 09:48:30 INFO - Cleaning up... 09:48:30 INFO - Return code: 0 09:48:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:30 INFO - Reading from file tmpfile_stdout 09:48:30 INFO - Current package versions: 09:48:30 INFO - argparse == 1.2.1 09:48:30 INFO - blessings == 1.6 09:48:30 INFO - blobuploader == 1.2.4 09:48:30 INFO - docopt == 0.6.1 09:48:30 INFO - functools32 == 3.2.3-2 09:48:30 INFO - jsonschema == 2.5.1 09:48:30 INFO - manifestparser == 1.1 09:48:30 INFO - mozInstall == 1.12 09:48:30 INFO - mozcrash == 0.17 09:48:30 INFO - mozdebug == 0.1 09:48:30 INFO - mozdevice == 0.48 09:48:30 INFO - mozfile == 1.2 09:48:30 INFO - mozhttpd == 0.7 09:48:30 INFO - mozinfo == 0.9 09:48:30 INFO - mozleak == 0.1 09:48:30 INFO - mozlog == 3.2 09:48:30 INFO - moznetwork == 0.27 09:48:30 INFO - mozprocess == 0.23 09:48:30 INFO - mozprofile == 0.28 09:48:30 INFO - mozrunner == 6.12 09:48:30 INFO - mozscreenshot == 0.1 09:48:30 INFO - mozsystemmonitor == 0.3 09:48:30 INFO - moztest == 0.7 09:48:30 INFO - mozversion == 1.4 09:48:30 INFO - psutil == 3.1.1 09:48:30 INFO - requests == 1.2.3 09:48:30 INFO - wsgiref == 0.1.2 09:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:30 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')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:30 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 09:48:30 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 09:48:30 INFO - Using env: {'DISPLAY': ':0', 09:48:30 INFO - 'HOME': '/home/cltbld', 09:48:30 INFO - 'LANG': 'en_US.UTF-8', 09:48:30 INFO - 'LANGUAGE': 'en_US:en', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MAIL': '/var/mail/cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SHLVL': '1', 09:48:30 INFO - 'TERM': 'linux', 09:48:30 INFO - 'TMOUT': '86400', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - '_': '/tools/buildbot/bin/python'} 09:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 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)) 09:48:30 INFO - Cleaning up... 09:48:30 INFO - Return code: 0 09:48:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:30 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')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48:30 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 09:48:30 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 09:48:30 INFO - Using env: {'DISPLAY': ':0', 09:48:30 INFO - 'HOME': '/home/cltbld', 09:48:30 INFO - 'LANG': 'en_US.UTF-8', 09:48:30 INFO - 'LANGUAGE': 'en_US:en', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MAIL': '/var/mail/cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SHLVL': '1', 09:48:30 INFO - 'TERM': 'linux', 09:48:30 INFO - 'TMOUT': '86400', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - '_': '/tools/buildbot/bin/python'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:31 INFO - Cleaning up... 09:48:31 INFO - Return code: 0 09:48:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cd8a41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', '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 09:48: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', 'flake8'] in /builds/slave/test/build 09:48: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 flake8 09:48:31 INFO - Using env: {'DISPLAY': ':0', 09:48:31 INFO - 'HOME': '/home/cltbld', 09:48:31 INFO - 'LANG': 'en_US.UTF-8', 09:48:31 INFO - 'LANGUAGE': 'en_US:en', 09:48:31 INFO - 'LOGNAME': 'cltbld', 09:48:31 INFO - 'MAIL': '/var/mail/cltbld', 09:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:31 INFO - 'MOZ_NO_REMOTE': '1', 09:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:31 INFO - 'NO_EM_RESTART': '1', 09:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:31 INFO - 'PWD': '/builds/slave/test', 09:48:31 INFO - 'SHELL': '/bin/bash', 09:48:31 INFO - 'SHLVL': '1', 09:48:31 INFO - 'TERM': 'linux', 09:48:31 INFO - 'TMOUT': '86400', 09:48:31 INFO - 'USER': 'cltbld', 09:48:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:31 INFO - '_': '/tools/buildbot/bin/python'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 INFO - Downloading/unpacking flake8 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:33 INFO - no previously-included directories found matching 'docs/_build' 09:48:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:33 INFO - Running setup.py install for pep8 09:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:34 INFO - no previously-included directories found matching 'docs/_build' 09:48:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Running post-action listener: _resource_record_post_action 09:48:34 INFO - Running post-action listener: _start_resource_monitoring 09:48:34 INFO - Starting resource monitoring. 09:48:34 INFO - ##### 09:48:34 INFO - ##### Finished create-virtualenv step (success) 09:48:34 INFO - ##### 09:48:34 INFO - ##### 09:48:34 INFO - ##### Running install step. 09:48:34 INFO - ##### 09:48:34 INFO - Running pre-action listener: _resource_record_pre_action 09:48:34 INFO - Running main action method: install 09:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:34 INFO - Reading from file tmpfile_stdout 09:48:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:34 INFO - Reading from file tmpfile_stdout 09:48:34 INFO - Output received: 09:48:34 INFO - Usage: mozinstall [options] installer 09:48:34 INFO - Options: 09:48:34 INFO - -h, --help show this help message and exit 09:48:34 INFO - -d DEST, --destination=DEST 09:48:34 INFO - Directory to install application into. [default: 09:48:34 INFO - "/builds/slave/test"] 09:48:34 INFO - --app=APP Application being installed. [default: firefox] 09:48:34 INFO - mkdir: /builds/slave/test/build/application 09:48:34 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'] 09:48:34 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 09:48:50 INFO - Reading from file tmpfile_stdout 09:48:50 INFO - Output received: 09:48:50 INFO - /builds/slave/test/build/application/firefox/firefox 09:48:50 INFO - Running post-action listener: _resource_record_post_action 09:48:50 INFO - ##### 09:48:50 INFO - ##### Finished install step (success) 09:48:50 INFO - ##### 09:48:50 INFO - ##### 09:48:50 INFO - ##### Running run-tests step. 09:48:50 INFO - ##### 09:48:50 INFO - Running pre-action listener: _resource_record_pre_action 09:48:50 INFO - Running main action method: run_tests 09:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:50 INFO - Python 2.7.3 09:48:50 INFO - Return code: 0 09:48:50 INFO - grabbing minidump binary from tooltool 09:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:50 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 0x1a441c0>, '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 0x1a450c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a45550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:50 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 09:48:50 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 09:48:50 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 09:48:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:50 INFO - Return code: 0 09:48:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:48:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:48:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:48:51 INFO - Return code: 0 09:48:51 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:48:51 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:48:51 INFO - Using env: {'DISPLAY': ':0', 09:48:51 INFO - 'HOME': '/home/cltbld', 09:48:51 INFO - 'LANG': 'en_US.UTF-8', 09:48:51 INFO - 'LANGUAGE': 'en_US:en', 09:48:51 INFO - 'LOGNAME': 'cltbld', 09:48:51 INFO - 'MAIL': '/var/mail/cltbld', 09:48:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:51 INFO - 'MOZ_NO_REMOTE': '1', 09:48:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:51 INFO - 'NO_EM_RESTART': '1', 09:48:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:51 INFO - 'PWD': '/builds/slave/test', 09:48:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:51 INFO - 'SHELL': '/bin/bash', 09:48:51 INFO - 'SHLVL': '1', 09:48:51 INFO - 'TERM': 'linux', 09:48:51 INFO - 'TMOUT': '86400', 09:48:51 INFO - 'USER': 'cltbld', 09:48:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046', 09:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:51 INFO - '_': '/tools/buildbot/bin/python'} 09:48:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:48:52 INFO - mozversion application_buildid: 20160712071125 09:48:52 INFO - mozversion application_changeset: 50dfed915c24291922414771d3622c336d28b87e 09:48:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:48:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:52 INFO - mozversion application_name: Firefox 09:48:52 INFO - mozversion application_remotingname: firefox-dev 09:48:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:48:52 INFO - mozversion application_vendor: Mozilla 09:48:52 INFO - mozversion application_version: 49.0a2 09:48:52 INFO - mozversion platform_buildid: 20160712071125 09:48:52 INFO - mozversion platform_changeset: 50dfed915c24291922414771d3622c336d28b87e 09:48:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:48:52 INFO - mozversion platform_version: 49.0a2 09:48:52 INFO - using testdate: 1468342132 09:48:52 INFO - actual date: 1468342132 09:48:52 INFO - starting webserver on 'localhost:55871' 09:48:52 INFO - SUITE-START | Running 2 tests 09:48:52 INFO - TEST-START | dromaeo_css 09:48:52 INFO - operating with platform_type : linux_ 09:48:52 INFO - Initialising browser for dromaeo_css test... 09:48:52 INFO - TEST-INFO | started process 3334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrQwAN/profile http://localhost:55871/getInfo.html) 09:48:57 INFO - PROCESS | 3334 | __metrics Screen width/height:1600/1200 09:48:57 INFO - PROCESS | 3334 | colorDepth:24 09:48:57 INFO - PROCESS | 3334 | Browser inner width/height: 1024/697 09:48:57 INFO - PROCESS | 3334 | __metrics 09:48:58 ERROR - PROCESS | 3334 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:48:59 INFO - TEST-INFO | 3334: exit 0 09:48:59 INFO - Browser initialized. 09:48:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:59 INFO - TEST-INFO | started process 3427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSrQwAN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:10 INFO - PROCESS | 3427 | RSS: Main: 145428480 09:49:10 INFO - PROCESS | 3427 | 09:50:02 INFO - PROCESS | 3427 | 1468342202647 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] 09:52:10 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55871/tests/dromaeo/cssquery-ext.html) 09:52:11 INFO - PROCESS | 3427 | RSS: Main: 257560576 09:52:11 INFO - PROCESS | 3427 | 09:55:13 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-ext.html (next: http://localhost:55871/tests/dromaeo/cssquery-jquery.html) 09:55:14 INFO - PROCESS | 3427 | RSS: Main: 234201088 09:55:14 INFO - PROCESS | 3427 | 09:58:16 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55871/tests/dromaeo/cssquery-mootools.html) 09:58:16 INFO - PROCESS | 3427 | RSS: Main: 227454976 09:58:16 INFO - PROCESS | 3427 | 10:01:18 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55871/tests/dromaeo/cssquery-prototype.html) 10:01:19 INFO - PROCESS | 3427 | RSS: Main: 223596544 10:01:19 INFO - PROCESS | 3427 | 10:04:21 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55871/tests/dromaeo/cssquery-yui.html) 10:04:22 INFO - PROCESS | 3427 | RSS: Main: 216047616 10:04:22 INFO - PROCESS | 3427 | 10:07:24 INFO - PROCESS | 3427 | Cycle 1(1): loaded http://localhost:55871/tests/dromaeo/cssquery-yui.html (next: http://localhost:55871/tests/dromaeo/cssquery-dojo.html) 10:07:25 INFO - PROCESS | 3427 | RSS: Main: 262205440 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | __start_tp_report 10:07:25 INFO - PROCESS | 3427 | _x_x_mozilla_page_load 10:07:25 INFO - PROCESS | 3427 | _x_x_mozilla_page_load_details 10:07:25 INFO - PROCESS | 3427 | |i|pagename|runs| 10:07:25 INFO - PROCESS | 3427 | |0;dojo.html;3357.1774915145793;3360.7143392811604;3369.5114208439777;3392.389369913418;3400.1839558505967;5343.064963631364;5419.945800541994;5421.078416669166;5452.672839629625;5477.643953143043;5411.891762164754;5439.4832490913395;5465.508104270615;5469.425710300421;5492.917606235909;4858.757062146896;4874.317595536628;4954.950450495485;4967.50324967504;5007.549320561149;4922.409310882681;4983.302337672729;4992.251162325644;5007.298978143063;5030.82392116276;5017.523335283142;5052.722100284483;5117.7185254810975;5125.769340379692;5159.484051594848;5073.086844368012;5080.568151707109;5107.310513080743;5115.309433226504;5127.743612819381;4806.831760888387;4929.679570827885;4984.127777638899;4994.850154495334;5034.974825125851;5423.7830486780485;5432.022235997519;5455.290812194389;5461.617686761928;5471.616986810925;5539.944600553983;5902.144189092601;5905.438983296623;5906;5906.143609176688;5743.253377060955;5779;5797.710114494258;5853.619514731528;5904.468597826173;5475.7262136893;5476.534494567926;5477.589180811455;5478.506934375885;5483.341998960111;5748.310202775694;5863.70681465925;5916.970415147896;5962.105684147413;5968.850778730566;5653.689047102449;5774.595778295479;5778.046622307356;5783.913241301384;5785.595008349375;5799.130130480377;5804.2744656917885;5852.619579727304;5854.326752423441;5862.267216597926;5568.554515638739;5757.193992841006;5758.395368486333;5767.336756272998;5810.88378232433;5853.122031695195;5863.355030946593;5867.530597552186;5871.941280587225;5878.11828225761;4486.66350023743;4518.932216016762;4527.796249168795;4534.682572219913;4555.20283950314;3957.109650328711;3998.360262358067;4029.133736246721;4037.1118353962083;4064.065264989069;5601.915971260434;5610.326760788732;5616.382197958222;5622.522085622686;5658.094704847204;5643.943560564424;5888.499477544371;5897.911531327033;5902.557308201902;5911.881762364728;5485.753141108659;5521.1442226454965;5524.392316845144;5553.750081246354;5574.275344205227;5017.523335283142;5026.09530284545;5027.522385373383;5048.217526283432;5061.6962982221185;5819.272590926134;5970.164177015221;6083.361247069082;6120.1737765401995;6122.7857025004805;5762.135679648086;5839.744454942208;5851.531877449709;5854.531637469077;5856;6071.058985857199;6079.574429790049;6081.513478921587;6082.847928801639;6085.604435711664;5576.358718747234;5631.971840140773;5665.716714164358;5723.828285151452;5724.79963201286;5834.795782147605;5837.562182836389;5840.883182336414;5842.649441033552;5865.4134586541;5692.260006199168;5698.8290351289525;5701.657900525982;5707.286589176353;5707.686077265625;5539.556835453073;5561.972190139023;5583.35791383996;5602.747876345656;5676;5561.749721262472;5593.105103183471;5596.188552659923;5602.4957753802355;5613.943860561342;5680.943190568041;5697.059985102577;5707.229524014205;5736.225609542658;5741.598088133791;5410.945890541044;5458.181272809111;5502.944970550403;5517.36550296705;5557.472040156179 10:07:25 INFO - PROCESS | 3427 | |1;ext.html;594.9434803693648;636.3604577399716;638.9968050159749;653.4772182254197;662.7084083003481;34248;36653.45019824702;36721.449178262345;36725.44911826321;36775.81612091942;48530.75734621331;50229.497705022935;50245.49754502454;53906;54088.459115408834;9152.725418237447;9268.907310926905;9269.768255793626;9286.860697089549;9295.39579927306;8446.704365347214;8705.564721763887;9161.450312981242;9266.629334826632;9269.675561355354;11036.282641628308;11296.604618838343;11299.49152288149;11601.245919015279;11606.651800445958;11064.502097405595;11129.944350278278;11139.832902506469;11146.888531114666;11151.219414640978;8665.826683466295;10683.679489615324;10973.122150227962;11015.614453494089;11040.227184097117;45050.32424513635;45411.31883021758;45443.54556454426;45463;45567.77216113931;3480.6345333739846;3585.820708964541;3659.9451008234896;3737.289914916157;4133.276676581586;34733.47899781505;34934.30131397358;35232.64767352319;35512.467312990324;35604.28791424183;4280.978595107004;4345.521992580813;4447.822087116511;4528.02647430804;4533.591976722078;386017;386970;387303;387747;388005;64511;64610.35389646043;64775;64833.67583162054;64882.10707357574;39312.803435982634;41038;41056.58943410528;43064.569354306055;43125;17813.46559603214;17838.5540361492;17942.102894855205;18041.007744574174;18082.819171808376;14302.427902883976;14473.348699308557;14473.421063157566;14497.20265385414;14692.632684182767;19024.619507609772;20424.591508169753;21933.451663708216;22153.66769498459;22208.888955555118;7355.675978323953;7385.22455142213;7388.44586656003;7412.814679633052;7463.738769143054;1001.464216644092;1059.5655781129853;1078.692572616816;1136.8806275341135;1176.2178151529308;34784.82607586946;35520.28959420797;36909.96995165238;37102.417144281084;37830.62169378271;1156.7917774800617;1211.1885037025215;1226.6013545597716;1230.0958795285458;1255.2029461291963;17739.29042838272;17922.372716955106;18074.819251807578;18300.725489117674;18394.540136496693;682957;687095;688393;690044;693575;64984;65483;65562.67218663877;65623.34376656268;65675;1363.7749771287824;1472.2197235465221;1473.3811799044427;1516.1888389711671;1528.7859699642058;34192.487112692834;34743.65256347404;35410.822945885106;35783;35864.82067589645;54988;55330.446695532526;55886.16170757523;55998.44001560095;56010.439895600524;444221;448077;448435;448718;448994;27071.1878643641;27119.45761084807;27450.176494705192;27652.861735691193;27790;50735;51349.48650513447;52528.73735631297;52770;52866.47133528616;43304.350434744134;43328.78335608428;43667.78166109149;43704.781476092416;43728.82536429064;43207.35188972105;43549.129017420106;44004;44150.779246103564;44961.77519112384;43359.34960975651;44477.555224447344;45966.540334597565;46132;48599.27101093416;38855.41716874306;40346.47550776607;40476;40826.38760418655;41334.586654133076;29434.11697649074;29440;29669;29727;29895 10:07:25 INFO - PROCESS | 3427 | |2;jquery.html;403.7436227995222;421.3111562595156;421.6900578075112;425.56167147837726;438.55705737205415;18830.435086947396;20281.18875244992;20545.486362840937;20826.89586552065;21400.14399424021;20009.299674511396;20308.492287692814;20446.386608401735;20681.482962925933;20706.68939965902;5676.858078548028;5869.060950247961;5922.407759224065;5926.02220633595;5934.554908381867;4131.400946862703;5786.045302525099;5799.3620701722775;6148.446639802417;6503.349665033506;6498.642574658392;6507.154069970898;6546.149000629912;6594.340565943416;6607.141071660677;6325.810225693236;6420.58266212697;6474.158359413246;6514.609123452608;6515.087887695727;3867.8259478323544;5354.598405119593;5661.405552417019;5663.377028526858;5700.315962084576;24481.877590611934;24623.630645540332;24631.753682463306;25042.624360634603;25107.87446062776;2344.6365813298794;2559.091522509501;2570.897164113433;2768.695443501213;2876.3096856754228;14496.782548261785;15648.217589120499;15716.92141539285;16348.182590870529;16512.25694843735;2039.7042428847733;2099.737532808399;2119.5442979759428;2156.7519735230335;2178.455386153462;98149;105324;106311.93688063175;107954;108006.45996770044;18640.627187456175;19266.807331926782;19398.127084280957;19709.408717738203;20251.189952402034;35347;35601.28797424089;36221.27557448836;36244.45633315502;36284;9938.254630902567;10464.11055060313;10512.737181570368;10545.261831671709;10568.682939511827;8591.09793471689;8607.440516366416;8673.956630216808;8847.646094156291;8868.512231827182;9419.387739796892;9424.670136545188;9470.621175153054;9817.509124543887;9867.457289848984;3032.454158251536;3574.195805943694;3740.6633402993316;3750.6061863503937;3831.2912111259507;999.1856636840952;1085.7122862441458;1090.6019302954364;1105.5190991918541;1138.3909608359488;19603.31388401399;19705.802941970684;19756.90121549412;19926.900365498368;20052.799472005092;1033.9017793309624;1080.6920027792198;1087.6845714742794;1098.0831006109988;1125.4991528769783;10782.245242833083;11214.158938079514;11304.830427543593;11317.320960742381;11397.202195846212;385174;386276;388399;507779;515417;100169;100230;100803.49598251961;103712;117243;1102.80149573076;1104.3373975614727;1128.0975219824109;1145.4902568357002;1149.1955631058293;18560.81439185645;18754.343597974006;18799.530011749815;18836.717449238546;19079.332223372116;44512.88717782081;45983.77008114938;46107.53892461032;46115.769421152676;46551.76724116493;65050.34949650443;65513.67243163754;65519.34480655323;65751.67124164349;65897.67051164714;8162.959185204036;8439.70461033861;8981.14679105484;9055.411398259092;9064.818703626022;6986.336298051677;9724.70825875225;13989.300534973414;14044.438222470986;14146.646333841736;6865.41643960269;8757.518336491554;11338.376389298668;11772.70568235801;11969.64091077269;11962.162648614514;12159.270443773048;12217.755644886875;12284.570040048913;12367.381630918599;12292.262464252173;12335;12404.56584019555;12443.253404795742;12446;8931.642734290555;9029.909700902906;9094.636214551343;9270.814583708154;9291.72124836256;12129.878701212874;12210.938945305217;12281.385930703607;12337;12424.130310878514 10:07:25 INFO - PROCESS | 3427 | |3;mootools.html;1380.558221369161;1530.5484881959824;1604.4464659692405;1745.0489483231638;1851.9444416667495;9062.592183351748;9442.669506567263;9454.527273636326;9618.759531011729;9636.132748052674;9405.012473690249;9604.087611676898;9715.174210192143;9724.124828765409;9724.270679699015;2150.9139634414605;2225.9220927267547;2385.320183747632;2448.657187993678;2476.7523247675267;2496.613024981131;2529.734377890323;2532.025170309435;2533.1767175667887;2538.1877799104295;2436.5857804173334;2514.245726282117;2515.6855393075866;2529.544681957247;2529.582618867885;2086.8643538170045;2341.6019276722827;2373.1100837186054;2431.0154387473103;2434.6591477193206;2434.3670645632264;2455.7175924768703;2459.2376363327426;2459.963100553493;2476.1457297232428;9578;9603.4718090505;9644.324897257195;9658.420494770266;9672.468014259213;5555.972220138914;5725.484706376405;5729.255196824386;5730.34101078373;5736.827895163152;3496.6503349665086;3534.611192768819;3587.587427445851;3611.8916432507067;3644.4168932970597;1125.6285425809544;1134.625573560723;1171.4377098992445;1172.554429316854;1209.7157168065498;13608.523701670492;13613.319334033358;13634.795478067837;13646.317684115853;13654.249016304098;4974.253861920741;5031.320771695848;5101.2603172539775;5101.51535604117;5109.156989096758;11420.31478111316;11479.827802582968;11486.138539609563;11509.654710358702;11510.53957841677;5689.260396148474;5750.712464376848;5758.337791153987;5764.308283005982;5764.625299355613;4572.062727140995;5147.819826306061;5230.843074707689;5261.237120617566;5357.785688572413;4324.718893271927;4340.891477713082;4348.173846969065;4374.715643483163;4384.978075109604;1340.1155237543176;1345.1122259308809;1354.1265883505084;1356.8778809907155;1369.9589012329645;1008.1531513528671;1008.9899101009042;1019.7552587378975;1019.8113349030453;1029.4749677664445;6208.50331973441;6238.844028899314;6255.343188965093;6263.843403914939;6280.968595157086;476.98092076317255;482.879280179955;488.836239859651;493.4744497110566;497.53231961955646;3988;4132.793360331972;4183.518895327015;4210.621044106045;4244.299690551086;11469.770604587862;11510.712232194095;11875.940620297017;11892.345920974256;12006.759864802654;11972.281663100242;12146.635600931986;12147.635570932885;12213.145079844504;12219.144659873902;8733.781655458537;9088.81822363549;9100.907891053115;9126.45241285525;9129.726108216764;6276.1840960676645;6286.52851036165;6380.170577824853;6429.678516074084;6557.606543607399;10967.341959482457;10989.340639561651;11280.605178818701;11313.151513636345;11315.547378105113;11300;11303.265287756269;11462.312261264351;11561.942190288995;11568.24806387582;7758.3017528422715;8360.205780450848;8570.057293697813;8585.613647386008;8711.128887111237;9546.85679714791;9640.951795240979;9654.662086826927;9728.124468797841;9731.756706082404;8408.663653453794;8594.097619750086;8608.440451370641;8626.956865215885;8728.301735861243;7866.095399028956;7913.248241417056;8136.674533018613;8165.714200002972;8391.412601117863;7052.788416347517;7274.818129546804;7275.236100209402;7427.925720742724;7442.144153422426;5233.110371236823;5249.842504724865;5294.391145018372;5331.09371406854;5331.546818520469;5517.944820551743;5525.033119204204;5542.279503664659;5563.944360556343;5618.381977982501 10:07:25 INFO - PROCESS | 3427 | |4;prototype.html;355.38873138202297;356.9214772749995;359.5739049226666;364.47151630136307;367.13539614208554;5438;5456.481634244746;5500.844822587262;5521.723913804309;5555.694436805974;5431.864203394917;5433.429489903562;5445.673259604427;5475.233467314569;5484.670919744808;3919.490466239385;3994.8202330895033;4261.254280500915;4284.186004659105;4293.506246781629;4250.893727656802;4269.993103241487;4270.12462445198;4277.550857159985;4297.376880352347;4104.671626269891;4277.636400905927;4290.97854510727;4291.635211007068;4295.312749960007;4021.934187440331;4235.597618226264;4261.190373828963;4295.334223195409;4303.655707543389;3819.4652748615217;3825.48355971943;3830.7893065881367;3839.712021598363;3858.787766672832;5129.230615407681;5287.86780330491;5302.443243459458;5325.786968521294;5352.357717073937;4902.436219834729;4918.188498897677;4933.260010998343;4936.703797772145;4936.728479933602;5679.829605111853;5696.658200507983;5710.029295019856;5721.628094173865;5727.9427205727825;4009.8571907006362;4172.269852775782;4185.639667108202;4224.070704445017;4240.427542281815;5741.655500669932;5783.421657834267;5845.7369418376275;5881.3530511643685;5888.470037696585;4143.047099167208;4148.605882441163;4167.395727619539;4197.727147735387;4206.558311377323;4159.230542349675;4192.874213773592;4204.642605378516;4266.573342665709;4271.743695378287;4743.739094349775;4771.308160316735;4774.928376074362;4787.4494433140635;4803.639727020487;5643.604947653707;5678.432156784289;5686.744096515667;5744.052231381859;5748.511376533042;1426.764583843675;1443.256722787765;1474.1449959023741;1478.0909740509724;1486.3831509923477;944.7071407863584;948.4830767231738;954.1222075690381;1001.67946257197;1034.5551412892528;5502.174673798882;5509.889802203934;5535.142052981794;5563.5271001964475;5581.6371935824045;5727.627704199213;5763.077907534775;5777.133429985452;5787.479126878517;5797.652140871477;5303;5508.807191748269;5523.558115350762;5542.944570554243;5557.3886872444;3053.572499849978;3054.801437906529;3058.3730335281216;3099.767517436201;3099.8450077496036;5851.210086638334;5921.763129474859;6020.307664618625;6036.637801731822;6057.636541807417;5840.591158618856;5858;5871.236739223874;5907.586468947133;5944.524438044946;6044.395560444008;6087.147799308101;6116.388361163937;6119.5104391648565;6126.571140020156;5573.247611572548;5786.97455890435;5925.466707996301;5925.822225333247;5934.406559344031;5804.73878675469;5821.544613846539;5843.181954526454;5847.736851841592;5851.824445266649;5908.5568582357355;6160.445559899451;6167.5374346925055;6188.845278868064;6205.937940620716;4145.97927010363;4157.376393540993;4171.0615111599645;4181.351890456984;4204.327307630764;5860.853478663067;5931.614445061057;5971.80563887233;5975.342712301556;5988.880222395441;5705;5721.399253078367;5772.39389864075;5776.855578610568;5831.591788574929;5644.463775941279;5692.800751973661;5732.742026608896;5739.426057394227;5755.280589926259;5470.480304371078;5558.555315574825;5662.971685141712;5721.485066343883;5736.5410767139365;5734.197212390185;5737.74180161902;5767.682777447113;5774.797882074276;5796.217815448524;5395.622306438511;5610.971945140412;5611.8877622448135;5613.915791263053;5648.373506319417 10:07:25 INFO - PROCESS | 3427 | |5;yui.html;767.9270469305415;807.7213361390318;811.1685522339601;837.221384112775;914.6524320758112;15085.849141508581;16086.678266434694;16348.918255408722;16430.91784541077;16592.419265325716;14925.776113358308;15395.153266570334;15408.152551609657;15417.152056636909;15434.305456254468;712.985740285194;838.5974732128551;847.4999750147397;851.6848765956605;863.0204717645455;840.1556435782061;842.5871323051691;843.4096132707099;844.9155084491532;845.7547311279721;890.4924193209873;892.2326798952895;897.4570384917129;900.3292547052422;901.1259078693689;742.4951033297356;881.7927786970089;887.1439061305839;892.2505095719627;892.7768057985504;654.2280109470822;656.8817612829689;657.0735263278801;657.3525077798365;657.5364368120463;15241.847581524155;15328.310226039855;15328.386864525517;15335.156566388845;15349.769753453707;14506.1296322221;14626.634334141732;14790.112593244332;14837.629059273604;15041.398344066225;13105.541306054241;13109;13346.399412026385;13394.196348219139;13411.128276662082;4706.811727530929;4713.858584242478;4764.190087685102;4780.282957556395;4857.392825896763;77562.61218693927;80782;80862.19137808605;81781.18218817795;82540;12148;12193.573224937085;12286.324252166216;12371;12454.190477618926;22454.10183592638;22763.886180569323;22796;22802.201922932618;22818.885905570365;8169.754907352789;8311.376646751396;8446.197611226924;8724.825503489894;8736.344774141964;4447.73313601185;4591.311303304531;4643.489216186217;4714.080754252887;4742.881427964259;3646.106703857572;3754.793486358222;3755.061234691327;3756.6055564165918;3759.342115129841;595.8599729063667;598.2103623217398;604.1632339210138;607.805502239288;619.7025427794683;617;647.2297965421134;661.3254480430031;722.2200023974095;722.757876111498;9990.200783937267;10037.33593870732;10107.69676909694;10127.442990635438;10189.745256368502;695.3498478922224;703.3704834173386;705.340506626306;711.9679614417364;760.5018712743162;4504;4581.725096494221;4784.162771514971;4786.593139583105;4813.7593120343845;105891.4705426468;115165;115436;116339.41830290963;116859;98311;100798;101241.49379253057;101523.49238253762;102607.48696256471;58689.70655146697;85293.57353213194;90453;90808.54595727111;90890.54554727185;8940;9014.414063085878;9071.267831927049;9204.493752843659;9265.351425400157;51449.742751286;52555.73722131365;52732.47267527429;52896.73551632217;56177.157342639075;53795.46204537905;68069.6596517034;73592.63203683947;76725.61637191779;78800.05999699877;13468.595942121752;14032.719345613235;14327.283635818376;14330.641733956734;14634.048786828822;14789.408423662933;15394;15742.685146297239;16020.519384418487;16349.591260218589;14528.491502797351;15162;15442.536723898302;15451.227438627799;15626.374945002528;13595.660108496972;13673.658158545719;14045.719085618435;14217.146971181763;14292.35684394184;14155.575332740034;14423.639409014859;14881;15115.093094414371;15176.392944282105;11385.146114041645;11553.24903881245;11630.476628551905;11869.10981676395;11980.10149238828;12026.518939242333;12089.15375923677;12131.696707582028;12350.505979760708;12525.311107889154 10:07:25 INFO - PROCESS | 3427 | __end_tp_report 10:07:25 INFO - PROCESS | 3427 | __start_cc_report 10:07:25 INFO - PROCESS | 3427 | _x_x_mozilla_cycle_collect,907 10:07:25 INFO - PROCESS | 3427 | __end_cc_report 10:07:25 INFO - PROCESS | 3427 | __startTimestamp1468343245072__endTimestamp 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | ------- Summary: start ------- 10:07:25 INFO - PROCESS | 3427 | Number of tests: 6 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#0] dojo.html Cycles:165 Average:5427.00 Median:5593.11 stddev:575.30 (10.3%) stddev-sans-first:553.68 10:07:25 INFO - PROCESS | 3427 | Values: 3357.2 3360.7 3369.5 3392.4 3400.2 5343.1 5419.9 5421.1 5452.7 5477.6 5411.9 5439.5 5465.5 5469.4 5492.9 4858.8 4874.3 4955.0 4967.5 5007.5 4922.4 4983.3 4992.3 5007.3 5030.8 5017.5 5052.7 5117.7 5125.8 5159.5 5073.1 5080.6 5107.3 5115.3 5127.7 4806.8 4929.7 4984.1 4994.9 5035.0 5423.8 5432.0 5455.3 5461.6 5471.6 5539.9 5902.1 5905.4 5906.0 5906.1 5743.3 5779.0 5797.7 5853.6 5904.5 5475.7 5476.5 5477.6 5478.5 5483.3 5748.3 5863.7 5917.0 5962.1 5968.9 5653.7 5774.6 5778.0 5783.9 5785.6 5799.1 5804.3 5852.6 5854.3 5862.3 5568.6 5757.2 5758.4 5767.3 5810.9 5853.1 5863.4 5867.5 5871.9 5878.1 4486.7 4518.9 4527.8 4534.7 4555.2 3957.1 3998.4 4029.1 4037.1 4064.1 5601.9 5610.3 5616.4 5622.5 5658.1 5643.9 5888.5 5897.9 5902.6 5911.9 5485.8 5521.1 5524.4 5553.8 5574.3 5017.5 5026.1 5027.5 5048.2 5061.7 5819.3 5970.2 6083.4 6120.2 6122.8 5762.1 5839.7 5851.5 5854.5 5856.0 6071.1 6079.6 6081.5 6082.8 6085.6 5576.4 5632.0 5665.7 5723.8 5724.8 5834.8 5837.6 5840.9 5842.6 5865.4 5692.3 5698.8 5701.7 5707.3 5707.7 5539.6 5562.0 5583.4 5602.7 5676.0 5561.7 5593.1 5596.2 5602.5 5613.9 5680.9 5697.1 5707.2 5736.2 5741.6 5410.9 5458.2 5502.9 5517.4 5557.5 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#1] ext.html Cycles:180 Average:67111.79 Median:40411.24 stddev:139741.21 (345.8%) stddev-sans-first:140043.98 10:07:25 INFO - PROCESS | 3427 | Values: 594.9 636.4 639.0 653.5 662.7 34248.0 36653.5 36721.4 36725.4 36775.8 48530.8 50229.5 50245.5 53906.0 54088.5 9152.7 9268.9 9269.8 9286.9 9295.4 8446.7 8705.6 9161.5 9266.6 9269.7 11036.3 11296.6 11299.5 11601.2 11606.7 11064.5 11129.9 11139.8 11146.9 11151.2 8665.8 10683.7 10973.1 11015.6 11040.2 45050.3 45411.3 45443.5 45463.0 45567.8 3480.6 3585.8 3659.9 3737.3 4133.3 34733.5 34934.3 35232.6 35512.5 35604.3 4281.0 4345.5 4447.8 4528.0 4533.6 386017.0 386970.0 387303.0 387747.0 388005.0 64511.0 64610.4 64775.0 64833.7 64882.1 39312.8 41038.0 41056.6 43064.6 43125.0 17813.5 17838.6 17942.1 18041.0 18082.8 14302.4 14473.3 14473.4 14497.2 14692.6 19024.6 20424.6 21933.5 22153.7 22208.9 7355.7 7385.2 7388.4 7412.8 7463.7 1001.5 1059.6 1078.7 1136.9 1176.2 34784.8 35520.3 36910.0 37102.4 37830.6 1156.8 1211.2 1226.6 1230.1 1255.2 17739.3 17922.4 18074.8 18300.7 18394.5 682957.0 687095.0 688393.0 690044.0 693575.0 64984.0 65483.0 65562.7 65623.3 65675.0 1363.8 1472.2 1473.4 1516.2 1528.8 34192.5 34743.7 35410.8 35783.0 35864.8 54988.0 55330.4 55886.2 55998.4 56010.4 444221.0 448077.0 448435.0 448718.0 448994.0 27071.2 27119.5 27450.2 27652.9 27790.0 50735.0 51349.5 52528.7 52770.0 52866.5 43304.4 43328.8 43667.8 43704.8 43728.8 43207.4 43549.1 44004.0 44150.8 44961.8 43359.3 44477.6 45966.5 46132.0 48599.3 38855.4 40346.5 40476.0 40826.4 41334.6 29434.1 29440.0 29669.0 29727.0 29895.0 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#2] jquery.html Cycles:180 Average:30314.80 Median:24627.69 stddev:73861.36 (299.9%) stddev-sans-first:74034.42 10:07:25 INFO - PROCESS | 3427 | Values: 403.7 421.3 421.7 425.6 438.6 18830.4 20281.2 20545.5 20826.9 21400.1 20009.3 20308.5 20446.4 20681.5 20706.7 5676.9 5869.1 5922.4 5926.0 5934.6 4131.4 5786.0 5799.4 6148.4 6503.3 6498.6 6507.2 6546.1 6594.3 6607.1 6325.8 6420.6 6474.2 6514.6 6515.1 3867.8 5354.6 5661.4 5663.4 5700.3 24481.9 24623.6 24631.8 25042.6 25107.9 2344.6 2559.1 2570.9 2768.7 2876.3 14496.8 15648.2 15716.9 16348.2 16512.3 2039.7 2099.7 2119.5 2156.8 2178.5 98149.0 105324.0 106311.9 107954.0 108006.5 18640.6 19266.8 19398.1 19709.4 20251.2 35347.0 35601.3 36221.3 36244.5 36284.0 9938.3 10464.1 10512.7 10545.3 10568.7 8591.1 8607.4 8674.0 8847.6 8868.5 9419.4 9424.7 9470.6 9817.5 9867.5 3032.5 3574.2 3740.7 3750.6 3831.3 999.2 1085.7 1090.6 1105.5 1138.4 19603.3 19705.8 19756.9 19926.9 20052.8 1033.9 1080.7 1087.7 1098.1 1125.5 10782.2 11214.2 11304.8 11317.3 11397.2 385174.0 386276.0 388399.0 507779.0 515417.0 100169.0 100230.0 100803.5 103712.0 117243.0 1102.8 1104.3 1128.1 1145.5 1149.2 18560.8 18754.3 18799.5 18836.7 19079.3 44512.9 45983.8 46107.5 46115.8 46551.8 65050.3 65513.7 65519.3 65751.7 65897.7 8163.0 8439.7 8981.1 9055.4 9064.8 6986.3 9724.7 13989.3 14044.4 14146.6 6865.4 8757.5 11338.4 11772.7 11969.6 11962.2 12159.3 12217.8 12284.6 12367.4 12292.3 12335.0 12404.6 12443.3 12446.0 8931.6 9029.9 9094.6 9270.8 9291.7 12129.9 12210.9 12281.4 12337.0 12424.1 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#3] mootools.html Cycles:180 Average:6288.35 Median:2524.52 stddev:3700.16 (146.6%) stddev-sans-first:3692.16 10:07:25 INFO - PROCESS | 3427 | Values: 1380.6 1530.5 1604.4 1745.0 1851.9 9062.6 9442.7 9454.5 9618.8 9636.1 9405.0 9604.1 9715.2 9724.1 9724.3 2150.9 2225.9 2385.3 2448.7 2476.8 2496.6 2529.7 2532.0 2533.2 2538.2 2436.6 2514.2 2515.7 2529.5 2529.6 2086.9 2341.6 2373.1 2431.0 2434.7 2434.4 2455.7 2459.2 2460.0 2476.1 9578.0 9603.5 9644.3 9658.4 9672.5 5556.0 5725.5 5729.3 5730.3 5736.8 3496.7 3534.6 3587.6 3611.9 3644.4 1125.6 1134.6 1171.4 1172.6 1209.7 13608.5 13613.3 13634.8 13646.3 13654.2 4974.3 5031.3 5101.3 5101.5 5109.2 11420.3 11479.8 11486.1 11509.7 11510.5 5689.3 5750.7 5758.3 5764.3 5764.6 4572.1 5147.8 5230.8 5261.2 5357.8 4324.7 4340.9 4348.2 4374.7 4385.0 1340.1 1345.1 1354.1 1356.9 1370.0 1008.2 1009.0 1019.8 1019.8 1029.5 6208.5 6238.8 6255.3 6263.8 6281.0 477.0 482.9 488.8 493.5 497.5 3988.0 4132.8 4183.5 4210.6 4244.3 11469.8 11510.7 11875.9 11892.3 12006.8 11972.3 12146.6 12147.6 12213.1 12219.1 8733.8 9088.8 9100.9 9126.5 9129.7 6276.2 6286.5 6380.2 6429.7 6557.6 10967.3 10989.3 11280.6 11313.2 11315.5 11300.0 11303.3 11462.3 11561.9 11568.2 7758.3 8360.2 8570.1 8585.6 8711.1 9546.9 9641.0 9654.7 9728.1 9731.8 8408.7 8594.1 8608.4 8627.0 8728.3 7866.1 7913.2 8136.7 8165.7 8391.4 7052.8 7274.8 7275.2 7427.9 7442.1 5233.1 5249.8 5294.4 5331.1 5331.5 5517.9 5525.0 5542.3 5563.9 5618.4 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#4] prototype.html Cycles:180 Average:4817.69 Median:5515.81 stddev:1414.25 (25.6%) stddev-sans-first:1377.99 10:07:25 INFO - PROCESS | 3427 | Values: 355.4 356.9 359.6 364.5 367.1 5438.0 5456.5 5500.8 5521.7 5555.7 5431.9 5433.4 5445.7 5475.2 5484.7 3919.5 3994.8 4261.3 4284.2 4293.5 4250.9 4270.0 4270.1 4277.6 4297.4 4104.7 4277.6 4291.0 4291.6 4295.3 4021.9 4235.6 4261.2 4295.3 4303.7 3819.5 3825.5 3830.8 3839.7 3858.8 5129.2 5287.9 5302.4 5325.8 5352.4 4902.4 4918.2 4933.3 4936.7 4936.7 5679.8 5696.7 5710.0 5721.6 5727.9 4009.9 4172.3 4185.6 4224.1 4240.4 5741.7 5783.4 5845.7 5881.4 5888.5 4143.0 4148.6 4167.4 4197.7 4206.6 4159.2 4192.9 4204.6 4266.6 4271.7 4743.7 4771.3 4774.9 4787.4 4803.6 5643.6 5678.4 5686.7 5744.1 5748.5 1426.8 1443.3 1474.1 1478.1 1486.4 944.7 948.5 954.1 1001.7 1034.6 5502.2 5509.9 5535.1 5563.5 5581.6 5727.6 5763.1 5777.1 5787.5 5797.7 5303.0 5508.8 5523.6 5542.9 5557.4 3053.6 3054.8 3058.4 3099.8 3099.8 5851.2 5921.8 6020.3 6036.6 6057.6 5840.6 5858.0 5871.2 5907.6 5944.5 6044.4 6087.1 6116.4 6119.5 6126.6 5573.2 5787.0 5925.5 5925.8 5934.4 5804.7 5821.5 5843.2 5847.7 5851.8 5908.6 6160.4 6167.5 6188.8 6205.9 4146.0 4157.4 4171.1 4181.4 4204.3 5860.9 5931.6 5971.8 5975.3 5988.9 5705.0 5721.4 5772.4 5776.9 5831.6 5644.5 5692.8 5732.7 5739.4 5755.3 5470.5 5558.6 5663.0 5721.5 5736.5 5734.2 5737.7 5767.7 5774.8 5796.2 5395.6 5611.0 5611.9 5613.9 5648.4 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - PROCESS | 3427 | [#5] yui.html Cycles:180 Average:21166.43 Median:4586.52 stddev:29895.92 (651.8%) stddev-sans-first:29940.55 10:07:25 INFO - PROCESS | 3427 | Values: 767.9 807.7 811.2 837.2 914.7 15085.8 16086.7 16348.9 16430.9 16592.4 14925.8 15395.2 15408.2 15417.2 15434.3 713.0 838.6 847.5 851.7 863.0 840.2 842.6 843.4 844.9 845.8 890.5 892.2 897.5 900.3 901.1 742.5 881.8 887.1 892.3 892.8 654.2 656.9 657.1 657.4 657.5 15241.8 15328.3 15328.4 15335.2 15349.8 14506.1 14626.6 14790.1 14837.6 15041.4 13105.5 13109.0 13346.4 13394.2 13411.1 4706.8 4713.9 4764.2 4780.3 4857.4 77562.6 80782.0 80862.2 81781.2 82540.0 12148.0 12193.6 12286.3 12371.0 12454.2 22454.1 22763.9 22796.0 22802.2 22818.9 8169.8 8311.4 8446.2 8724.8 8736.3 4447.7 4591.3 4643.5 4714.1 4742.9 3646.1 3754.8 3755.1 3756.6 3759.3 595.9 598.2 604.2 607.8 619.7 617.0 647.2 661.3 722.2 722.8 9990.2 10037.3 10107.7 10127.4 10189.7 695.3 703.4 705.3 712.0 760.5 4504.0 4581.7 4784.2 4786.6 4813.8 105891.5 115165.0 115436.0 116339.4 116859.0 98311.0 100798.0 101241.5 101523.5 102607.5 58689.7 85293.6 90453.0 90808.5 90890.5 8940.0 9014.4 9071.3 9204.5 9265.4 51449.7 52555.7 52732.5 52896.7 56177.2 53795.5 68069.7 73592.6 76725.6 78800.1 13468.6 14032.7 14327.3 14330.6 14634.0 14789.4 15394.0 15742.7 16020.5 16349.6 14528.5 15162.0 15442.5 15451.2 15626.4 13595.7 13673.7 14045.7 14217.1 14292.4 14155.6 14423.6 14881.0 15115.1 15176.4 11385.1 11553.2 11630.5 11869.1 11980.1 12026.5 12089.2 12131.7 12350.5 12525.3 10:07:25 INFO - PROCESS | 3427 | -------- Summary: end -------- 10:07:25 INFO - PROCESS | 3427 | 10:07:25 INFO - TEST-INFO | 3427: exit 0 10:07:25 INFO - TEST-OK | dromaeo_css | took 1113483ms 10:07:25 INFO - TEST-START | kraken 10:07:25 INFO - operating with platform_type : linux_ 10:07:25 INFO - Initialising browser for kraken test... 10:07:25 INFO - TEST-INFO | started process 3615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbeEXzz/profile http://localhost:55871/getInfo.html) 10:07:29 INFO - PROCESS | 3615 | __metrics Screen width/height:1600/1200 10:07:29 INFO - PROCESS | 3615 | colorDepth:24 10:07:29 INFO - PROCESS | 3615 | Browser inner width/height: 1024/697 10:07:29 INFO - PROCESS | 3615 | __metrics 10:07:30 ERROR - PROCESS | 3615 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:31 INFO - TEST-INFO | 3615: exit 0 10:07:31 INFO - Browser initialized. 10:07:31 INFO - Running cycle 1/1 for kraken test... 10:07:31 INFO - TEST-INFO | started process 3709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbeEXzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:43 INFO - PROCESS | 3709 | RSS: Main: 145444864 10:07:43 INFO - PROCESS | 3709 | 10:07:45 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55871/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:46 INFO - PROCESS | 3709 | RSS: Main: 195035136 10:07:46 INFO - PROCESS | 3709 | 10:07:49 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55871/tests/kraken/driver.html?testName=audio-dft) 10:07:50 INFO - PROCESS | 3709 | RSS: Main: 192311296 10:07:50 INFO - PROCESS | 3709 | 10:07:52 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55871/tests/kraken/driver.html?testName=audio-fft) 10:07:53 INFO - PROCESS | 3709 | RSS: Main: 278867968 10:07:53 INFO - PROCESS | 3709 | 10:07:55 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55871/tests/kraken/driver.html?testName=audio-oscillator) 10:07:56 INFO - PROCESS | 3709 | RSS: Main: 187682816 10:07:56 INFO - PROCESS | 3709 | 10:07:58 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:58 INFO - PROCESS | 3709 | RSS: Main: 187744256 10:07:58 INFO - PROCESS | 3709 | 10:08:01 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55871/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:02 INFO - PROCESS | 3709 | RSS: Main: 223739904 10:08:02 INFO - PROCESS | 3709 | 10:08:05 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55871/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:06 INFO - PROCESS | 3709 | RSS: Main: 221495296 10:08:06 INFO - PROCESS | 3709 | 10:08:09 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55871/tests/kraken/driver.html?testName=json-parse-financial) 10:08:09 INFO - PROCESS | 3709 | RSS: Main: 221995008 10:08:09 INFO - PROCESS | 3709 | 10:08:11 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:11 INFO - PROCESS | 3709 | RSS: Main: 200081408 10:08:11 INFO - PROCESS | 3709 | 10:08:13 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:14 INFO - PROCESS | 3709 | RSS: Main: 201302016 10:08:14 INFO - PROCESS | 3709 | 10:08:16 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:16 INFO - PROCESS | 3709 | RSS: Main: 209887232 10:08:16 INFO - PROCESS | 3709 | 10:08:19 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:20 INFO - PROCESS | 3709 | RSS: Main: 215891968 10:08:20 INFO - PROCESS | 3709 | 10:08:22 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:23 INFO - PROCESS | 3709 | RSS: Main: 213688320 10:08:23 INFO - PROCESS | 3709 | 10:08:24 INFO - PROCESS | 3709 | Cycle 1(1): loaded http://localhost:55871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55871/tests/kraken/driver.html?testName=ai-astar) 10:08:25 INFO - PROCESS | 3709 | RSS: Main: 256012288 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | __start_tp_report 10:08:25 INFO - PROCESS | 3709 | _x_x_mozilla_page_load 10:08:25 INFO - PROCESS | 3709 | _x_x_mozilla_page_load_details 10:08:25 INFO - PROCESS | 3709 | |i|pagename|runs| 10:08:25 INFO - PROCESS | 3709 | |0;ai-astar;110;105;109;111;110;110;110;109;110;110 10:08:25 INFO - PROCESS | 3709 | |1;audio-beat-detection;154;126;126;178;125;129;153;131;176;122 10:08:25 INFO - PROCESS | 3709 | |2;audio-dft;160;160;160;160;160;160;159;161;160;161 10:08:25 INFO - PROCESS | 3709 | |3;audio-fft;76;74;76;111;76;75;79;75;104;75 10:08:25 INFO - PROCESS | 3709 | |4;audio-oscillator;87;87;127;87;87;86;114;86;88;128 10:08:25 INFO - PROCESS | 3709 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;117;117;117 10:08:25 INFO - PROCESS | 3709 | |6;imaging-darkroom;146;145;145;146;145;146;146;145;146;145 10:08:25 INFO - PROCESS | 3709 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;96;96 10:08:25 INFO - PROCESS | 3709 | |8;json-parse-financial;52;48;50;50;50;51;50;51;51;50 10:08:25 INFO - PROCESS | 3709 | |9;json-stringify-tinderbox;60;59;60;61;59;59;60;59;60;60 10:08:25 INFO - PROCESS | 3709 | |10;stanford-crypto-aes;75;75;76;75;78;78;78;78;112;77 10:08:25 INFO - PROCESS | 3709 | |11;stanford-crypto-ccm;117;122;117;122;128;114;115;131;129;119 10:08:25 INFO - PROCESS | 3709 | |12;stanford-crypto-pbkdf2;154;154;152;153;155;152;151;151;151;150 10:08:25 INFO - PROCESS | 3709 | |13;stanford-crypto-sha256-iterative;63;65;60;61;61;65;64;61;60;60 10:08:25 INFO - PROCESS | 3709 | __end_tp_report 10:08:25 INFO - PROCESS | 3709 | __start_cc_report 10:08:25 INFO - PROCESS | 3709 | _x_x_mozilla_cycle_collect,1574 10:08:25 INFO - PROCESS | 3709 | __end_cc_report 10:08:25 INFO - PROCESS | 3709 | __startTimestamp1468343305131__endTimestamp 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | ------- Summary: start ------- 10:08:25 INFO - PROCESS | 3709 | Number of tests: 14 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.73 10:08:25 INFO - PROCESS | 3709 | Values: 110.0 105.0 109.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.00 stddev:21.62 (15.2%) stddev-sans-first:22.49 10:08:25 INFO - PROCESS | 3709 | Values: 154.0 126.0 126.0 178.0 125.0 129.0 153.0 131.0 176.0 122.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:08:25 INFO - PROCESS | 3709 | Values: 160.0 160.0 160.0 160.0 160.0 160.0 159.0 161.0 160.0 161.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.55 (17.9%) stddev-sans-first:14.19 10:08:25 INFO - PROCESS | 3709 | Values: 76.0 74.0 76.0 111.0 76.0 75.0 79.0 75.0 104.0 75.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:87.00 stddev:17.85 (20.5%) stddev-sans-first:18.51 10:08:25 INFO - PROCESS | 3709 | Values: 87.0 87.0 127.0 87.0 87.0 86.0 114.0 86.0 88.0 128.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:08:25 INFO - PROCESS | 3709 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 10:08:25 INFO - PROCESS | 3709 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:08:25 INFO - PROCESS | 3709 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.50 stddev:1.06 (2.1%) stddev-sans-first:0.93 10:08:25 INFO - PROCESS | 3709 | Values: 52.0 48.0 50.0 50.0 50.0 51.0 50.0 51.0 51.0 50.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:08:25 INFO - PROCESS | 3709 | Values: 60.0 59.0 60.0 61.0 59.0 59.0 60.0 59.0 60.0 60.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:77.50 stddev:11.25 (14.5%) stddev-sans-first:11.78 10:08:25 INFO - PROCESS | 3709 | Values: 75.0 75.0 76.0 75.0 78.0 78.0 78.0 78.0 112.0 77.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.00 stddev:6.10 (5.0%) stddev-sans-first:6.25 10:08:25 INFO - PROCESS | 3709 | Values: 117.0 122.0 117.0 122.0 128.0 114.0 115.0 131.0 129.0 119.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:152.50 stddev:1.64 (1.1%) stddev-sans-first:1.62 10:08:25 INFO - PROCESS | 3709 | Values: 154.0 154.0 152.0 153.0 155.0 152.0 151.0 151.0 151.0 150.0 10:08:25 INFO - PROCESS | 3709 | 10:08:25 INFO - PROCESS | 3709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:2.05 (3.3%) stddev-sans-first:2.15 10:08:25 INFO - PROCESS | 3709 | Values: 63.0 65.0 60.0 61.0 61.0 65.0 64.0 61.0 60.0 60.0 10:08:25 INFO - PROCESS | 3709 | -------- Summary: end -------- 10:08:25 INFO - PROCESS | 3709 | 10:08:26 INFO - TEST-INFO | 3709: exit 0 10:08:26 INFO - TEST-OK | kraken | took 60307ms 10:08:26 INFO - SUITE-END | took 1173s 10:08:26 INFO - Completed test suite (00:19:34) 10:08:26 INFO - javascript benchmark 10:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.1774915145793, 3360.7143392811604, 3369.5114208439777, 3392.389369913418, 3400.1839558505967, 5343.064963631364, 5419.945800541994, 5421.078416669166, 5452.672839629625, 5477.643953143043, 5411.891762164754, 5439.4832490913395, 5465.508104270615, 5469.425710300421, 5492.917606235909, 4858.757062146896, 4874.317595536628, 4954.950450495485, 4967.50324967504, 5007.549320561149, 4922.409310882681, 4983.302337672729, 4992.251162325644, 5007.298978143063, 5030.82392116276, 5017.523335283142, 5052.722100284483, 5117.7185254810975, 5125.769340379692, 5159.484051594848, 5073.086844368012, 5080.568151707109, 5107.310513080743, 5115.309433226504, 5127.743612819381, 4806.831760888387, 4929.679570827885, 4984.127777638899, 4994.850154495334, 5034.974825125851, 5423.7830486780485, 5432.022235997519, 5455.290812194389, 5461.617686761928, 5471.616986810925, 5539.944600553983, 5902.144189092601, 5905.438983296623, 5906.0, 5906.143609176688, 5743.253377060955, 5779.0, 5797.710114494258, 5853.619514731528, 5904.468597826173, 5475.7262136893, 5476.534494567926, 5477.589180811455, 5478.506934375885, 5483.341998960111, 5748.310202775694, 5863.70681465925, 5916.970415147896, 5962.105684147413, 5968.850778730566, 5653.689047102449, 5774.595778295479, 5778.046622307356, 5783.913241301384, 5785.595008349375, 5799.130130480377, 5804.2744656917885, 5852.619579727304, 5854.326752423441, 5862.267216597926, 5568.554515638739, 5757.193992841006, 5758.395368486333, 5767.336756272998, 5810.88378232433, 5853.122031695195, 5863.355030946593, 5867.530597552186, 5871.941280587225, 5878.11828225761, 4486.66350023743, 4518.932216016762, 4527.796249168795, 4534.682572219913, 4555.20283950314, 3957.109650328711, 3998.360262358067, 4029.133736246721, 4037.1118353962083, 4064.065264989069, 5601.915971260434, 5610.326760788732, 5616.382197958222, 5622.522085622686, 5658.094704847204, 5643.943560564424, 5888.499477544371, 5897.911531327033, 5902.557308201902, 5911.881762364728, 5485.753141108659, 5521.1442226454965, 5524.392316845144, 5553.750081246354, 5574.275344205227, 5017.523335283142, 5026.09530284545, 5027.522385373383, 5048.217526283432, 5061.6962982221185, 5819.272590926134, 5970.164177015221, 6083.361247069082, 6120.1737765401995, 6122.7857025004805, 5762.135679648086, 5839.744454942208, 5851.531877449709, 5854.531637469077, 5856.0, 6071.058985857199, 6079.574429790049, 6081.513478921587, 6082.847928801639, 6085.604435711664, 5576.358718747234, 5631.971840140773, 5665.716714164358, 5723.828285151452, 5724.79963201286, 5834.795782147605, 5837.562182836389, 5840.883182336414, 5842.649441033552, 5865.4134586541, 5692.260006199168, 5698.8290351289525, 5701.657900525982, 5707.286589176353, 5707.686077265625, 5539.556835453073, 5561.972190139023, 5583.35791383996, 5602.747876345656, 5676.0, 5561.749721262472, 5593.105103183471, 5596.188552659923, 5602.4957753802355, 5613.943860561342, 5680.943190568041, 5697.059985102577, 5707.229524014205, 5736.225609542658, 5741.598088133791, 5410.945890541044, 5458.181272809111, 5502.944970550403, 5517.36550296705, 5557.472040156179], "value": 5391.662713804971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.9434803693648, 636.3604577399716, 638.9968050159749, 653.4772182254197, 662.7084083003481, 34248.0, 36653.45019824702, 36721.449178262345, 36725.44911826321, 36775.81612091942, 48530.75734621331, 50229.497705022935, 50245.49754502454, 53906.0, 54088.459115408834, 9152.725418237447, 9268.907310926905, 9269.768255793626, 9286.860697089549, 9295.39579927306, 8446.704365347214, 8705.564721763887, 9161.450312981242, 9266.629334826632, 9269.675561355354, 11036.282641628308, 11296.604618838343, 11299.49152288149, 11601.245919015279, 11606.651800445958, 11064.502097405595, 11129.944350278278, 11139.832902506469, 11146.888531114666, 11151.219414640978, 8665.826683466295, 10683.679489615324, 10973.122150227962, 11015.614453494089, 11040.227184097117, 45050.32424513635, 45411.31883021758, 45443.54556454426, 45463.0, 45567.77216113931, 3480.6345333739846, 3585.820708964541, 3659.9451008234896, 3737.289914916157, 4133.276676581586, 34733.47899781505, 34934.30131397358, 35232.64767352319, 35512.467312990324, 35604.28791424183, 4280.978595107004, 4345.521992580813, 4447.822087116511, 4528.02647430804, 4533.591976722078, 386017.0, 386970.0, 387303.0, 387747.0, 388005.0, 64511.0, 64610.35389646043, 64775.0, 64833.67583162054, 64882.10707357574, 39312.803435982634, 41038.0, 41056.58943410528, 43064.569354306055, 43125.0, 17813.46559603214, 17838.5540361492, 17942.102894855205, 18041.007744574174, 18082.819171808376, 14302.427902883976, 14473.348699308557, 14473.421063157566, 14497.20265385414, 14692.632684182767, 19024.619507609772, 20424.591508169753, 21933.451663708216, 22153.66769498459, 22208.888955555118, 7355.675978323953, 7385.22455142213, 7388.44586656003, 7412.814679633052, 7463.738769143054, 1001.464216644092, 1059.5655781129853, 1078.692572616816, 1136.8806275341135, 1176.2178151529308, 34784.82607586946, 35520.28959420797, 36909.96995165238, 37102.417144281084, 37830.62169378271, 1156.7917774800617, 1211.1885037025215, 1226.6013545597716, 1230.0958795285458, 1255.2029461291963, 17739.29042838272, 17922.372716955106, 18074.819251807578, 18300.725489117674, 18394.540136496693, 682957.0, 687095.0, 688393.0, 690044.0, 693575.0, 64984.0, 65483.0, 65562.67218663877, 65623.34376656268, 65675.0, 1363.7749771287824, 1472.2197235465221, 1473.3811799044427, 1516.1888389711671, 1528.7859699642058, 34192.487112692834, 34743.65256347404, 35410.822945885106, 35783.0, 35864.82067589645, 54988.0, 55330.446695532526, 55886.16170757523, 55998.44001560095, 56010.439895600524, 444221.0, 448077.0, 448435.0, 448718.0, 448994.0, 27071.1878643641, 27119.45761084807, 27450.176494705192, 27652.861735691193, 27790.0, 50735.0, 51349.48650513447, 52528.73735631297, 52770.0, 52866.47133528616, 43304.350434744134, 43328.78335608428, 43667.78166109149, 43704.781476092416, 43728.82536429064, 43207.35188972105, 43549.129017420106, 44004.0, 44150.779246103564, 44961.77519112384, 43359.34960975651, 44477.555224447344, 45966.540334597565, 46132.0, 48599.27101093416, 38855.41716874306, 40346.47550776607, 40476.0, 40826.38760418655, 41334.586654133076, 29434.11697649074, 29440.0, 29669.0, 29727.0, 29895.0], "value": 21605.70288797302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.7436227995222, 421.3111562595156, 421.6900578075112, 425.56167147837726, 438.55705737205415, 18830.435086947396, 20281.18875244992, 20545.486362840937, 20826.89586552065, 21400.14399424021, 20009.299674511396, 20308.492287692814, 20446.386608401735, 20681.482962925933, 20706.68939965902, 5676.858078548028, 5869.060950247961, 5922.407759224065, 5926.02220633595, 5934.554908381867, 4131.400946862703, 5786.045302525099, 5799.3620701722775, 6148.446639802417, 6503.349665033506, 6498.642574658392, 6507.154069970898, 6546.149000629912, 6594.340565943416, 6607.141071660677, 6325.810225693236, 6420.58266212697, 6474.158359413246, 6514.609123452608, 6515.087887695727, 3867.8259478323544, 5354.598405119593, 5661.405552417019, 5663.377028526858, 5700.315962084576, 24481.877590611934, 24623.630645540332, 24631.753682463306, 25042.624360634603, 25107.87446062776, 2344.6365813298794, 2559.091522509501, 2570.897164113433, 2768.695443501213, 2876.3096856754228, 14496.782548261785, 15648.217589120499, 15716.92141539285, 16348.182590870529, 16512.25694843735, 2039.7042428847733, 2099.737532808399, 2119.5442979759428, 2156.7519735230335, 2178.455386153462, 98149.0, 105324.0, 106311.93688063175, 107954.0, 108006.45996770044, 18640.627187456175, 19266.807331926782, 19398.127084280957, 19709.408717738203, 20251.189952402034, 35347.0, 35601.28797424089, 36221.27557448836, 36244.45633315502, 36284.0, 9938.254630902567, 10464.11055060313, 10512.737181570368, 10545.261831671709, 10568.682939511827, 8591.09793471689, 8607.440516366416, 8673.956630216808, 8847.646094156291, 8868.512231827182, 9419.387739796892, 9424.670136545188, 9470.621175153054, 9817.509124543887, 9867.457289848984, 3032.454158251536, 3574.195805943694, 3740.6633402993316, 3750.6061863503937, 3831.2912111259507, 999.1856636840952, 1085.7122862441458, 1090.6019302954364, 1105.5190991918541, 1138.3909608359488, 19603.31388401399, 19705.802941970684, 19756.90121549412, 19926.900365498368, 20052.799472005092, 1033.9017793309624, 1080.6920027792198, 1087.6845714742794, 1098.0831006109988, 1125.4991528769783, 10782.245242833083, 11214.158938079514, 11304.830427543593, 11317.320960742381, 11397.202195846212, 385174.0, 386276.0, 388399.0, 507779.0, 515417.0, 100169.0, 100230.0, 100803.49598251961, 103712.0, 117243.0, 1102.80149573076, 1104.3373975614727, 1128.0975219824109, 1145.4902568357002, 1149.1955631058293, 18560.81439185645, 18754.343597974006, 18799.530011749815, 18836.717449238546, 19079.332223372116, 44512.88717782081, 45983.77008114938, 46107.53892461032, 46115.769421152676, 46551.76724116493, 65050.34949650443, 65513.67243163754, 65519.34480655323, 65751.67124164349, 65897.67051164714, 8162.959185204036, 8439.70461033861, 8981.14679105484, 9055.411398259092, 9064.818703626022, 6986.336298051677, 9724.70825875225, 13989.300534973414, 14044.438222470986, 14146.646333841736, 6865.41643960269, 8757.518336491554, 11338.376389298668, 11772.70568235801, 11969.64091077269, 11962.162648614514, 12159.270443773048, 12217.755644886875, 12284.570040048913, 12367.381630918599, 12292.262464252173, 12335.0, 12404.56584019555, 12443.253404795742, 12446.0, 8931.642734290555, 9029.909700902906, 9094.636214551343, 9270.814583708154, 9291.72124836256, 12129.878701212874, 12210.938945305217, 12281.385930703607, 12337.0, 12424.130310878514], "value": 10618.964416265013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.558221369161, 1530.5484881959824, 1604.4464659692405, 1745.0489483231638, 1851.9444416667495, 9062.592183351748, 9442.669506567263, 9454.527273636326, 9618.759531011729, 9636.132748052674, 9405.012473690249, 9604.087611676898, 9715.174210192143, 9724.124828765409, 9724.270679699015, 2150.9139634414605, 2225.9220927267547, 2385.320183747632, 2448.657187993678, 2476.7523247675267, 2496.613024981131, 2529.734377890323, 2532.025170309435, 2533.1767175667887, 2538.1877799104295, 2436.5857804173334, 2514.245726282117, 2515.6855393075866, 2529.544681957247, 2529.582618867885, 2086.8643538170045, 2341.6019276722827, 2373.1100837186054, 2431.0154387473103, 2434.6591477193206, 2434.3670645632264, 2455.7175924768703, 2459.2376363327426, 2459.963100553493, 2476.1457297232428, 9578.0, 9603.4718090505, 9644.324897257195, 9658.420494770266, 9672.468014259213, 5555.972220138914, 5725.484706376405, 5729.255196824386, 5730.34101078373, 5736.827895163152, 3496.6503349665086, 3534.611192768819, 3587.587427445851, 3611.8916432507067, 3644.4168932970597, 1125.6285425809544, 1134.625573560723, 1171.4377098992445, 1172.554429316854, 1209.7157168065498, 13608.523701670492, 13613.319334033358, 13634.795478067837, 13646.317684115853, 13654.249016304098, 4974.253861920741, 5031.320771695848, 5101.2603172539775, 5101.51535604117, 5109.156989096758, 11420.31478111316, 11479.827802582968, 11486.138539609563, 11509.654710358702, 11510.53957841677, 5689.260396148474, 5750.712464376848, 5758.337791153987, 5764.308283005982, 5764.625299355613, 4572.062727140995, 5147.819826306061, 5230.843074707689, 5261.237120617566, 5357.785688572413, 4324.718893271927, 4340.891477713082, 4348.173846969065, 4374.715643483163, 4384.978075109604, 1340.1155237543176, 1345.1122259308809, 1354.1265883505084, 1356.8778809907155, 1369.9589012329645, 1008.1531513528671, 1008.9899101009042, 1019.7552587378975, 1019.8113349030453, 1029.4749677664445, 6208.50331973441, 6238.844028899314, 6255.343188965093, 6263.843403914939, 6280.968595157086, 476.98092076317255, 482.879280179955, 488.836239859651, 493.4744497110566, 497.53231961955646, 3988.0, 4132.793360331972, 4183.518895327015, 4210.621044106045, 4244.299690551086, 11469.770604587862, 11510.712232194095, 11875.940620297017, 11892.345920974256, 12006.759864802654, 11972.281663100242, 12146.635600931986, 12147.635570932885, 12213.145079844504, 12219.144659873902, 8733.781655458537, 9088.81822363549, 9100.907891053115, 9126.45241285525, 9129.726108216764, 6276.1840960676645, 6286.52851036165, 6380.170577824853, 6429.678516074084, 6557.606543607399, 10967.341959482457, 10989.340639561651, 11280.605178818701, 11313.151513636345, 11315.547378105113, 11300.0, 11303.265287756269, 11462.312261264351, 11561.942190288995, 11568.24806387582, 7758.3017528422715, 8360.205780450848, 8570.057293697813, 8585.613647386008, 8711.128887111237, 9546.85679714791, 9640.951795240979, 9654.662086826927, 9728.124468797841, 9731.756706082404, 8408.663653453794, 8594.097619750086, 8608.440451370641, 8626.956865215885, 8728.301735861243, 7866.095399028956, 7913.248241417056, 8136.674533018613, 8165.714200002972, 8391.412601117863, 7052.788416347517, 7274.818129546804, 7275.236100209402, 7427.925720742724, 7442.144153422426, 5233.110371236823, 5249.842504724865, 5294.391145018372, 5331.09371406854, 5331.546818520469, 5517.944820551743, 5525.033119204204, 5542.279503664659, 5563.944360556343, 5618.381977982501], "value": 4888.0303738469365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.38873138202297, 356.9214772749995, 359.5739049226666, 364.47151630136307, 367.13539614208554, 5438.0, 5456.481634244746, 5500.844822587262, 5521.723913804309, 5555.694436805974, 5431.864203394917, 5433.429489903562, 5445.673259604427, 5475.233467314569, 5484.670919744808, 3919.490466239385, 3994.8202330895033, 4261.254280500915, 4284.186004659105, 4293.506246781629, 4250.893727656802, 4269.993103241487, 4270.12462445198, 4277.550857159985, 4297.376880352347, 4104.671626269891, 4277.636400905927, 4290.97854510727, 4291.635211007068, 4295.312749960007, 4021.934187440331, 4235.597618226264, 4261.190373828963, 4295.334223195409, 4303.655707543389, 3819.4652748615217, 3825.48355971943, 3830.7893065881367, 3839.712021598363, 3858.787766672832, 5129.230615407681, 5287.86780330491, 5302.443243459458, 5325.786968521294, 5352.357717073937, 4902.436219834729, 4918.188498897677, 4933.260010998343, 4936.703797772145, 4936.728479933602, 5679.829605111853, 5696.658200507983, 5710.029295019856, 5721.628094173865, 5727.9427205727825, 4009.8571907006362, 4172.269852775782, 4185.639667108202, 4224.070704445017, 4240.427542281815, 5741.655500669932, 5783.421657834267, 5845.7369418376275, 5881.3530511643685, 5888.470037696585, 4143.047099167208, 4148.605882441163, 4167.395727619539, 4197.727147735387, 4206.558311377323, 4159.230542349675, 4192.874213773592, 4204.642605378516, 4266.573342665709, 4271.743695378287, 4743.739094349775, 4771.308160316735, 4774.928376074362, 4787.4494433140635, 4803.639727020487, 5643.604947653707, 5678.432156784289, 5686.744096515667, 5744.052231381859, 5748.511376533042, 1426.764583843675, 1443.256722787765, 1474.1449959023741, 1478.0909740509724, 1486.3831509923477, 944.7071407863584, 948.4830767231738, 954.1222075690381, 1001.67946257197, 1034.5551412892528, 5502.174673798882, 5509.889802203934, 5535.142052981794, 5563.5271001964475, 5581.6371935824045, 5727.627704199213, 5763.077907534775, 5777.133429985452, 5787.479126878517, 5797.652140871477, 5303.0, 5508.807191748269, 5523.558115350762, 5542.944570554243, 5557.3886872444, 3053.572499849978, 3054.801437906529, 3058.3730335281216, 3099.767517436201, 3099.8450077496036, 5851.210086638334, 5921.763129474859, 6020.307664618625, 6036.637801731822, 6057.636541807417, 5840.591158618856, 5858.0, 5871.236739223874, 5907.586468947133, 5944.524438044946, 6044.395560444008, 6087.147799308101, 6116.388361163937, 6119.5104391648565, 6126.571140020156, 5573.247611572548, 5786.97455890435, 5925.466707996301, 5925.822225333247, 5934.406559344031, 5804.73878675469, 5821.544613846539, 5843.181954526454, 5847.736851841592, 5851.824445266649, 5908.5568582357355, 6160.445559899451, 6167.5374346925055, 6188.845278868064, 6205.937940620716, 4145.97927010363, 4157.376393540993, 4171.0615111599645, 4181.351890456984, 4204.327307630764, 5860.853478663067, 5931.614445061057, 5971.80563887233, 5975.342712301556, 5988.880222395441, 5705.0, 5721.399253078367, 5772.39389864075, 5776.855578610568, 5831.591788574929, 5644.463775941279, 5692.800751973661, 5732.742026608896, 5739.426057394227, 5755.280589926259, 5470.480304371078, 5558.555315574825, 5662.971685141712, 5721.485066343883, 5736.5410767139365, 5734.197212390185, 5737.74180161902, 5767.682777447113, 5774.797882074276, 5796.217815448524, 5395.622306438511, 5610.971945140412, 5611.8877622448135, 5613.915791263053, 5648.373506319417], "value": 4372.161356824461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.9270469305415, 807.7213361390318, 811.1685522339601, 837.221384112775, 914.6524320758112, 15085.849141508581, 16086.678266434694, 16348.918255408722, 16430.91784541077, 16592.419265325716, 14925.776113358308, 15395.153266570334, 15408.152551609657, 15417.152056636909, 15434.305456254468, 712.985740285194, 838.5974732128551, 847.4999750147397, 851.6848765956605, 863.0204717645455, 840.1556435782061, 842.5871323051691, 843.4096132707099, 844.9155084491532, 845.7547311279721, 890.4924193209873, 892.2326798952895, 897.4570384917129, 900.3292547052422, 901.1259078693689, 742.4951033297356, 881.7927786970089, 887.1439061305839, 892.2505095719627, 892.7768057985504, 654.2280109470822, 656.8817612829689, 657.0735263278801, 657.3525077798365, 657.5364368120463, 15241.847581524155, 15328.310226039855, 15328.386864525517, 15335.156566388845, 15349.769753453707, 14506.1296322221, 14626.634334141732, 14790.112593244332, 14837.629059273604, 15041.398344066225, 13105.541306054241, 13109.0, 13346.399412026385, 13394.196348219139, 13411.128276662082, 4706.811727530929, 4713.858584242478, 4764.190087685102, 4780.282957556395, 4857.392825896763, 77562.61218693927, 80782.0, 80862.19137808605, 81781.18218817795, 82540.0, 12148.0, 12193.573224937085, 12286.324252166216, 12371.0, 12454.190477618926, 22454.10183592638, 22763.886180569323, 22796.0, 22802.201922932618, 22818.885905570365, 8169.754907352789, 8311.376646751396, 8446.197611226924, 8724.825503489894, 8736.344774141964, 4447.73313601185, 4591.311303304531, 4643.489216186217, 4714.080754252887, 4742.881427964259, 3646.106703857572, 3754.793486358222, 3755.061234691327, 3756.6055564165918, 3759.342115129841, 595.8599729063667, 598.2103623217398, 604.1632339210138, 607.805502239288, 619.7025427794683, 617.0, 647.2297965421134, 661.3254480430031, 722.2200023974095, 722.757876111498, 9990.200783937267, 10037.33593870732, 10107.69676909694, 10127.442990635438, 10189.745256368502, 695.3498478922224, 703.3704834173386, 705.340506626306, 711.9679614417364, 760.5018712743162, 4504.0, 4581.725096494221, 4784.162771514971, 4786.593139583105, 4813.7593120343845, 105891.4705426468, 115165.0, 115436.0, 116339.41830290963, 116859.0, 98311.0, 100798.0, 101241.49379253057, 101523.49238253762, 102607.48696256471, 58689.70655146697, 85293.57353213194, 90453.0, 90808.54595727111, 90890.54554727185, 8940.0, 9014.414063085878, 9071.267831927049, 9204.493752843659, 9265.351425400157, 51449.742751286, 52555.73722131365, 52732.47267527429, 52896.73551632217, 56177.157342639075, 53795.46204537905, 68069.6596517034, 73592.63203683947, 76725.61637191779, 78800.05999699877, 13468.595942121752, 14032.719345613235, 14327.283635818376, 14330.641733956734, 14634.048786828822, 14789.408423662933, 15394.0, 15742.685146297239, 16020.519384418487, 16349.591260218589, 14528.491502797351, 15162.0, 15442.536723898302, 15451.227438627799, 15626.374945002528, 13595.660108496972, 13673.658158545719, 14045.719085618435, 14217.146971181763, 14292.35684394184, 14155.575332740034, 14423.639409014859, 14881.0, 15115.093094414371, 15176.392944282105, 11385.146114041645, 11553.24903881245, 11630.476628551905, 11869.10981676395, 11980.10149238828, 12026.518939242333, 12089.15375923677, 12131.696707582028, 12350.505979760708, 12525.311107889154], "value": 7834.002140464573, "unit": "score"}], "name": "dromaeo_css", "value": 7691.993450848389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 126.0, 178.0, 125.0, 129.0, 153.0, 131.0, 176.0, 122.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 111.0, 76.0, 75.0, 79.0, 75.0, 104.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 127.0, 87.0, 87.0, 86.0, 114.0, 86.0, 88.0, 128.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 48.0, 50.0, 50.0, 50.0, 51.0, 50.0, 51.0, 51.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 61.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 78.0, 78.0, 78.0, 78.0, 112.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 117.0, 122.0, 128.0, 114.0, 115.0, 131.0, 129.0, 119.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 152.0, 153.0, 155.0, 152.0, 151.0, 151.0, 151.0, 150.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 60.0, 61.0, 61.0, 65.0, 64.0, 61.0, 60.0, 60.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1474.8, "alertThreshold": 2.0}]} 10:08:26 INFO - Return code: 0 10:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:26 ERROR - # TBPL SUCCESS # 10:08:26 INFO - Running post-action listener: _resource_record_post_action 10:08:26 INFO - ##### 10:08:26 INFO - ##### Finished run-tests step (success) 10:08:26 INFO - ##### 10:08:26 INFO - Running post-run listener: _resource_record_post_run 10:08:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7917568; Write bytes: 382279680; Read time: 2248; Write time: 395956 10:08:26 INFO - TinderboxPrint: CPU usage
13.0% 10:08:26 INFO - TinderboxPrint: I/O read bytes / time
7,917,568 / 2,248 10:08:26 INFO - TinderboxPrint: I/O write bytes / time
382,279,680 / 395,956 10:08:26 INFO - TinderboxPrint: CPU idle
8,271.3 (86.9%) 10:08:26 INFO - TinderboxPrint: CPU user
1,194.3 (12.6%) 10:08:26 INFO - TinderboxPrint: Swap in / out
0 / 0 10:08:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 18698240; Read time: 68; Write time: 6216 10:08:26 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6152192; Write bytes: 301174784; Read time: 1860; Write time: 304752 10:08:27 INFO - Running post-run listener: _upload_blobber_files 10:08:27 INFO - Blob upload gear active. 10:08:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:08:27 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'] 10:08:27 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 10:08:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:28 INFO - (blobuploader) - INFO - Done attempting. 10:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:31 INFO - (blobuploader) - INFO - Done attempting. 10:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:32 INFO - (blobuploader) - INFO - Done attempting. 10:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:32 INFO - Return code: 0 10:08:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a996aa44f64579fe4f92963b2676b71ee8508b0a070b8365a583fb2ab0a1f617c78b7dea4c67df14b61dde722ca4524ed47dd45c7184d3f8963cd343483f839a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50b5d015af86eff9fe623773e815d39700936fe36226797c3b3ef4af2284a5dee477362ccd67b0821891a70f2a884bf293f1c50f88401c08360f76b4711ffda7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe94d0fdf685d0572e018ff563f2f25aace3d0bf6348f60d5c7aa251db81d5a906cb5c9c9ee8dcedc61d9ee6b823f73c0accf7dc21629e06ad0cfdecaa8c3c69"} 10:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:32 INFO - Contents: 10:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a996aa44f64579fe4f92963b2676b71ee8508b0a070b8365a583fb2ab0a1f617c78b7dea4c67df14b61dde722ca4524ed47dd45c7184d3f8963cd343483f839a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50b5d015af86eff9fe623773e815d39700936fe36226797c3b3ef4af2284a5dee477362ccd67b0821891a70f2a884bf293f1c50f88401c08360f76b4711ffda7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe94d0fdf685d0572e018ff563f2f25aace3d0bf6348f60d5c7aa251db81d5a906cb5c9c9ee8dcedc61d9ee6b823f73c0accf7dc21629e06ad0cfdecaa8c3c69"} 10:08:32 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:32 INFO - Copying logs to upload dir... 10:08:32 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.074234 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-12 10:08:32.905642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:08:32.909606) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a996aa44f64579fe4f92963b2676b71ee8508b0a070b8365a583fb2ab0a1f617c78b7dea4c67df14b61dde722ca4524ed47dd45c7184d3f8963cd343483f839a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50b5d015af86eff9fe623773e815d39700936fe36226797c3b3ef4af2284a5dee477362ccd67b0821891a70f2a884bf293f1c50f88401c08360f76b4711ffda7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe94d0fdf685d0572e018ff563f2f25aace3d0bf6348f60d5c7aa251db81d5a906cb5c9c9ee8dcedc61d9ee6b823f73c0accf7dc21629e06ad0cfdecaa8c3c69"} build_url:https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a996aa44f64579fe4f92963b2676b71ee8508b0a070b8365a583fb2ab0a1f617c78b7dea4c67df14b61dde722ca4524ed47dd45c7184d3f8963cd343483f839a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50b5d015af86eff9fe623773e815d39700936fe36226797c3b3ef4af2284a5dee477362ccd67b0821891a70f2a884bf293f1c50f88401c08360f76b4711ffda7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe94d0fdf685d0572e018ff563f2f25aace3d0bf6348f60d5c7aa251db81d5a906cb5c9c9ee8dcedc61d9ee6b823f73c0accf7dc21629e06ad0cfdecaa8c3c69"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:08:32.935431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:08:32.935768) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468342069.400763-104835046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:08:32.984962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:08:32.985293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:08:32.985606) ========= ========= Total master_lag: 0.36 =========