builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1468189080.8 results: success (0) buildid: 20160710123925 builduid: 5f52a2cea9ff42e088cadfe1edf07ff2 revision: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.803856) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.804441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.804754) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.896099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:00.896396) ========= 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=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 15:18:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-10 15:18:01 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152860 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.098477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.098789) ========= 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=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.140541 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.255309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.255677) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf --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 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf --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=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 15:18:01,459 truncating revision to first 12 chars 2016-07-10 15:18:01,459 Setting DEBUG logging. 2016-07-10 15:18:01,459 attempt 1/10 2016-07-10 15:18:01,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f0d18b6adc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-10 15:18:01,749 unpacking tar archive at: mozilla-aurora-9f0d18b6adc5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.947396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.947705) ========= script_repo_revision: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.948090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.948363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 15:18:01.959977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-10 15:18:01.960254) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:02 INFO - MultiFileLogger online at 20160710 15:18:02 in /builds/slave/test 15:18:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:02 INFO - {'append_to_log': False, 15:18:02 INFO - 'base_work_dir': '/builds/slave/test', 15:18:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:02 INFO - 'branch': 'Mozilla-Aurora', 15:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:02 INFO - 'config_files': ('talos/linux_config.py',), 15:18:02 INFO - 'default_actions': ('clobber', 15:18:02 INFO - 'read-buildbot-config', 15:18:02 INFO - 'download-and-extract', 15:18:02 INFO - 'populate-webroot', 15:18:02 INFO - 'create-virtualenv', 15:18:02 INFO - 'install', 15:18:02 INFO - 'run-tests'), 15:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:02 INFO - 'download_minidump_stackwalk': True, 15:18:02 INFO - 'download_symbols': 'ondemand', 15:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:02 INFO - 'installer_path': 'installer.exe', 15:18:02 INFO - 'log_level': 'info', 15:18:02 INFO - 'log_name': 'talos', 15:18:02 INFO - 'log_to_console': True, 15:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:02 INFO - 'opt_config_files': (), 15:18:02 INFO - 'pip_index': False, 15:18:02 INFO - 'sps_profile': False, 15:18:02 INFO - 'sps_profile_interval': 0, 15:18:02 INFO - 'suite': 'dromaeojs-e10s', 15:18:02 INFO - 'system_bits': '32', 15:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:02 INFO - 'title': 'talos-linux64-ix-043', 15:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:02 INFO - 'use_talos_json': True, 15:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:02 INFO - 'work_dir': 'build'} 15:18:02 INFO - ##### 15:18:02 INFO - ##### Running clobber step. 15:18:02 INFO - ##### 15:18:02 INFO - Running pre-action listener: _resource_record_pre_action 15:18:02 INFO - Running main action method: clobber 15:18:02 INFO - rmtree: /builds/slave/test/build 15:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:04 INFO - Running post-action listener: _resource_record_post_action 15:18:04 INFO - ##### 15:18:04 INFO - ##### Finished clobber step (success) 15:18:04 INFO - ##### 15:18:04 INFO - ##### 15:18:04 INFO - ##### Running read-buildbot-config step. 15:18:04 INFO - ##### 15:18:04 INFO - Running pre-action listener: _resource_record_pre_action 15:18:04 INFO - Running main action method: read_buildbot_config 15:18:04 INFO - Using buildbot properties: 15:18:04 INFO - { 15:18:04 INFO - "project": "", 15:18:04 INFO - "product": "firefox", 15:18:04 INFO - "script_repo_revision": "production", 15:18:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:18:04 INFO - "repository": "", 15:18:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:18:04 INFO - "buildid": "20160710123925", 15:18:04 INFO - "pgo_build": "True", 15:18:04 INFO - "basedir": "/builds/slave/test", 15:18:04 INFO - "buildnumber": 412, 15:18:04 INFO - "slavename": "talos-linux64-ix-043", 15:18:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:18:04 INFO - "platform": "ubuntu64_hw", 15:18:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:18:04 INFO - "branch": "mozilla-aurora", 15:18:04 INFO - "repo_path": "releases/mozilla-aurora", 15:18:04 INFO - "revision": "9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf", 15:18:04 INFO - "stage_platform": "linux64-pgo", 15:18:04 INFO - "builduid": "5f52a2cea9ff42e088cadfe1edf07ff2", 15:18:04 INFO - "slavebuilddir": "test" 15:18:04 INFO - } 15:18:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:18:04 INFO - Running post-action listener: _resource_record_post_action 15:18:04 INFO - ##### 15:18:04 INFO - ##### Finished read-buildbot-config step (success) 15:18:04 INFO - ##### 15:18:04 INFO - ##### 15:18:04 INFO - ##### Running download-and-extract step. 15:18:04 INFO - ##### 15:18:04 INFO - Running pre-action listener: _resource_record_pre_action 15:18:04 INFO - Running main action method: download_and_extract 15:18:04 INFO - mkdir: /builds/slave/test/build/tests 15:18: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')]} 15:18:04 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:10 INFO - Downloaded 1361 bytes. 15:18:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:10 INFO - Using the following test package requirements: 15:18:10 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:10 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:10 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:18:10 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'jsshell-linux-x86_64.zip'], 15:18:10 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:10 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:10 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:18:10 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:18:10 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:10 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:10 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18: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')]} 15:18:10 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:17 INFO - Downloaded 24526720 bytes. 15:18:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:18:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:18:19 INFO - Return code: 0 15:18:19 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 15:18: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')]} 15:18:19 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:20 INFO - Downloaded 24526720 bytes. 15:18:20 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'] 15:18:20 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 15:18:21 INFO - Return code: 0 15:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:21 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:23 INFO - Downloaded 10833369 bytes. 15:18:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:18:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:18:23 INFO - Return code: 0 15:18: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')]} 15:18:23 INFO - https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OSuCNmwjRYGaIW9gCGnI4g/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 15:18:25 INFO - Downloaded 63644723 bytes. 15:18:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:25 INFO - mkdir: /builds/slave/test/properties 15:18:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:25 INFO - Contents: 15:18:25 INFO - build_url:https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:26 INFO - Running post-action listener: _resource_record_post_action 15:18:26 INFO - Running post-action listener: set_extra_try_arguments 15:18:26 INFO - ##### 15:18:26 INFO - ##### Finished download-and-extract step (success) 15:18:26 INFO - ##### 15:18:26 INFO - ##### 15:18:26 INFO - ##### Running populate-webroot step. 15:18:26 INFO - ##### 15:18:26 INFO - Running pre-action listener: _resource_record_pre_action 15:18:26 INFO - Running main action method: populate_webroot 15:18:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:26 INFO - '--tppagecycles', 15:18:26 INFO - '7'], 15:18:26 INFO - 'tests': ['tsvgm']}}, 15:18:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['damp', 'tps']}, 15:18:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'tests': ['damp', 'tps']}, 15:18:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['dromaeo_dom']}, 15:18:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['a11yr', 15:18:26 INFO - 'ts_paint', 15:18:26 INFO - 'tpaint', 15:18:26 INFO - 'sessionrestore', 15:18:26 INFO - 'sessionrestore_no_auto_restore', 15:18:26 INFO - 'tabpaint']}, 15:18:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['tsvgx', 15:18:26 INFO - 'tsvgr_opacity', 15:18:26 INFO - 'tart', 15:18:26 INFO - 'tscrollx', 15:18:26 INFO - 'cart']}, 15:18:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:26 INFO - 'tsvgr_opacity', 15:18:26 INFO - 'tart', 15:18:26 INFO - 'tscrollx', 15:18:26 INFO - 'cart']}, 15:18:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'talos_options': ['--disable-e10s'], 15:18:26 INFO - 'tests': ['tp5o']}, 15:18:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'tests': ['tp5o']}, 15:18:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'talos_options': ['--disable-e10s', 15:18:26 INFO - '--xperf_path', 15:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:26 INFO - 'tests': ['tp5n']}, 15:18:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:26 INFO - 'talos_options': ['--xperf_path', 15:18:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:26 INFO - 'tests': ['tp5n']}}, 15:18:26 INFO - 'talos.zip': {'path': '', 15:18:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:26 INFO - Running post-action listener: _resource_record_post_action 15:18:26 INFO - ##### 15:18:26 INFO - ##### Finished populate-webroot step (success) 15:18:26 INFO - ##### 15:18:26 INFO - ##### 15:18:26 INFO - ##### Running create-virtualenv step. 15:18:26 INFO - ##### 15:18:26 INFO - Running pre-action listener: _resource_record_pre_action 15:18:26 INFO - Running main action method: create_virtualenv 15:18:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:18:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:26 INFO - Using real prefix '/usr' 15:18:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:30 INFO - Installing pip.................done. 15:18:30 INFO - Return code: 0 15:18:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18: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', 'pip>=1.5'] in /builds/slave/test/build 15:18: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 pip>=1.5 15:18:30 INFO - Using env: {'DISPLAY': ':0', 15:18:30 INFO - 'HOME': '/home/cltbld', 15:18:30 INFO - 'LANG': 'en_US.UTF-8', 15:18:30 INFO - 'LANGUAGE': 'en_US:en', 15:18:30 INFO - 'LOGNAME': 'cltbld', 15:18:30 INFO - 'MAIL': '/var/mail/cltbld', 15:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:30 INFO - 'MOZ_NO_REMOTE': '1', 15:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:30 INFO - 'NO_EM_RESTART': '1', 15:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:30 INFO - 'PWD': '/builds/slave/test', 15:18:30 INFO - 'SHELL': '/bin/bash', 15:18:30 INFO - 'SHLVL': '1', 15:18:30 INFO - 'TERM': 'linux', 15:18:30 INFO - 'TMOUT': '86400', 15:18:30 INFO - 'USER': 'cltbld', 15:18:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:30 INFO - '_': '/tools/buildbot/bin/python'} 15:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:30 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 15:18:30 INFO - Cleaning up... 15:18:30 INFO - Return code: 0 15:18:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', '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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:18: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 psutil>=3.1.1 15:18:30 INFO - Using env: {'DISPLAY': ':0', 15:18:30 INFO - 'HOME': '/home/cltbld', 15:18:30 INFO - 'LANG': 'en_US.UTF-8', 15:18:30 INFO - 'LANGUAGE': 'en_US:en', 15:18:30 INFO - 'LOGNAME': 'cltbld', 15:18:30 INFO - 'MAIL': '/var/mail/cltbld', 15:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:30 INFO - 'MOZ_NO_REMOTE': '1', 15:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:30 INFO - 'NO_EM_RESTART': '1', 15:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:30 INFO - 'PWD': '/builds/slave/test', 15:18:30 INFO - 'SHELL': '/bin/bash', 15:18:30 INFO - 'SHLVL': '1', 15:18:30 INFO - 'TERM': 'linux', 15:18:30 INFO - 'TMOUT': '86400', 15:18:30 INFO - 'USER': 'cltbld', 15:18:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:30 INFO - '_': '/tools/buildbot/bin/python'} 15:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:30 INFO - Downloading/unpacking psutil>=3.1.1 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:33 INFO - Installing collected packages: psutil 15:18:33 INFO - Running setup.py install for psutil 15:18:33 INFO - building 'psutil._psutil_linux' extension 15:18:33 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 15:18:34 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 15:18:34 INFO - building 'psutil._psutil_posix' extension 15:18:34 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 15:18:34 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 15:18:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:34 INFO - Successfully installed psutil 15:18:34 INFO - Cleaning up... 15:18:34 INFO - Return code: 0 15:18:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:18:34 INFO - Using env: {'DISPLAY': ':0', 15:18:34 INFO - 'HOME': '/home/cltbld', 15:18:34 INFO - 'LANG': 'en_US.UTF-8', 15:18:34 INFO - 'LANGUAGE': 'en_US:en', 15:18:34 INFO - 'LOGNAME': 'cltbld', 15:18:34 INFO - 'MAIL': '/var/mail/cltbld', 15:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:34 INFO - 'MOZ_NO_REMOTE': '1', 15:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:34 INFO - 'NO_EM_RESTART': '1', 15:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:34 INFO - 'PWD': '/builds/slave/test', 15:18:34 INFO - 'SHELL': '/bin/bash', 15:18:34 INFO - 'SHLVL': '1', 15:18:34 INFO - 'TERM': 'linux', 15:18:34 INFO - 'TMOUT': '86400', 15:18:34 INFO - 'USER': 'cltbld', 15:18:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:34 INFO - '_': '/tools/buildbot/bin/python'} 15:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:18:36 INFO - Installing collected packages: mozsystemmonitor 15:18:36 INFO - Running setup.py install for mozsystemmonitor 15:18:36 INFO - Successfully installed mozsystemmonitor 15:18:36 INFO - Cleaning up... 15:18:36 INFO - Return code: 0 15:18:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:18:36 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')]} 15:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:36 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')]} 15:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:36 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:36 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 15:18:36 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 15:18:36 INFO - Using env: {'DISPLAY': ':0', 15:18:36 INFO - 'HOME': '/home/cltbld', 15:18:36 INFO - 'LANG': 'en_US.UTF-8', 15:18:36 INFO - 'LANGUAGE': 'en_US:en', 15:18:36 INFO - 'LOGNAME': 'cltbld', 15:18:36 INFO - 'MAIL': '/var/mail/cltbld', 15:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:36 INFO - 'MOZ_NO_REMOTE': '1', 15:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:36 INFO - 'NO_EM_RESTART': '1', 15:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:36 INFO - 'PWD': '/builds/slave/test', 15:18:36 INFO - 'SHELL': '/bin/bash', 15:18:36 INFO - 'SHLVL': '1', 15:18:36 INFO - 'TERM': 'linux', 15:18:36 INFO - 'TMOUT': '86400', 15:18:36 INFO - 'USER': 'cltbld', 15:18:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:36 INFO - '_': '/tools/buildbot/bin/python'} 15:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:37 INFO - Downloading/unpacking jsonschema==2.5.1 15:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:39 INFO - warning: no files found matching '*.txt' 15:18:39 INFO - no previously-included directories found matching 'build' 15:18:39 INFO - no previously-included directories found matching 'dist' 15:18:39 INFO - no previously-included directories found matching '.git*' 15:18:39 INFO - Installing collected packages: jsonschema, functools32 15:18:39 INFO - Running setup.py install for functools32 15:18:39 INFO - warning: no files found matching '*.txt' 15:18:39 INFO - no previously-included directories found matching 'build' 15:18:39 INFO - no previously-included directories found matching 'dist' 15:18:39 INFO - no previously-included directories found matching '.git*' 15:18:39 INFO - Successfully installed jsonschema functools32 15:18:39 INFO - Cleaning up... 15:18:39 INFO - Return code: 0 15:18:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:18:39 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')]} 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:39 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')]} 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:39 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:39 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 15:18:39 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 15:18:39 INFO - Using env: {'DISPLAY': ':0', 15:18:39 INFO - 'HOME': '/home/cltbld', 15:18:39 INFO - 'LANG': 'en_US.UTF-8', 15:18:39 INFO - 'LANGUAGE': 'en_US:en', 15:18:39 INFO - 'LOGNAME': 'cltbld', 15:18:39 INFO - 'MAIL': '/var/mail/cltbld', 15:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:39 INFO - 'MOZ_NO_REMOTE': '1', 15:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:39 INFO - 'NO_EM_RESTART': '1', 15:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:39 INFO - 'PWD': '/builds/slave/test', 15:18:39 INFO - 'SHELL': '/bin/bash', 15:18:39 INFO - 'SHLVL': '1', 15:18:39 INFO - 'TERM': 'linux', 15:18:39 INFO - 'TMOUT': '86400', 15:18:39 INFO - 'USER': 'cltbld', 15:18:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:39 INFO - '_': '/tools/buildbot/bin/python'} 15:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:41 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 15:18:41 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 15:18:41 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 15:18:41 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 15:18:41 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 15:18:41 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 15:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:42 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 15:18:42 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 15:18:42 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 15:18:42 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 15:18:42 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 15:18:42 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 15:18:42 INFO - Downloading docopt-0.6.1.tar.gz 15:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:42 INFO - Running setup.py install for blobuploader 15:18:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:18:42 INFO - Running setup.py install for requests 15:18:42 INFO - Running setup.py install for docopt 15:18:42 INFO - Successfully installed blobuploader requests docopt 15:18:42 INFO - Cleaning up... 15:18:42 INFO - Return code: 0 15:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:42 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')]} 15:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:42 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')]} 15:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:42 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:42 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 15:18:42 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 15:18:42 INFO - Using env: {'DISPLAY': ':0', 15:18:42 INFO - 'HOME': '/home/cltbld', 15:18:42 INFO - 'LANG': 'en_US.UTF-8', 15:18:42 INFO - 'LANGUAGE': 'en_US:en', 15:18:42 INFO - 'LOGNAME': 'cltbld', 15:18:42 INFO - 'MAIL': '/var/mail/cltbld', 15:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:42 INFO - 'MOZ_NO_REMOTE': '1', 15:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:42 INFO - 'NO_EM_RESTART': '1', 15:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:42 INFO - 'PWD': '/builds/slave/test', 15:18:42 INFO - 'SHELL': '/bin/bash', 15:18:42 INFO - 'SHLVL': '1', 15:18:42 INFO - 'TERM': 'linux', 15:18:42 INFO - 'TMOUT': '86400', 15:18:42 INFO - 'USER': 'cltbld', 15:18:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:42 INFO - '_': '/tools/buildbot/bin/python'} 15:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:43 INFO - Running setup.py (path:/tmp/pip-tAeUZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:43 INFO - Running setup.py (path:/tmp/pip-zHhWVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:43 INFO - Running setup.py (path:/tmp/pip-335exu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:43 INFO - Running setup.py (path:/tmp/pip-uiiHFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:43 INFO - Running setup.py (path:/tmp/pip-5Oy928-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:43 INFO - Running setup.py (path:/tmp/pip-zHFgxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:43 INFO - Running setup.py (path:/tmp/pip-hPt6lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:43 INFO - Running setup.py (path:/tmp/pip-lS8U1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:43 INFO - Running setup.py (path:/tmp/pip-Y2pzuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:43 INFO - Running setup.py (path:/tmp/pip-ICKiUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:43 INFO - Running setup.py (path:/tmp/pip-4WwfKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:43 INFO - Running setup.py (path:/tmp/pip-BmTxqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:44 INFO - Running setup.py (path:/tmp/pip-CxakGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:44 INFO - Running setup.py (path:/tmp/pip-rnbHJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:44 INFO - Running setup.py (path:/tmp/pip-dpG12h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:44 INFO - Running setup.py (path:/tmp/pip-gEC2ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:44 INFO - Running setup.py (path:/tmp/pip-NRkbHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:44 INFO - Running setup.py install for manifestparser 15:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:18:44 INFO - Running setup.py install for mozcrash 15:18:44 INFO - Running setup.py install for mozdebug 15:18:44 INFO - Running setup.py install for mozdevice 15:18:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:18:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:18:44 INFO - Running setup.py install for mozfile 15:18:44 INFO - Running setup.py install for mozhttpd 15:18:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozinfo 15:18:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozInstall 15:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozleak 15:18:45 INFO - Running setup.py install for mozlog 15:18:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for moznetwork 15:18:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozprocess 15:18:45 INFO - Running setup.py install for mozprofile 15:18:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozrunner 15:18:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:18:45 INFO - Running setup.py install for mozscreenshot 15:18:45 INFO - Running setup.py install for moztest 15:18:46 INFO - Running setup.py install for mozversion 15:18:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:46 INFO - Cleaning up... 15:18:46 INFO - Return code: 0 15:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:46 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')]} 15:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:46 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')]} 15:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:46 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:46 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 15:18:46 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 15:18:46 INFO - Using env: {'DISPLAY': ':0', 15:18:46 INFO - 'HOME': '/home/cltbld', 15:18:46 INFO - 'LANG': 'en_US.UTF-8', 15:18:46 INFO - 'LANGUAGE': 'en_US:en', 15:18:46 INFO - 'LOGNAME': 'cltbld', 15:18:46 INFO - 'MAIL': '/var/mail/cltbld', 15:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:46 INFO - 'MOZ_NO_REMOTE': '1', 15:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:46 INFO - 'NO_EM_RESTART': '1', 15:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:46 INFO - 'PWD': '/builds/slave/test', 15:18:46 INFO - 'SHELL': '/bin/bash', 15:18:46 INFO - 'SHLVL': '1', 15:18:46 INFO - 'TERM': 'linux', 15:18:46 INFO - 'TMOUT': '86400', 15:18:46 INFO - 'USER': 'cltbld', 15:18:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:46 INFO - '_': '/tools/buildbot/bin/python'} 15:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:46 INFO - Running setup.py (path:/tmp/pip-O4Kuen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:46 INFO - Running setup.py (path:/tmp/pip-SGTWMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:46 INFO - Running setup.py (path:/tmp/pip-BmzUR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:46 INFO - Running setup.py (path:/tmp/pip-9w5ToX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:46 INFO - Running setup.py (path:/tmp/pip-C6B0YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:46 INFO - Running setup.py (path:/tmp/pip-BfxQiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:46 INFO - Running setup.py (path:/tmp/pip-rCZvhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:46 INFO - Running setup.py (path:/tmp/pip-I87ECe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:46 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)) 15:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:46 INFO - Running setup.py (path:/tmp/pip-WrWEgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:47 INFO - Running setup.py (path:/tmp/pip-7omlIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:47 INFO - Running setup.py (path:/tmp/pip-JMJ_Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:47 INFO - Running setup.py (path:/tmp/pip-UzcoYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:47 INFO - Running setup.py (path:/tmp/pip-lkQWR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:47 INFO - Running setup.py (path:/tmp/pip-ihvsUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:47 INFO - Running setup.py (path:/tmp/pip-WDETL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:47 INFO - Running setup.py (path:/tmp/pip-LLtKYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:47 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)) 15:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:47 INFO - Running setup.py (path:/tmp/pip-Hd_mvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:47 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)) 15:18:47 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)) 15:18:47 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)) 15:18:47 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)) 15:18:47 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)) 15:18:47 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)) 15:18:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:47 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 15:18:47 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 15:18:47 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 15:18:47 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 15:18:47 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 15:18:47 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 15:18:49 INFO - Downloading blessings-1.6.tar.gz 15:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:49 INFO - Installing collected packages: blessings 15:18:49 INFO - Running setup.py install for blessings 15:18:49 INFO - Successfully installed blessings 15:18:49 INFO - Cleaning up... 15:18:49 INFO - Return code: 0 15:18:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:49 INFO - Reading from file tmpfile_stdout 15:18:49 INFO - Current package versions: 15:18:49 INFO - argparse == 1.2.1 15:18:49 INFO - blessings == 1.6 15:18:49 INFO - blobuploader == 1.2.4 15:18:49 INFO - docopt == 0.6.1 15:18:49 INFO - functools32 == 3.2.3-2 15:18:49 INFO - jsonschema == 2.5.1 15:18:49 INFO - manifestparser == 1.1 15:18:49 INFO - mozInstall == 1.12 15:18:49 INFO - mozcrash == 0.17 15:18:49 INFO - mozdebug == 0.1 15:18:49 INFO - mozdevice == 0.48 15:18:49 INFO - mozfile == 1.2 15:18:49 INFO - mozhttpd == 0.7 15:18:49 INFO - mozinfo == 0.9 15:18:49 INFO - mozleak == 0.1 15:18:49 INFO - mozlog == 3.2 15:18:49 INFO - moznetwork == 0.27 15:18:49 INFO - mozprocess == 0.22 15:18:49 INFO - mozprofile == 0.28 15:18:49 INFO - mozrunner == 6.11 15:18:49 INFO - mozscreenshot == 0.1 15:18:49 INFO - mozsystemmonitor == 0.3 15:18:49 INFO - moztest == 0.7 15:18:49 INFO - mozversion == 1.4 15:18:49 INFO - psutil == 3.1.1 15:18:49 INFO - requests == 1.2.3 15:18:49 INFO - wsgiref == 0.1.2 15:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:49 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:49 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 15:18:49 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 15:18:49 INFO - Using env: {'DISPLAY': ':0', 15:18:49 INFO - 'HOME': '/home/cltbld', 15:18:49 INFO - 'LANG': 'en_US.UTF-8', 15:18:49 INFO - 'LANGUAGE': 'en_US:en', 15:18:49 INFO - 'LOGNAME': 'cltbld', 15:18:49 INFO - 'MAIL': '/var/mail/cltbld', 15:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:49 INFO - 'MOZ_NO_REMOTE': '1', 15:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:49 INFO - 'NO_EM_RESTART': '1', 15:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:49 INFO - 'PWD': '/builds/slave/test', 15:18:49 INFO - 'SHELL': '/bin/bash', 15:18:49 INFO - 'SHLVL': '1', 15:18:50 INFO - 'TERM': 'linux', 15:18:50 INFO - 'TMOUT': '86400', 15:18:50 INFO - 'USER': 'cltbld', 15:18:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:50 INFO - '_': '/tools/buildbot/bin/python'} 15:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 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)) 15:18:50 INFO - Cleaning up... 15:18:50 INFO - Return code: 0 15:18:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:50 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:50 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 15:18:50 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 15:18:50 INFO - Using env: {'DISPLAY': ':0', 15:18:50 INFO - 'HOME': '/home/cltbld', 15:18:50 INFO - 'LANG': 'en_US.UTF-8', 15:18:50 INFO - 'LANGUAGE': 'en_US:en', 15:18:50 INFO - 'LOGNAME': 'cltbld', 15:18:50 INFO - 'MAIL': '/var/mail/cltbld', 15:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:50 INFO - 'MOZ_NO_REMOTE': '1', 15:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:50 INFO - 'NO_EM_RESTART': '1', 15:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:50 INFO - 'PWD': '/builds/slave/test', 15:18:50 INFO - 'SHELL': '/bin/bash', 15:18:50 INFO - 'SHLVL': '1', 15:18:50 INFO - 'TERM': 'linux', 15:18:50 INFO - 'TMOUT': '86400', 15:18:50 INFO - 'USER': 'cltbld', 15:18:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:50 INFO - '_': '/tools/buildbot/bin/python'} 15:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:50 INFO - Cleaning up... 15:18:50 INFO - Return code: 0 15:18:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:50 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 0x7f786e211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2239350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, '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': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', '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 15:18:50 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 15:18:50 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 15:18:50 INFO - Using env: {'DISPLAY': ':0', 15:18:50 INFO - 'HOME': '/home/cltbld', 15:18:50 INFO - 'LANG': 'en_US.UTF-8', 15:18:50 INFO - 'LANGUAGE': 'en_US:en', 15:18:50 INFO - 'LOGNAME': 'cltbld', 15:18:50 INFO - 'MAIL': '/var/mail/cltbld', 15:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:50 INFO - 'MOZ_NO_REMOTE': '1', 15:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:50 INFO - 'NO_EM_RESTART': '1', 15:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:50 INFO - 'PWD': '/builds/slave/test', 15:18:50 INFO - 'SHELL': '/bin/bash', 15:18:50 INFO - 'SHLVL': '1', 15:18:50 INFO - 'TERM': 'linux', 15:18:50 INFO - 'TMOUT': '86400', 15:18:50 INFO - 'USER': 'cltbld', 15:18:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:50 INFO - '_': '/tools/buildbot/bin/python'} 15:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:50 INFO - Downloading/unpacking flake8 15:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:52 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 15:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:53 INFO - no previously-included directories found matching 'docs/_build' 15:18:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:53 INFO - Running setup.py install for pep8 15:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:53 INFO - no previously-included directories found matching 'docs/_build' 15:18:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:53 INFO - Cleaning up... 15:18:53 INFO - Return code: 0 15:18:53 INFO - Running post-action listener: _resource_record_post_action 15:18:53 INFO - Running post-action listener: _start_resource_monitoring 15:18:53 INFO - Starting resource monitoring. 15:18:53 INFO - ##### 15:18:53 INFO - ##### Finished create-virtualenv step (success) 15:18:53 INFO - ##### 15:18:53 INFO - ##### 15:18:53 INFO - ##### Running install step. 15:18:53 INFO - ##### 15:18:53 INFO - Running pre-action listener: _resource_record_pre_action 15:18:53 INFO - Running main action method: install 15:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:53 INFO - Reading from file tmpfile_stdout 15:18:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:53 INFO - Reading from file tmpfile_stdout 15:18:53 INFO - Output received: 15:18:53 INFO - Usage: mozinstall [options] installer 15:18:53 INFO - Options: 15:18:53 INFO - -h, --help show this help message and exit 15:18:53 INFO - -d DEST, --destination=DEST 15:18:53 INFO - Directory to install application into. [default: 15:18:53 INFO - "/builds/slave/test"] 15:18:53 INFO - --app=APP Application being installed. [default: firefox] 15:18:53 INFO - mkdir: /builds/slave/test/build/application 15:18:53 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'] 15:18:53 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 15:19:09 INFO - Reading from file tmpfile_stdout 15:19:09 INFO - Output received: 15:19:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:09 INFO - Running post-action listener: _resource_record_post_action 15:19:09 INFO - ##### 15:19:09 INFO - ##### Finished install step (success) 15:19:09 INFO - ##### 15:19:09 INFO - ##### 15:19:09 INFO - ##### Running run-tests step. 15:19:09 INFO - ##### 15:19:09 INFO - Running pre-action listener: _resource_record_pre_action 15:19:09 INFO - Running main action method: run_tests 15:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:09 INFO - Python 2.7.3 15:19:09 INFO - Return code: 0 15:19:09 INFO - grabbing minidump binary from tooltool 15:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:09 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 0x22c81c0>, '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 0x22c90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:09 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 15:19:09 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 15:19:09 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 15:19:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:09 INFO - Return code: 0 15:19:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:19:10 INFO - Return code: 0 15:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:19:10 INFO - Using env: {'DISPLAY': ':0', 15:19:10 INFO - 'HOME': '/home/cltbld', 15:19:10 INFO - 'LANG': 'en_US.UTF-8', 15:19:10 INFO - 'LANGUAGE': 'en_US:en', 15:19:10 INFO - 'LOGNAME': 'cltbld', 15:19:10 INFO - 'MAIL': '/var/mail/cltbld', 15:19:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:10 INFO - 'MOZ_NO_REMOTE': '1', 15:19:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:10 INFO - 'NO_EM_RESTART': '1', 15:19:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:10 INFO - 'PWD': '/builds/slave/test', 15:19:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:10 INFO - 'SHELL': '/bin/bash', 15:19:10 INFO - 'SHLVL': '1', 15:19:10 INFO - 'TERM': 'linux', 15:19:10 INFO - 'TMOUT': '86400', 15:19:10 INFO - 'USER': 'cltbld', 15:19:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468178804.489682-953865346', 15:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:10 INFO - '_': '/tools/buildbot/bin/python'} 15:19:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:19:10 INFO - mozversion application_buildid: 20160710123925 15:19:10 INFO - mozversion application_changeset: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf 15:19:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:19:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:10 INFO - mozversion application_name: Firefox 15:19:10 INFO - mozversion application_remotingname: firefox-dev 15:19:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:10 INFO - mozversion application_vendor: Mozilla 15:19:10 INFO - mozversion application_version: 49.0a2 15:19:10 INFO - mozversion platform_buildid: 20160710123925 15:19:10 INFO - mozversion platform_changeset: 9f0d18b6adc500a1fdfffd986f6a5c7d4af5fcaf 15:19:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:10 INFO - mozversion platform_version: 49.0a2 15:19:10 INFO - using testdate: 1468189150 15:19:10 INFO - actual date: 1468189150 15:19:10 INFO - starting webserver on 'localhost:52021' 15:19:10 INFO - SUITE-START | Running 2 tests 15:19:10 INFO - TEST-START | dromaeo_css 15:19:10 INFO - operating with platform_type : linux_ 15:19:10 INFO - Initialising browser for dromaeo_css test... 15:19:10 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TLU6p/profile http://localhost:52021/getInfo.html) 15:19:15 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 15:19:15 INFO - PROCESS | 3333 | colorDepth:24 15:19:15 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 15:19:15 INFO - PROCESS | 3333 | __metrics 15:19:16 ERROR - PROCESS | 3333 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:19:17 INFO - TEST-INFO | 3333: exit 0 15:19:17 INFO - Browser initialized. 15:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:17 INFO - TEST-INFO | started process 3465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TLU6p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:29 INFO - PROCESS | 3465 | RSS: Main: 156356608 15:19:29 INFO - PROCESS | 3465 | 15:20:18 INFO - PROCESS | 3465 | 1468189218640 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] 15:22:26 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52021/tests/dromaeo/cssquery-ext.html) 15:22:27 INFO - PROCESS | 3465 | RSS: Main: 159944704 15:22:27 INFO - PROCESS | 3465 | 15:25:29 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-ext.html (next: http://localhost:52021/tests/dromaeo/cssquery-jquery.html) 15:25:30 INFO - PROCESS | 3465 | RSS: Main: 157974528 15:25:30 INFO - PROCESS | 3465 | 15:28:32 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52021/tests/dromaeo/cssquery-mootools.html) 15:28:32 INFO - PROCESS | 3465 | RSS: Main: 157163520 15:28:32 INFO - PROCESS | 3465 | 15:31:34 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52021/tests/dromaeo/cssquery-prototype.html) 15:31:34 INFO - PROCESS | 3465 | RSS: Main: 157421568 15:31:34 INFO - PROCESS | 3465 | 15:34:37 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52021/tests/dromaeo/cssquery-yui.html) 15:34:38 INFO - PROCESS | 3465 | RSS: Main: 158908416 15:34:38 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:52021/tests/dromaeo/cssquery-yui.html (next: http://localhost:52021/tests/dromaeo/cssquery-dojo.html) 15:37:40 INFO - PROCESS | 3465 | RSS: Main: 159469568 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | __start_tp_report 15:37:40 INFO - PROCESS | 3465 | _x_x_mozilla_page_load 15:37:40 INFO - PROCESS | 3465 | _x_x_mozilla_page_load_details 15:37:40 INFO - PROCESS | 3465 | |i|pagename|runs| 15:37:40 INFO - PROCESS | 3465 | |0;dojo.html;3384.3908096542627;3390.88131915383;3412.539307193528;3416.5046068320094;3416.9487457688124;5669.744861481233;5686.09022556391;5733.741981610827;5734.197212390269;5738.885222295557;5733.254676892008;5769.278840144982;5810.331811841639;5813.970930145343;5817.127430885369;5142.794288228466;5191.948080519203;5212.973935130338;5255.474452554752;5302.337207849019;5127.692338459704;5136.64043516954;5213.608979326546;5286.894262114755;5292.338457692788;5170.146925757245;5218.895622087556;5224.399194092671;5245.10833158364;5267.973660131694;5233.65981211222;5287.07476191665;5291.788328466857;5299.629025968184;5327.440618735016;5036.7733451994745;5144.897102057937;5198.844034678966;5249.396319423277;5259.76331065103;5554.694491802949;5558.86102847428;5577.3028371453565;5614.129809879434;5629.155626655994;6128.264608246995;6183.505319574423;6184.969075154595;6208.565400421972;6243.063540468921;6255.600469941626;6278.560500764948;6278.780242691484;6283.717232724538;6294.622322660655;5615.354234263071;5719.399463056361;5757.050086735683;5773.624714393551;5825.359210486843;6296.653684047421;6321.1150438938585;6352.872942541216;6361.109444677749;6373.808785736435;5926.851828704317;6100.511959043266;6117.174181485531;6124.816255512342;6125.234345706786;6031.9698401508585;6061.181740464981;6078;6113.29697084841;6139.938600613937;6072.878542429126;6127.356627554132;6130.29501607312;6141.447269745744;6141.877162456726;5989.460948514655;6040.546958978094;6054.364291749391;6079.088136779518;6125.540584456184;4629.120467111238;4733.83431579893;4734.218853889139;4737.573618374363;4741.810327586858;4216.8313267469575;4219.683523735732;4228.9154216915485;4229.196452673982;4230.069384735415;5685.403032681592;5820.3888591698105;5843.824685259449;5956.880862382728;5966.552508561788;6019.428154325332;6143.262808462924;6149.66176860268;6163.291221509494;6228.03465462854;5923.141144534018;5963.731632076567;5964.821055368346;5977.282726072812;5977.6114552553945;5179.19722443022;5249.343832020997;5284.524392804666;5312.601554883399;5359.678419294854;6469.061986012002;6544.181977252843;6549.01764735284;6556.344365563501;6557;6298.307186209513;6306.558540902093;6307.779227727007;6308.52686048539;6316.115743795965;6219.564630475823;6254.124422580933;6307.810765677037;6368.745250190126;6529.542931994714;6108.02271636536;6119.663418512025;6120.265568131853;6126.203593532812;6129.632222066691;6215.875682486235;6217;6224.502039836892;6232.283287422005;6232.937670623236;5858.765649373977;5958.314793798769;5989.7304621293015;6027;6082.635041897501;5984.730687119003;6033.9698301508215;6067.150598916067;6080.027195648675;6081.361457047124;5753.165790960371;5906.468417842415;5963.075723262901;5968.731407086779;5997.580169388101;5994.160817485643;6033.9698301508215;6045.304789949212;6138.570300078952;6144.078388241799;5994.280686317496;5995.250593675791;6002.039673652194;6021.638701677914;6023.397660233942 15:37:40 INFO - PROCESS | 3465 | |1;ext.html;642.8103709405725;651.3356376495974;664.558068884192;674.7941877727297;679.1510611735331;38171.42742858856;40087.799561002226;43150;43155.78422107885;43209.35185972213;42528.57471425285;43506.12987740251;43754.562454375446;43807.561924380745;43993;8664.350173736964;8909.68816091437;8915.108489151065;8924.062973387798;8943.373963822534;8806.911930880673;8835.116488351177;8856.8671469928;8911.197992180703;8916.554172291391;8846.601902914352;8943.284537237038;8945.59744811485;8953.05992870749;8954.2836573074;8863.246624036932;8894.332925030583;8919.643214271422;8954.865677014817;8977.147171018743;8785.868211976825;8860.601272942733;8914.108589141098;8922.910770892273;8943.821123577492;35342.116447088774;40184;40663.39004914929;40798.18403631911;40985.59014409877;3280.1471617379416;3551.236484155919;3647.1246900743895;3663.725220608465;3741.850325986957;32149.1962700932;32232.677673223203;34623.653763462295;35096.29807403838;36026.8198659005;4796.664233503656;4798.328234047236;4834.299026641117;4840.709557426566;4871.537203965653;359678;360496;361141.9999999974;361858;363141;38509;67320.32679673239;67508.3249167502;67648.6617566909;67752;38255.23489530194;40121.79939100344;40349.59650403517;40351.1929761409;40498;17140.742888856676;17296.740548891525;17309.65380692379;17338.393156239472;17359.305627775;13331.066825322328;13340.399682014138;13356.532521361705;13365.398557064955;13372.130811497222;9064.456132632064;9083.50040747752;9096.954515227513;9121;9134.132257435665;3475.826208689555;3497.283056973314;3522.4188008978745;3582.982085089558;3585.94621080684;1030.8659874216453;1157.9536818527333;1162.953481860733;1179.2983175010854;1238.5541205166132;33388.3322333552;33922;34091.82954085214;35098;35099.473507897404;1149.0635132367095;1161.59344229519;1179.3572502985894;1207.7644859252362;1221.4869754703045;17182.828171718375;17518.124093795515;17665.318690547014;17902.820971790377;17916;649490;652067;857381;958506;973216;64334;64719.35280647228;64820.67589662022;64963;65086.34913650898;1518.506485392252;1540.5840423085704;1553.6115971007475;1557.0579799221534;1568.3412966554074;33913.83043084769;34083.82958085194;34305.656943430244;34450.65549344474;34948.47577286292;55681.72159139178;56822;56896.431035689115;57049.71475142598;57094;522687;528597;529812;530460;533821;30182;30401.391972159992;30507.389852203276;30653.846730766203;30688.386232274785;51865;52551.211731823285;53186;56987.71506142443;57246.713766430905;43694.78152609216;44515.55484445244;44648;45500.77249613731;45612.77193614011;43867.78066109649;44009.55990440054;44285.33571996487;44638;44744.77627611841;43010.56989430066;43605.78197108994;43700.56299436965;43808.561914381724;44774.3283850736;38430.423543646306;38626.6137338623;38992.805035975776;39723.80138099407;39790.2041959165;29500.557491637213;30062;30368.69631303747;30498.697897141585;30824.69175308218 15:37:40 INFO - PROCESS | 3465 | |2;jquery.html;398.17974971558584;405.0986554915313;414.5977907860576;425.1902949571836;428.6742076022222;18989.62020759584;20313.109198332484;20557.794422055777;20721.274755383565;21311.786882131175;19233.519162020955;19775;19793.109310081047;19796.80203197971;19851.503712407197;5568.248286481314;5907.704614769265;5944.405559444042;5944.464998150165;5961.463468287853;5746.87935852509;5840.094785308284;5912.645241285537;5913.349531551526;5949.137375080611;5981.730822112993;5986.910196347058;6028.728707208164;6040.456358927696;6045.304789949146;5745.195672605839;5971.402859714016;5989.730462129215;6006.819795406145;6022.759089636453;5379.408265090837;5423.484768946943;5426.864328391783;5433.972830135864;5437.02133615949;23512.529749404915;23764.88117559401;23965.760342396527;24246.39384015396;24275;2486.6021436570245;2501.762332578402;2538.9111381101757;2553.8723063846733;2606.843589384624;15136.697266054618;15378.923105384401;15386.692266154727;15507.767383489258;16000.919995399949;1966.1447270437407;2063.13348393675;2069.8240649544805;2116.8941552922292;2144.292383513437;81976.18023819746;82829.17170828275;82863;83589;84310.57844710798;10239;10535.736606584744;10654.840177397346;10949.890501095046;11752.353620550952;13959;13994.510192143429;14001;14013.789793153112;14033.578992630237;8713.215810577078;8871.379003469696;8896.332775041898;9044.186023257938;9118;8937.910620893708;9060.320475964329;9124.406913550598;9222.907770922338;9319.627214911463;6834.2482326944;6837.247902730695;6850.794476165723;6967.407770339477;6970.546914450646;1826.3151318255655;1884.9340273090377;1912.5887934094237;1937.3122541497846;1949.5905859769607;987.9012098790064;1045.816982028142;1097.6981330134117;1134.8694900086596;1193.6001439517686;20238.089285982165;20473.590528189354;20834.79165208359;21017.159313627282;21048.579028419346;1067.071647666535;1070.1385384765338;1090.9127269818396;1119.0152665654173;1206.5535751771724;11505.712357191138;11587.319838623353;11728.88271117295;11936.880631193577;12020.158588898694;482894;497982;499438;502156;507644;82559;84159;84972.72540911891;86738.56630716933;87295;1051.6687243518268;1099.3568762273999;1108.6784832398675;1110.6612483192703;1118.4910865556153;18054.277828886698;18065.187066581773;18440.631187376446;18505.90747046256;18953.90523047376;38636.6136338633;44554.3316850254;44740.32889506595;45192.54807452015;46052.539474604826;51335.48664513307;59308.40691593029;61263.69368153309;61734.342739159925;62456.375436245056;7918.722844700408;8620.568971551524;8749.300055995378;8910.064443233627;9035.412698174598;12826.61520154397;13238.271895045866;13485.73028539404;13489.392977315849;13665.726685466036;11444.599439019594;11620.244684095507;11723.237989530653;11743.588974385855;11904.285742855456;10809.35143891369;10882.095633264305;11120.165987550805;11174.441277936234;11275.605353812578;11592.942035289769;11605.245659032136;11702.4733886977;11895.643130706092;12020.939895300467;7654.540727556365;7816.84366312682;7874.6850125994315;8025.638846252049;8193.549354785544;10011.749706257402;11377.829332560184;11516.712082197677;11635;11680.123990700562 15:37:40 INFO - PROCESS | 3465 | |3;mootools.html;1598.6882557901206;1628.560288722045;1808.8643351748622;1879.3891985104844;1894.469548526413;8394.24451799338;9015.233705135062;9133.406328588637;9570.042995700434;9571.042895710434;9378.765530861732;9450.81098378032;9512.76218094548;9560.330776845623;9590.856137157949;2458.459138989424;2483.7019557653016;2487.7139129000216;2490.950180996379;2497.2383423055962;2422.0675040109595;2446.706395232575;2453.288546321565;2454.1778504201116;2455.8035357171384;2426.5632186206476;2437.098273638756;2471.085698291635;2480.4295012147127;2482.491089326693;2407.735149133594;2411.288669842401;2443.389152711822;2446.7308596054418;2453.668754718117;2410.0359856057544;2417.4439878827793;2437.890294936732;2441.8779061046876;2453.889574969113;9358.906410935871;9379.953100234523;9485.620575176985;9487.383320084242;9489.430634161972;5338.172583249602;5438.293021907127;5447.237386765856;5456.127019676833;5467.425920278393;3361.226917808893;3394.389009978203;3455.9654403455893;3464.0300715799617;3533.876314329012;1140.5038808118495;1142.126273400849;1159.0437888741822;1173.3136115372517;1183.5029287699188;12841.935790321082;12908.612741617766;12933.935330323382;12941.417636206394;12976.091673582852;4713.787879545429;4723.622110231173;4804.0872234275375;4835.564799168092;4864.100141473838;11004.779904401867;11031.503582338813;11040.668779936615;11041.779164416666;11050.557977680963;5402.648827826179;5487.396386397493;5496.203050557647;5521.3926468088475;5581.49766521015;4500.549945005539;5018.573421259161;5051.848444546669;5217.2695822584865;5223.608229382811;4211.094614657802;4247.23549761046;4254.617084462351;4302.397664326997;4323.805428755651;1334.4662135145825;1356.2743931996336;1359.5309618181711;1361.6868120332379;1377.304461247084;1058.88352281249;1067.6796960911695;1070.4701172919454;1077.8221593437152;1083.6965649618119;6355.332690067568;6453.838654033687;6477.5465717400275;6519.608823470607;6528.771492997722;484.23007418205225;494.1845954175567;494.74026136278025;498.66838552363;503.4990184766108;4507.661925355612;4554.362389265505;4584.4498660161;4586.541345865387;4615.538446155358;11582.247153935135;11922.10584206188;11942.880571194351;12002;12029.278243305429;11187.4965626547;11652.009579185864;11696.941515292368;11698.122640801974;11777.116716246315;8530.14698530142;8935.508547029976;8959;8999.415038022507;9019.413738107134;6594.439472644879;6762.459003279628;6801.795946121624;6854.554453960476;6890.379865812101;10717.303375280582;10926;10979.17656175774;10979.835302470628;11152.107831373633;10937.179711521827;11136.443177841238;11151.10791136691;11188.888111118784;11279;7663.655135519027;8149.9185008151535;8360.414770965974;8418.831623367376;8513.574321284035;9277.907220927975;9343.15911567935;9393.81212375735;9409.059094090537;9409.153176214173;8306.709265175932;8503;8518.829623407373;8587.9694436668;8650.870236946577;8254.133316001973;8291.419600627898;8307.792305192419;8315.792105197419;8410.369222308474;7595.3164215220895;7744.303012728881;7745.728899488491;7756.92243077562;7788.415868809749;5638.154276858504;5694.1458781183155;5774.971125144515;5812.94187058124;5883.411658834082;5773.191753154478;5792.073268277056;5852.678102704393;5858.8242352729485;5873.5594830388745 15:37:40 INFO - PROCESS | 3465 | |4;prototype.html;350.7790092241887;351.3920916813913;351.9771214871033;353.60219752778124;359.32088353012796;5699.373068962416;5703.173039909216;5725.167946257194;5755.848830233949;5767;5601.551875849932;5635.295588051494;5651.519620832234;5656.943430565693;5670;4024.4768180136616;4375.980573404357;4388.385626012361;4414.690971631987;4437.445319335083;4348.152110338485;4399.86800395987;4401.515833258339;4409.867703968886;4437.64498840092;4343.174796788616;4386.890327741816;4388.23205938961;4390.868273951771;4392.780360981938;4236.766977816219;4337.7397356158735;4342.804573794187;4356.673249506268;4398.780060996937;3877.0695033192114;3879.35990561557;3893.922121557553;3902.941455878164;3918.941215881764;5389.676619402849;5399.325084364455;5419;5449.4005659377435;5461.9453805461835;4756.66703330767;4938.925916111261;4975.278584605212;4975.7760900759195;5004.274380214885;5894.551687262956;5896.793612223594;5924.348321684612;5926.585139040269;5933.821985340447;4225.915481690349;4238.766867822269;4248.745075295461;4253;4256.659467242614;5902.763889444417;6139.447449729546;6174.413430724074;6195.721192546346;6220.222472190931;4324.805383757738;4328;4330.112326972963;4333.133373325348;4347.5652434756275;4384.167008268419;4395.494518130392;4399.824007039747;4410.33844923264;4457.687961842705;4957.950420495749;5006.324146240284;5022.472640372781;5024.346834911438;5028.220625803006;5921.940780592139;5953.613015154001;5955.28536575605;5955.791547295824;5965.492933100648;1480;1503.5339044896118;1528.2206074901658;1537.423466200175;1539.3842463014885;976.9706908792748;1010.544815465727;1046.6964580271788;1049.9317544359592;1061.2730279758237;5810.970945145247;5822.7670893163795;5830.533557315404;5842.328132264844;5844.801815627786;6082.57421980466;6082.665453400017;6088.786892458743;6122.724477398528;6162.198914141133;5512.779488820483;5903;5904.9704751475965;5919.6152250103605;5945.583809133319;3288.704016638514;3308.20603055265;3312.93374132516;3325.750568707308;3342.5487559179687;6150.3849615039035;6397.840053998687;6421.839454013687;6435;6504.5121615879;6232.376762323732;6279.335975966373;6293.32533673187;6301.936980630135;6329.461995730415;6176.4441200292185;6344.143540622049;6408.903866442007;6429.260635026938;6433.099366088658;6160.845978850564;6178.351273116438;6194.5044396449075;6202.41077097675;6204.897551224388;6100.572959892765;6112.449879510687;6113;6114.2051533302165;6121;5998.8500287491415;6419.165508483868;6479.4816414685765;6485.481161507162;6486.708098135689;4232.851850185229;4344.869653910388;4346.500152482505;4347.195768782785;4348.347747837724;5911.290645122613;6130.7241174146375;6141.447269745744;6244.250689917239;6244.594101383395;5960.761569537343;5969.403059693996;5989.7304621293015;5995.800839832138;6008.789692360747;5921.348651648402;6001.519878409629;6006.579539432198;6015.097735339734;6022.4341671166685;5667.744951477276;5768.394318596655;5901.763929442946;5930.318013428511;5956.702164891652;5977.22296101504;6042.486388657014;6067.514598832171;6077.541390066263;6105.5420843437805;5626.549876009991;5921.822345329647;5935.34711181761;5945.027486256871;5969 15:37:40 INFO - PROCESS | 3465 | |5;yui.html;756.4288961833814;790.7113903425247;871.9433236839609;879.5558243087243;905.6241659711218;14307.642308942282;14705.779413308795;15154.621134471643;15394.076355418683;15494.922525387385;16133;16143.83856161438;16182.271797769099;16277.348906043744;16318.75521867173;865.8917635295588;869.2828416556334;879.1955360844819;890.2610833008588;890.6259371064168;881.9338549608773;889.0931250124869;889.8665200219987;892.295086881363;894.2622336572322;936.3773090894547;945.1540870920556;948.1987720376271;949.7625593601599;949.8480243161096;937.8452555328363;939.3330735178066;940.1961323068746;940.2759874896326;941.251704894607;688.215434404774;690.2855544511407;690.7720452250745;690.7789507357647;692.536000879412;14844.851551484455;14871.33079011447;14880.851191488055;14917.627059323604;14952.775708364383;16555.172241388;16561.751573726404;16846.83153168465;17171.313147474088;17406;12192.695182620417;12240.755184896341;12268.32524211168;12739.872601274054;12979.805302920464;4891.4308351283835;4921;4985.850424487271;5026.321446604698;5131.563817075553;77652;78412.60793695995;79177.60411197964;80199.59900200462;82783;12385.876141238652;12850.807237891253;12852.742945141232;12986.220826750425;13016.869831301567;23096.422589435064;23099.653505197435;23115.88442057779;23125.653115203284;23156.18953336625;9138.543072846463;9430.811383772287;9482.95258523703;9553.187979021723;9601.90398096024;5101.668391554537;5177.663451875616;5212.661177023481;5241.947580524222;5378.677279363251;3792.7534710243744;3855.248226595787;3864.478295430081;3874.1283211277237;3900.8244628991765;639.3446717114902;644.2784081828382;672.2537982839045;703.9788806335819;714.4820005496077;725.8366867454886;794.6026986506747;813.4834380168636;824.723717554626;864.9437786543855;10948.397838118979;10975.615853445252;11040.116790656728;11093.944530277297;11223.551057957753;736.3336180756424;801.3869389916719;832.367400775403;835.2733122183739;853.0658928473312;5246.422893481714;5318.946810531923;5328.387235467893;5370.91943620846;5400.540954018874;119568;122955;125536.37231813783;125908.37045814896;131925.3403732975;80276.59861700654;110915.44542277238;113303;113692;114312.42843785728;76694.616526917;78209;78230.6088469554;91375.54312228397;92315;10153.492325383553;10323.793524129625;10491.94754026225;10617.522211500656;10786.406747628957;50998;55945.44054559402;56419.94750656168;56694;57322;79715.20284797078;81153.59423202847;82305.17694822975;82974;84029.57985210035;13719.657008574866;13793.862061379257;13826.930865345608;13967.93016034954;14321.424643289021;15353.155576443403;15557.45548905783;15668.92165539165;16198.595035124215;17132.229049692545;14949.551513454613;15216.923915380352;15219.543413697607;15271.694566108394;15419.378705619847;15417;15505.767413488582;15616.297266623256;15877.52367428979;16013.119278439797;14853.925730371278;14934.551963441114;15223.923880380527;15230.314635841192;15989.200539973188;12574.937125314314;12579.87420125787;12653.810192847299;12751.808722868978;13003.869961300266;12727.93636031814;12798.808017879925;12808.10343275999;12915.870841291468;13219.074664773758 15:37:40 INFO - PROCESS | 3465 | __end_tp_report 15:37:40 INFO - PROCESS | 3465 | __start_cc_report 15:37:40 INFO - PROCESS | 3465 | _x_x_mozilla_cycle_collect,334 15:37:40 INFO - PROCESS | 3465 | __end_cc_report 15:37:40 INFO - PROCESS | 3465 | __startTimestamp1468190260586__endTimestamp 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | ------- Summary: start ------- 15:37:40 INFO - PROCESS | 3465 | Number of tests: 6 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#0] dojo.html Cycles:165 Average:5734.38 Median:5984.73 stddev:655.15 (10.9%) stddev-sans-first:630.69 15:37:40 INFO - PROCESS | 3465 | Values: 3384.4 3390.9 3412.5 3416.5 3416.9 5669.7 5686.1 5733.7 5734.2 5738.9 5733.3 5769.3 5810.3 5814.0 5817.1 5142.8 5191.9 5213.0 5255.5 5302.3 5127.7 5136.6 5213.6 5286.9 5292.3 5170.1 5218.9 5224.4 5245.1 5268.0 5233.7 5287.1 5291.8 5299.6 5327.4 5036.8 5144.9 5198.8 5249.4 5259.8 5554.7 5558.9 5577.3 5614.1 5629.2 6128.3 6183.5 6185.0 6208.6 6243.1 6255.6 6278.6 6278.8 6283.7 6294.6 5615.4 5719.4 5757.1 5773.6 5825.4 6296.7 6321.1 6352.9 6361.1 6373.8 5926.9 6100.5 6117.2 6124.8 6125.2 6032.0 6061.2 6078.0 6113.3 6139.9 6072.9 6127.4 6130.3 6141.4 6141.9 5989.5 6040.5 6054.4 6079.1 6125.5 4629.1 4733.8 4734.2 4737.6 4741.8 4216.8 4219.7 4228.9 4229.2 4230.1 5685.4 5820.4 5843.8 5956.9 5966.6 6019.4 6143.3 6149.7 6163.3 6228.0 5923.1 5963.7 5964.8 5977.3 5977.6 5179.2 5249.3 5284.5 5312.6 5359.7 6469.1 6544.2 6549.0 6556.3 6557.0 6298.3 6306.6 6307.8 6308.5 6316.1 6219.6 6254.1 6307.8 6368.7 6529.5 6108.0 6119.7 6120.3 6126.2 6129.6 6215.9 6217.0 6224.5 6232.3 6232.9 5858.8 5958.3 5989.7 6027.0 6082.6 5984.7 6034.0 6067.2 6080.0 6081.4 5753.2 5906.5 5963.1 5968.7 5997.6 5994.2 6034.0 6045.3 6138.6 6144.1 5994.3 5995.3 6002.0 6021.6 6023.4 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#1] ext.html Cycles:180 Average:71233.86 Median:43152.89 stddev:163121.64 (378.0%) stddev-sans-first:163493.14 15:37:40 INFO - PROCESS | 3465 | Values: 642.8 651.3 664.6 674.8 679.2 38171.4 40087.8 43150.0 43155.8 43209.4 42528.6 43506.1 43754.6 43807.6 43993.0 8664.4 8909.7 8915.1 8924.1 8943.4 8806.9 8835.1 8856.9 8911.2 8916.6 8846.6 8943.3 8945.6 8953.1 8954.3 8863.2 8894.3 8919.6 8954.9 8977.1 8785.9 8860.6 8914.1 8922.9 8943.8 35342.1 40184.0 40663.4 40798.2 40985.6 3280.1 3551.2 3647.1 3663.7 3741.9 32149.2 32232.7 34623.7 35096.3 36026.8 4796.7 4798.3 4834.3 4840.7 4871.5 359678.0 360496.0 361142.0 361858.0 363141.0 38509.0 67320.3 67508.3 67648.7 67752.0 38255.2 40121.8 40349.6 40351.2 40498.0 17140.7 17296.7 17309.7 17338.4 17359.3 13331.1 13340.4 13356.5 13365.4 13372.1 9064.5 9083.5 9097.0 9121.0 9134.1 3475.8 3497.3 3522.4 3583.0 3585.9 1030.9 1158.0 1163.0 1179.3 1238.6 33388.3 33922.0 34091.8 35098.0 35099.5 1149.1 1161.6 1179.4 1207.8 1221.5 17182.8 17518.1 17665.3 17902.8 17916.0 649490.0 652067.0 857381.0 958506.0 973216.0 64334.0 64719.4 64820.7 64963.0 65086.3 1518.5 1540.6 1553.6 1557.1 1568.3 33913.8 34083.8 34305.7 34450.7 34948.5 55681.7 56822.0 56896.4 57049.7 57094.0 522687.0 528597.0 529812.0 530460.0 533821.0 30182.0 30401.4 30507.4 30653.8 30688.4 51865.0 52551.2 53186.0 56987.7 57246.7 43694.8 44515.6 44648.0 45500.8 45612.8 43867.8 44009.6 44285.3 44638.0 44744.8 43010.6 43605.8 43700.6 43808.6 44774.3 38430.4 38626.6 38992.8 39723.8 39790.2 29500.6 30062.0 30368.7 30498.7 30824.7 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#2] jquery.html Cycles:180 Average:29569.42 Median:23865.32 stddev:81929.79 (343.3%) stddev-sans-first:82130.34 15:37:40 INFO - PROCESS | 3465 | Values: 398.2 405.1 414.6 425.2 428.7 18989.6 20313.1 20557.8 20721.3 21311.8 19233.5 19775.0 19793.1 19796.8 19851.5 5568.2 5907.7 5944.4 5944.5 5961.5 5746.9 5840.1 5912.6 5913.3 5949.1 5981.7 5986.9 6028.7 6040.5 6045.3 5745.2 5971.4 5989.7 6006.8 6022.8 5379.4 5423.5 5426.9 5434.0 5437.0 23512.5 23764.9 23965.8 24246.4 24275.0 2486.6 2501.8 2538.9 2553.9 2606.8 15136.7 15378.9 15386.7 15507.8 16000.9 1966.1 2063.1 2069.8 2116.9 2144.3 81976.2 82829.2 82863.0 83589.0 84310.6 10239.0 10535.7 10654.8 10949.9 11752.4 13959.0 13994.5 14001.0 14013.8 14033.6 8713.2 8871.4 8896.3 9044.2 9118.0 8937.9 9060.3 9124.4 9222.9 9319.6 6834.2 6837.2 6850.8 6967.4 6970.5 1826.3 1884.9 1912.6 1937.3 1949.6 987.9 1045.8 1097.7 1134.9 1193.6 20238.1 20473.6 20834.8 21017.2 21048.6 1067.1 1070.1 1090.9 1119.0 1206.6 11505.7 11587.3 11728.9 11936.9 12020.2 482894.0 497982.0 499438.0 502156.0 507644.0 82559.0 84159.0 84972.7 86738.6 87295.0 1051.7 1099.4 1108.7 1110.7 1118.5 18054.3 18065.2 18440.6 18505.9 18953.9 38636.6 44554.3 44740.3 45192.5 46052.5 51335.5 59308.4 61263.7 61734.3 62456.4 7918.7 8620.6 8749.3 8910.1 9035.4 12826.6 13238.3 13485.7 13489.4 13665.7 11444.6 11620.2 11723.2 11743.6 11904.3 10809.4 10882.1 11120.2 11174.4 11275.6 11592.9 11605.2 11702.5 11895.6 12020.9 7654.5 7816.8 7874.7 8025.6 8193.5 10011.7 11377.8 11516.7 11635.0 11680.1 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#3] mootools.html Cycles:180 Average:6238.50 Median:4664.66 stddev:3577.05 (76.7%) stddev-sans-first:3570.09 15:37:40 INFO - PROCESS | 3465 | Values: 1598.7 1628.6 1808.9 1879.4 1894.5 8394.2 9015.2 9133.4 9570.0 9571.0 9378.8 9450.8 9512.8 9560.3 9590.9 2458.5 2483.7 2487.7 2491.0 2497.2 2422.1 2446.7 2453.3 2454.2 2455.8 2426.6 2437.1 2471.1 2480.4 2482.5 2407.7 2411.3 2443.4 2446.7 2453.7 2410.0 2417.4 2437.9 2441.9 2453.9 9358.9 9380.0 9485.6 9487.4 9489.4 5338.2 5438.3 5447.2 5456.1 5467.4 3361.2 3394.4 3456.0 3464.0 3533.9 1140.5 1142.1 1159.0 1173.3 1183.5 12841.9 12908.6 12933.9 12941.4 12976.1 4713.8 4723.6 4804.1 4835.6 4864.1 11004.8 11031.5 11040.7 11041.8 11050.6 5402.6 5487.4 5496.2 5521.4 5581.5 4500.5 5018.6 5051.8 5217.3 5223.6 4211.1 4247.2 4254.6 4302.4 4323.8 1334.5 1356.3 1359.5 1361.7 1377.3 1058.9 1067.7 1070.5 1077.8 1083.7 6355.3 6453.8 6477.5 6519.6 6528.8 484.2 494.2 494.7 498.7 503.5 4507.7 4554.4 4584.4 4586.5 4615.5 11582.2 11922.1 11942.9 12002.0 12029.3 11187.5 11652.0 11696.9 11698.1 11777.1 8530.1 8935.5 8959.0 8999.4 9019.4 6594.4 6762.5 6801.8 6854.6 6890.4 10717.3 10926.0 10979.2 10979.8 11152.1 10937.2 11136.4 11151.1 11188.9 11279.0 7663.7 8149.9 8360.4 8418.8 8513.6 9277.9 9343.2 9393.8 9409.1 9409.2 8306.7 8503.0 8518.8 8588.0 8650.9 8254.1 8291.4 8307.8 8315.8 8410.4 7595.3 7744.3 7745.7 7756.9 7788.4 5638.2 5694.1 5775.0 5812.9 5883.4 5773.2 5792.1 5852.7 5858.8 5873.6 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#4] prototype.html Cycles:180 Average:5026.65 Median:5761.42 stddev:1492.27 (25.9%) stddev-sans-first:1454.60 15:37:40 INFO - PROCESS | 3465 | Values: 350.8 351.4 352.0 353.6 359.3 5699.4 5703.2 5725.2 5755.8 5767.0 5601.6 5635.3 5651.5 5656.9 5670.0 4024.5 4376.0 4388.4 4414.7 4437.4 4348.2 4399.9 4401.5 4409.9 4437.6 4343.2 4386.9 4388.2 4390.9 4392.8 4236.8 4337.7 4342.8 4356.7 4398.8 3877.1 3879.4 3893.9 3902.9 3918.9 5389.7 5399.3 5419.0 5449.4 5461.9 4756.7 4938.9 4975.3 4975.8 5004.3 5894.6 5896.8 5924.3 5926.6 5933.8 4225.9 4238.8 4248.7 4253.0 4256.7 5902.8 6139.4 6174.4 6195.7 6220.2 4324.8 4328.0 4330.1 4333.1 4347.6 4384.2 4395.5 4399.8 4410.3 4457.7 4958.0 5006.3 5022.5 5024.3 5028.2 5921.9 5953.6 5955.3 5955.8 5965.5 1480.0 1503.5 1528.2 1537.4 1539.4 977.0 1010.5 1046.7 1049.9 1061.3 5811.0 5822.8 5830.5 5842.3 5844.8 6082.6 6082.7 6088.8 6122.7 6162.2 5512.8 5903.0 5905.0 5919.6 5945.6 3288.7 3308.2 3312.9 3325.8 3342.5 6150.4 6397.8 6421.8 6435.0 6504.5 6232.4 6279.3 6293.3 6301.9 6329.5 6176.4 6344.1 6408.9 6429.3 6433.1 6160.8 6178.4 6194.5 6202.4 6204.9 6100.6 6112.4 6113.0 6114.2 6121.0 5998.9 6419.2 6479.5 6485.5 6486.7 4232.9 4344.9 4346.5 4347.2 4348.3 5911.3 6130.7 6141.4 6244.3 6244.6 5960.8 5969.4 5989.7 5995.8 6008.8 5921.3 6001.5 6006.6 6015.1 6022.4 5667.7 5768.4 5901.8 5930.3 5956.7 5977.2 6042.5 6067.5 6077.5 6105.5 5626.5 5921.8 5935.3 5945.0 5969.0 15:37:40 INFO - PROCESS | 3465 | 15:37:40 INFO - PROCESS | 3465 | [#5] yui.html Cycles:180 Average:22310.05 Median:3859.86 stddev:31800.90 (823.9%) stddev-sans-first:31848.93 15:37:40 INFO - PROCESS | 3465 | Values: 756.4 790.7 871.9 879.6 905.6 14307.6 14705.8 15154.6 15394.1 15494.9 16133.0 16143.8 16182.3 16277.3 16318.8 865.9 869.3 879.2 890.3 890.6 881.9 889.1 889.9 892.3 894.3 936.4 945.2 948.2 949.8 949.8 937.8 939.3 940.2 940.3 941.3 688.2 690.3 690.8 690.8 692.5 14844.9 14871.3 14880.9 14917.6 14952.8 16555.2 16561.8 16846.8 17171.3 17406.0 12192.7 12240.8 12268.3 12739.9 12979.8 4891.4 4921.0 4985.9 5026.3 5131.6 77652.0 78412.6 79177.6 80199.6 82783.0 12385.9 12850.8 12852.7 12986.2 13016.9 23096.4 23099.7 23115.9 23125.7 23156.2 9138.5 9430.8 9483.0 9553.2 9601.9 5101.7 5177.7 5212.7 5241.9 5378.7 3792.8 3855.2 3864.5 3874.1 3900.8 639.3 644.3 672.3 704.0 714.5 725.8 794.6 813.5 824.7 864.9 10948.4 10975.6 11040.1 11093.9 11223.6 736.3 801.4 832.4 835.3 853.1 5246.4 5318.9 5328.4 5370.9 5400.5 119568.0 122955.0 125536.4 125908.4 131925.3 80276.6 110915.4 113303.0 113692.0 114312.4 76694.6 78209.0 78230.6 91375.5 92315.0 10153.5 10323.8 10491.9 10617.5 10786.4 50998.0 55945.4 56419.9 56694.0 57322.0 79715.2 81153.6 82305.2 82974.0 84029.6 13719.7 13793.9 13826.9 13967.9 14321.4 15353.2 15557.5 15668.9 16198.6 17132.2 14949.6 15216.9 15219.5 15271.7 15419.4 15417.0 15505.8 15616.3 15877.5 16013.1 14853.9 14934.6 15223.9 15230.3 15989.2 12574.9 12579.9 12653.8 12751.8 13003.9 12727.9 12798.8 12808.1 12915.9 13219.1 15:37:40 INFO - PROCESS | 3465 | -------- Summary: end -------- 15:37:40 INFO - PROCESS | 3465 | 15:37:41 INFO - TEST-INFO | 3465: exit 0 15:37:41 INFO - TEST-OK | dromaeo_css | took 1110207ms 15:37:41 INFO - TEST-START | kraken 15:37:41 INFO - operating with platform_type : linux_ 15:37:41 INFO - Initialising browser for kraken test... 15:37:41 INFO - TEST-INFO | started process 3713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfiZwyQ/profile http://localhost:52021/getInfo.html) 15:37:45 INFO - PROCESS | 3713 | __metrics Screen width/height:1600/1200 15:37:45 INFO - PROCESS | 3713 | colorDepth:24 15:37:45 INFO - PROCESS | 3713 | Browser inner width/height: 1024/697 15:37:45 INFO - PROCESS | 3713 | __metrics 15:37:45 ERROR - PROCESS | 3713 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:37:46 INFO - TEST-INFO | 3713: exit 0 15:37:46 INFO - Browser initialized. 15:37:46 INFO - Running cycle 1/1 for kraken test... 15:37:46 INFO - TEST-INFO | started process 3841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfiZwyQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:58 INFO - PROCESS | 3841 | RSS: Main: 156090368 15:37:58 INFO - PROCESS | 3841 | 15:38:01 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52021/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:01 INFO - PROCESS | 3841 | RSS: Main: 160735232 15:38:01 INFO - PROCESS | 3841 | 15:38:04 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52021/tests/kraken/driver.html?testName=audio-dft) 15:38:05 INFO - PROCESS | 3841 | RSS: Main: 160342016 15:38:05 INFO - PROCESS | 3841 | 15:38:07 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52021/tests/kraken/driver.html?testName=audio-fft) 15:38:08 INFO - PROCESS | 3841 | RSS: Main: 160911360 15:38:08 INFO - PROCESS | 3841 | 15:38:10 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52021/tests/kraken/driver.html?testName=audio-oscillator) 15:38:11 INFO - PROCESS | 3841 | RSS: Main: 160686080 15:38:11 INFO - PROCESS | 3841 | 15:38:13 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52021/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:14 INFO - PROCESS | 3841 | RSS: Main: 160587776 15:38:14 INFO - PROCESS | 3841 | 15:38:17 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52021/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:17 INFO - PROCESS | 3841 | RSS: Main: 160370688 15:38:17 INFO - PROCESS | 3841 | 15:38:21 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52021/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:21 INFO - PROCESS | 3841 | RSS: Main: 161173504 15:38:21 INFO - PROCESS | 3841 | 15:38:24 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52021/tests/kraken/driver.html?testName=json-parse-financial) 15:38:25 INFO - PROCESS | 3841 | RSS: Main: 161243136 15:38:25 INFO - PROCESS | 3841 | 15:38:26 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52021/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:27 INFO - PROCESS | 3841 | RSS: Main: 161001472 15:38:27 INFO - PROCESS | 3841 | 15:38:29 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:29 INFO - PROCESS | 3841 | RSS: Main: 161042432 15:38:29 INFO - PROCESS | 3841 | 15:38:31 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:32 INFO - PROCESS | 3841 | RSS: Main: 161550336 15:38:32 INFO - PROCESS | 3841 | 15:38:35 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:35 INFO - PROCESS | 3841 | RSS: Main: 161763328 15:38:35 INFO - PROCESS | 3841 | 15:38:38 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:38 INFO - PROCESS | 3841 | RSS: Main: 161665024 15:38:38 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | Cycle 1(1): loaded http://localhost:52021/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52021/tests/kraken/driver.html?testName=ai-astar) 15:38:40 INFO - PROCESS | 3841 | RSS: Main: 162062336 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | __start_tp_report 15:38:40 INFO - PROCESS | 3841 | _x_x_mozilla_page_load 15:38:40 INFO - PROCESS | 3841 | _x_x_mozilla_page_load_details 15:38:40 INFO - PROCESS | 3841 | |i|pagename|runs| 15:38:40 INFO - PROCESS | 3841 | |0;ai-astar;112;105;111;111;111;111;110;109;109;110 15:38:40 INFO - PROCESS | 3841 | |1;audio-beat-detection;155;123;151;178;126;154;150;126;175;127 15:38:40 INFO - PROCESS | 3841 | |2;audio-dft;162;161;165;161;162;162;163;161;162;159 15:38:40 INFO - PROCESS | 3841 | |3;audio-fft;77;75;75;177;76;76;75;79;168;75 15:38:40 INFO - PROCESS | 3841 | |4;audio-oscillator;86;84;139;84;86;86;135;85;85;135 15:38:40 INFO - PROCESS | 3841 | |5;imaging-gaussian-blur;117;118;117;118;116;117;117;117;117;117 15:38:40 INFO - PROCESS | 3841 | |6;imaging-darkroom;149;147;147;147;146;148;147;147;147;146 15:38:40 INFO - PROCESS | 3841 | |7;imaging-desaturate;95;96;95;100;95;96;96;96;95;96 15:38:40 INFO - PROCESS | 3841 | |8;json-parse-financial;54;55;53;53;54;53;54;54;54;53 15:38:40 INFO - PROCESS | 3841 | |9;json-stringify-tinderbox;59;59;59;60;61;59;60;60;64;61 15:38:40 INFO - PROCESS | 3841 | |10;stanford-crypto-aes;77;83;77;76;77;79;79;80;114;77 15:38:40 INFO - PROCESS | 3841 | |11;stanford-crypto-ccm;128;131;138;158;124;117;125;123;125;121 15:38:40 INFO - PROCESS | 3841 | |12;stanford-crypto-pbkdf2;157;152;153;153;154;152;158;157;158;156 15:38:40 INFO - PROCESS | 3841 | |13;stanford-crypto-sha256-iterative;63;62;65;61;63;62;68;61;59;63 15:38:40 INFO - PROCESS | 3841 | __end_tp_report 15:38:40 INFO - PROCESS | 3841 | __start_cc_report 15:38:40 INFO - PROCESS | 3841 | _x_x_mozilla_cycle_collect,900 15:38:40 INFO - PROCESS | 3841 | __end_cc_report 15:38:40 INFO - PROCESS | 3841 | __startTimestamp1468190320869__endTimestamp 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | ------- Summary: start ------- 15:38:40 INFO - PROCESS | 3841 | Number of tests: 14 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.97 (1.8%) stddev-sans-first:1.94 15:38:40 INFO - PROCESS | 3841 | Values: 112.0 105.0 111.0 111.0 111.0 111.0 110.0 109.0 109.0 110.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:152.50 stddev:20.38 (13.4%) stddev-sans-first:21.38 15:38:40 INFO - PROCESS | 3841 | Values: 155.0 123.0 151.0 178.0 126.0 154.0 150.0 126.0 175.0 127.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.64 15:38:40 INFO - PROCESS | 3841 | Values: 162.0 161.0 165.0 161.0 162.0 162.0 163.0 161.0 162.0 159.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:40.76 (54.0%) stddev-sans-first:42.69 15:38:40 INFO - PROCESS | 3841 | Values: 77.0 75.0 75.0 177.0 76.0 76.0 75.0 79.0 168.0 75.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:85.00 stddev:24.76 (29.1%) stddev-sans-first:25.70 15:38:40 INFO - PROCESS | 3841 | Values: 86.0 84.0 139.0 84.0 86.0 86.0 135.0 85.0 85.0 135.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:38:40 INFO - PROCESS | 3841 | Values: 117.0 118.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 15:38:40 INFO - PROCESS | 3841 | Values: 149.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 146.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.54 15:38:40 INFO - PROCESS | 3841 | Values: 95.0 96.0 95.0 100.0 95.0 96.0 96.0 96.0 95.0 96.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 15:38:40 INFO - PROCESS | 3841 | Values: 54.0 55.0 53.0 53.0 54.0 53.0 54.0 54.0 54.0 53.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.55 (2.6%) stddev-sans-first:1.58 15:38:40 INFO - PROCESS | 3841 | Values: 59.0 59.0 59.0 60.0 61.0 59.0 60.0 60.0 64.0 61.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.00 stddev:11.46 (14.7%) stddev-sans-first:12.02 15:38:40 INFO - PROCESS | 3841 | Values: 77.0 83.0 77.0 76.0 77.0 79.0 79.0 80.0 114.0 77.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:126.50 stddev:11.68 (9.2%) stddev-sans-first:12.38 15:38:40 INFO - PROCESS | 3841 | Values: 128.0 131.0 138.0 158.0 124.0 117.0 125.0 123.0 125.0 121.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:156.50 stddev:2.45 (1.6%) stddev-sans-first:2.49 15:38:40 INFO - PROCESS | 3841 | Values: 157.0 152.0 153.0 153.0 154.0 152.0 158.0 157.0 158.0 156.0 15:38:40 INFO - PROCESS | 3841 | 15:38:40 INFO - PROCESS | 3841 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.45 (3.9%) stddev-sans-first:2.60 15:38:40 INFO - PROCESS | 3841 | Values: 63.0 62.0 65.0 61.0 63.0 62.0 68.0 61.0 59.0 63.0 15:38:40 INFO - PROCESS | 3841 | -------- Summary: end -------- 15:38:40 INFO - PROCESS | 3841 | 15:38:41 INFO - TEST-INFO | 3841: exit 0 15:38:41 INFO - TEST-OK | kraken | took 60655ms 15:38:41 INFO - SUITE-END | took 1170s 15:38:42 INFO - Completed test suite (00:19:31) 15:38:42 INFO - javascript benchmark 15:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7692.15650301113, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.3908096542627, 3390.88131915383, 3412.539307193528, 3416.5046068320094, 3416.9487457688124, 5669.744861481233, 5686.09022556391, 5733.741981610827, 5734.197212390269, 5738.885222295557, 5733.254676892008, 5769.278840144982, 5810.331811841639, 5813.970930145343, 5817.127430885369, 5142.794288228466, 5191.948080519203, 5212.973935130338, 5255.474452554752, 5302.337207849019, 5127.692338459704, 5136.64043516954, 5213.608979326546, 5286.894262114755, 5292.338457692788, 5170.146925757245, 5218.895622087556, 5224.399194092671, 5245.10833158364, 5267.973660131694, 5233.65981211222, 5287.07476191665, 5291.788328466857, 5299.629025968184, 5327.440618735016, 5036.7733451994745, 5144.897102057937, 5198.844034678966, 5249.396319423277, 5259.76331065103, 5554.694491802949, 5558.86102847428, 5577.3028371453565, 5614.129809879434, 5629.155626655994, 6128.264608246995, 6183.505319574423, 6184.969075154595, 6208.565400421972, 6243.063540468921, 6255.600469941626, 6278.560500764948, 6278.780242691484, 6283.717232724538, 6294.622322660655, 5615.354234263071, 5719.399463056361, 5757.050086735683, 5773.624714393551, 5825.359210486843, 6296.653684047421, 6321.1150438938585, 6352.872942541216, 6361.109444677749, 6373.808785736435, 5926.851828704317, 6100.511959043266, 6117.174181485531, 6124.816255512342, 6125.234345706786, 6031.9698401508585, 6061.181740464981, 6078.0, 6113.29697084841, 6139.938600613937, 6072.878542429126, 6127.356627554132, 6130.29501607312, 6141.447269745744, 6141.877162456726, 5989.460948514655, 6040.546958978094, 6054.364291749391, 6079.088136779518, 6125.540584456184, 4629.120467111238, 4733.83431579893, 4734.218853889139, 4737.573618374363, 4741.810327586858, 4216.8313267469575, 4219.683523735732, 4228.9154216915485, 4229.196452673982, 4230.069384735415, 5685.403032681592, 5820.3888591698105, 5843.824685259449, 5956.880862382728, 5966.552508561788, 6019.428154325332, 6143.262808462924, 6149.66176860268, 6163.291221509494, 6228.03465462854, 5923.141144534018, 5963.731632076567, 5964.821055368346, 5977.282726072812, 5977.6114552553945, 5179.19722443022, 5249.343832020997, 5284.524392804666, 5312.601554883399, 5359.678419294854, 6469.061986012002, 6544.181977252843, 6549.01764735284, 6556.344365563501, 6557.0, 6298.307186209513, 6306.558540902093, 6307.779227727007, 6308.52686048539, 6316.115743795965, 6219.564630475823, 6254.124422580933, 6307.810765677037, 6368.745250190126, 6529.542931994714, 6108.02271636536, 6119.663418512025, 6120.265568131853, 6126.203593532812, 6129.632222066691, 6215.875682486235, 6217.0, 6224.502039836892, 6232.283287422005, 6232.937670623236, 5858.765649373977, 5958.314793798769, 5989.7304621293015, 6027.0, 6082.635041897501, 5984.730687119003, 6033.9698301508215, 6067.150598916067, 6080.027195648675, 6081.361457047124, 5753.165790960371, 5906.468417842415, 5963.075723262901, 5968.731407086779, 5997.580169388101, 5994.160817485643, 6033.9698301508215, 6045.304789949212, 6138.570300078952, 6144.078388241799, 5994.280686317496, 5995.250593675791, 6002.039673652194, 6021.638701677914, 6023.397660233942], "value": 5690.543759944823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.8103709405725, 651.3356376495974, 664.558068884192, 674.7941877727297, 679.1510611735331, 38171.42742858856, 40087.799561002226, 43150.0, 43155.78422107885, 43209.35185972213, 42528.57471425285, 43506.12987740251, 43754.562454375446, 43807.561924380745, 43993.0, 8664.350173736964, 8909.68816091437, 8915.108489151065, 8924.062973387798, 8943.373963822534, 8806.911930880673, 8835.116488351177, 8856.8671469928, 8911.197992180703, 8916.554172291391, 8846.601902914352, 8943.284537237038, 8945.59744811485, 8953.05992870749, 8954.2836573074, 8863.246624036932, 8894.332925030583, 8919.643214271422, 8954.865677014817, 8977.147171018743, 8785.868211976825, 8860.601272942733, 8914.108589141098, 8922.910770892273, 8943.821123577492, 35342.116447088774, 40184.0, 40663.39004914929, 40798.18403631911, 40985.59014409877, 3280.1471617379416, 3551.236484155919, 3647.1246900743895, 3663.725220608465, 3741.850325986957, 32149.1962700932, 32232.677673223203, 34623.653763462295, 35096.29807403838, 36026.8198659005, 4796.664233503656, 4798.328234047236, 4834.299026641117, 4840.709557426566, 4871.537203965653, 359678.0, 360496.0, 361141.9999999974, 361858.0, 363141.0, 38509.0, 67320.32679673239, 67508.3249167502, 67648.6617566909, 67752.0, 38255.23489530194, 40121.79939100344, 40349.59650403517, 40351.1929761409, 40498.0, 17140.742888856676, 17296.740548891525, 17309.65380692379, 17338.393156239472, 17359.305627775, 13331.066825322328, 13340.399682014138, 13356.532521361705, 13365.398557064955, 13372.130811497222, 9064.456132632064, 9083.50040747752, 9096.954515227513, 9121.0, 9134.132257435665, 3475.826208689555, 3497.283056973314, 3522.4188008978745, 3582.982085089558, 3585.94621080684, 1030.8659874216453, 1157.9536818527333, 1162.953481860733, 1179.2983175010854, 1238.5541205166132, 33388.3322333552, 33922.0, 34091.82954085214, 35098.0, 35099.473507897404, 1149.0635132367095, 1161.59344229519, 1179.3572502985894, 1207.7644859252362, 1221.4869754703045, 17182.828171718375, 17518.124093795515, 17665.318690547014, 17902.820971790377, 17916.0, 649490.0, 652067.0, 857381.0, 958506.0, 973216.0, 64334.0, 64719.35280647228, 64820.67589662022, 64963.0, 65086.34913650898, 1518.506485392252, 1540.5840423085704, 1553.6115971007475, 1557.0579799221534, 1568.3412966554074, 33913.83043084769, 34083.82958085194, 34305.656943430244, 34450.65549344474, 34948.47577286292, 55681.72159139178, 56822.0, 56896.431035689115, 57049.71475142598, 57094.0, 522687.0, 528597.0, 529812.0, 530460.0, 533821.0, 30182.0, 30401.391972159992, 30507.389852203276, 30653.846730766203, 30688.386232274785, 51865.0, 52551.211731823285, 53186.0, 56987.71506142443, 57246.713766430905, 43694.78152609216, 44515.55484445244, 44648.0, 45500.77249613731, 45612.77193614011, 43867.78066109649, 44009.55990440054, 44285.33571996487, 44638.0, 44744.77627611841, 43010.56989430066, 43605.78197108994, 43700.56299436965, 43808.561914381724, 44774.3283850736, 38430.423543646306, 38626.6137338623, 38992.805035975776, 39723.80138099407, 39790.2041959165, 29500.557491637213, 30062.0, 30368.69631303747, 30498.697897141585, 30824.69175308218], "value": 20324.36668785655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.17974971558584, 405.0986554915313, 414.5977907860576, 425.1902949571836, 428.6742076022222, 18989.62020759584, 20313.109198332484, 20557.794422055777, 20721.274755383565, 21311.786882131175, 19233.519162020955, 19775.0, 19793.109310081047, 19796.80203197971, 19851.503712407197, 5568.248286481314, 5907.704614769265, 5944.405559444042, 5944.464998150165, 5961.463468287853, 5746.87935852509, 5840.094785308284, 5912.645241285537, 5913.349531551526, 5949.137375080611, 5981.730822112993, 5986.910196347058, 6028.728707208164, 6040.456358927696, 6045.304789949146, 5745.195672605839, 5971.402859714016, 5989.730462129215, 6006.819795406145, 6022.759089636453, 5379.408265090837, 5423.484768946943, 5426.864328391783, 5433.972830135864, 5437.02133615949, 23512.529749404915, 23764.88117559401, 23965.760342396527, 24246.39384015396, 24275.0, 2486.6021436570245, 2501.762332578402, 2538.9111381101757, 2553.8723063846733, 2606.843589384624, 15136.697266054618, 15378.923105384401, 15386.692266154727, 15507.767383489258, 16000.919995399949, 1966.1447270437407, 2063.13348393675, 2069.8240649544805, 2116.8941552922292, 2144.292383513437, 81976.18023819746, 82829.17170828275, 82863.0, 83589.0, 84310.57844710798, 10239.0, 10535.736606584744, 10654.840177397346, 10949.890501095046, 11752.353620550952, 13959.0, 13994.510192143429, 14001.0, 14013.789793153112, 14033.578992630237, 8713.215810577078, 8871.379003469696, 8896.332775041898, 9044.186023257938, 9118.0, 8937.910620893708, 9060.320475964329, 9124.406913550598, 9222.907770922338, 9319.627214911463, 6834.2482326944, 6837.247902730695, 6850.794476165723, 6967.407770339477, 6970.546914450646, 1826.3151318255655, 1884.9340273090377, 1912.5887934094237, 1937.3122541497846, 1949.5905859769607, 987.9012098790064, 1045.816982028142, 1097.6981330134117, 1134.8694900086596, 1193.6001439517686, 20238.089285982165, 20473.590528189354, 20834.79165208359, 21017.159313627282, 21048.579028419346, 1067.071647666535, 1070.1385384765338, 1090.9127269818396, 1119.0152665654173, 1206.5535751771724, 11505.712357191138, 11587.319838623353, 11728.88271117295, 11936.880631193577, 12020.158588898694, 482894.0, 497982.0, 499438.0, 502156.0, 507644.0, 82559.0, 84159.0, 84972.72540911891, 86738.56630716933, 87295.0, 1051.6687243518268, 1099.3568762273999, 1108.6784832398675, 1110.6612483192703, 1118.4910865556153, 18054.277828886698, 18065.187066581773, 18440.631187376446, 18505.90747046256, 18953.90523047376, 38636.6136338633, 44554.3316850254, 44740.32889506595, 45192.54807452015, 46052.539474604826, 51335.48664513307, 59308.40691593029, 61263.69368153309, 61734.342739159925, 62456.375436245056, 7918.722844700408, 8620.568971551524, 8749.300055995378, 8910.064443233627, 9035.412698174598, 12826.61520154397, 13238.271895045866, 13485.73028539404, 13489.392977315849, 13665.726685466036, 11444.599439019594, 11620.244684095507, 11723.237989530653, 11743.588974385855, 11904.285742855456, 10809.35143891369, 10882.095633264305, 11120.165987550805, 11174.441277936234, 11275.605353812578, 11592.942035289769, 11605.245659032136, 11702.4733886977, 11895.643130706092, 12020.939895300467, 7654.540727556365, 7816.84366312682, 7874.6850125994315, 8025.638846252049, 8193.549354785544, 10011.749706257402, 11377.829332560184, 11516.712082197677, 11635.0, 11680.123990700562], "value": 9671.543592564465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1598.6882557901206, 1628.560288722045, 1808.8643351748622, 1879.3891985104844, 1894.469548526413, 8394.24451799338, 9015.233705135062, 9133.406328588637, 9570.042995700434, 9571.042895710434, 9378.765530861732, 9450.81098378032, 9512.76218094548, 9560.330776845623, 9590.856137157949, 2458.459138989424, 2483.7019557653016, 2487.7139129000216, 2490.950180996379, 2497.2383423055962, 2422.0675040109595, 2446.706395232575, 2453.288546321565, 2454.1778504201116, 2455.8035357171384, 2426.5632186206476, 2437.098273638756, 2471.085698291635, 2480.4295012147127, 2482.491089326693, 2407.735149133594, 2411.288669842401, 2443.389152711822, 2446.7308596054418, 2453.668754718117, 2410.0359856057544, 2417.4439878827793, 2437.890294936732, 2441.8779061046876, 2453.889574969113, 9358.906410935871, 9379.953100234523, 9485.620575176985, 9487.383320084242, 9489.430634161972, 5338.172583249602, 5438.293021907127, 5447.237386765856, 5456.127019676833, 5467.425920278393, 3361.226917808893, 3394.389009978203, 3455.9654403455893, 3464.0300715799617, 3533.876314329012, 1140.5038808118495, 1142.126273400849, 1159.0437888741822, 1173.3136115372517, 1183.5029287699188, 12841.935790321082, 12908.612741617766, 12933.935330323382, 12941.417636206394, 12976.091673582852, 4713.787879545429, 4723.622110231173, 4804.0872234275375, 4835.564799168092, 4864.100141473838, 11004.779904401867, 11031.503582338813, 11040.668779936615, 11041.779164416666, 11050.557977680963, 5402.648827826179, 5487.396386397493, 5496.203050557647, 5521.3926468088475, 5581.49766521015, 4500.549945005539, 5018.573421259161, 5051.848444546669, 5217.2695822584865, 5223.608229382811, 4211.094614657802, 4247.23549761046, 4254.617084462351, 4302.397664326997, 4323.805428755651, 1334.4662135145825, 1356.2743931996336, 1359.5309618181711, 1361.6868120332379, 1377.304461247084, 1058.88352281249, 1067.6796960911695, 1070.4701172919454, 1077.8221593437152, 1083.6965649618119, 6355.332690067568, 6453.838654033687, 6477.5465717400275, 6519.608823470607, 6528.771492997722, 484.23007418205225, 494.1845954175567, 494.74026136278025, 498.66838552363, 503.4990184766108, 4507.661925355612, 4554.362389265505, 4584.4498660161, 4586.541345865387, 4615.538446155358, 11582.247153935135, 11922.10584206188, 11942.880571194351, 12002.0, 12029.278243305429, 11187.4965626547, 11652.009579185864, 11696.941515292368, 11698.122640801974, 11777.116716246315, 8530.14698530142, 8935.508547029976, 8959.0, 8999.415038022507, 9019.413738107134, 6594.439472644879, 6762.459003279628, 6801.795946121624, 6854.554453960476, 6890.379865812101, 10717.303375280582, 10926.0, 10979.17656175774, 10979.835302470628, 11152.107831373633, 10937.179711521827, 11136.443177841238, 11151.10791136691, 11188.888111118784, 11279.0, 7663.655135519027, 8149.9185008151535, 8360.414770965974, 8418.831623367376, 8513.574321284035, 9277.907220927975, 9343.15911567935, 9393.81212375735, 9409.059094090537, 9409.153176214173, 8306.709265175932, 8503.0, 8518.829623407373, 8587.9694436668, 8650.870236946577, 8254.133316001973, 8291.419600627898, 8307.792305192419, 8315.792105197419, 8410.369222308474, 7595.3164215220895, 7744.303012728881, 7745.728899488491, 7756.92243077562, 7788.415868809749, 5638.154276858504, 5694.1458781183155, 5774.971125144515, 5812.94187058124, 5883.411658834082, 5773.191753154478, 5792.073268277056, 5852.678102704393, 5858.8242352729485, 5873.5594830388745], "value": 4895.383466256199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7790092241887, 351.3920916813913, 351.9771214871033, 353.60219752778124, 359.32088353012796, 5699.373068962416, 5703.173039909216, 5725.167946257194, 5755.848830233949, 5767.0, 5601.551875849932, 5635.295588051494, 5651.519620832234, 5656.943430565693, 5670.0, 4024.4768180136616, 4375.980573404357, 4388.385626012361, 4414.690971631987, 4437.445319335083, 4348.152110338485, 4399.86800395987, 4401.515833258339, 4409.867703968886, 4437.64498840092, 4343.174796788616, 4386.890327741816, 4388.23205938961, 4390.868273951771, 4392.780360981938, 4236.766977816219, 4337.7397356158735, 4342.804573794187, 4356.673249506268, 4398.780060996937, 3877.0695033192114, 3879.35990561557, 3893.922121557553, 3902.941455878164, 3918.941215881764, 5389.676619402849, 5399.325084364455, 5419.0, 5449.4005659377435, 5461.9453805461835, 4756.66703330767, 4938.925916111261, 4975.278584605212, 4975.7760900759195, 5004.274380214885, 5894.551687262956, 5896.793612223594, 5924.348321684612, 5926.585139040269, 5933.821985340447, 4225.915481690349, 4238.766867822269, 4248.745075295461, 4253.0, 4256.659467242614, 5902.763889444417, 6139.447449729546, 6174.413430724074, 6195.721192546346, 6220.222472190931, 4324.805383757738, 4328.0, 4330.112326972963, 4333.133373325348, 4347.5652434756275, 4384.167008268419, 4395.494518130392, 4399.824007039747, 4410.33844923264, 4457.687961842705, 4957.950420495749, 5006.324146240284, 5022.472640372781, 5024.346834911438, 5028.220625803006, 5921.940780592139, 5953.613015154001, 5955.28536575605, 5955.791547295824, 5965.492933100648, 1480.0, 1503.5339044896118, 1528.2206074901658, 1537.423466200175, 1539.3842463014885, 976.9706908792748, 1010.544815465727, 1046.6964580271788, 1049.9317544359592, 1061.2730279758237, 5810.970945145247, 5822.7670893163795, 5830.533557315404, 5842.328132264844, 5844.801815627786, 6082.57421980466, 6082.665453400017, 6088.786892458743, 6122.724477398528, 6162.198914141133, 5512.779488820483, 5903.0, 5904.9704751475965, 5919.6152250103605, 5945.583809133319, 3288.704016638514, 3308.20603055265, 3312.93374132516, 3325.750568707308, 3342.5487559179687, 6150.3849615039035, 6397.840053998687, 6421.839454013687, 6435.0, 6504.5121615879, 6232.376762323732, 6279.335975966373, 6293.32533673187, 6301.936980630135, 6329.461995730415, 6176.4441200292185, 6344.143540622049, 6408.903866442007, 6429.260635026938, 6433.099366088658, 6160.845978850564, 6178.351273116438, 6194.5044396449075, 6202.41077097675, 6204.897551224388, 6100.572959892765, 6112.449879510687, 6113.0, 6114.2051533302165, 6121.0, 5998.8500287491415, 6419.165508483868, 6479.4816414685765, 6485.481161507162, 6486.708098135689, 4232.851850185229, 4344.869653910388, 4346.500152482505, 4347.195768782785, 4348.347747837724, 5911.290645122613, 6130.7241174146375, 6141.447269745744, 6244.250689917239, 6244.594101383395, 5960.761569537343, 5969.403059693996, 5989.7304621293015, 5995.800839832138, 6008.789692360747, 5921.348651648402, 6001.519878409629, 6006.579539432198, 6015.097735339734, 6022.4341671166685, 5667.744951477276, 5768.394318596655, 5901.763929442946, 5930.318013428511, 5956.702164891652, 5977.22296101504, 6042.486388657014, 6067.514598832171, 6077.541390066263, 6105.5420843437805, 5626.549876009991, 5921.822345329647, 5935.34711181761, 5945.027486256871, 5969.0], "value": 4551.8681724378475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.4288961833814, 790.7113903425247, 871.9433236839609, 879.5558243087243, 905.6241659711218, 14307.642308942282, 14705.779413308795, 15154.621134471643, 15394.076355418683, 15494.922525387385, 16133.0, 16143.83856161438, 16182.271797769099, 16277.348906043744, 16318.75521867173, 865.8917635295588, 869.2828416556334, 879.1955360844819, 890.2610833008588, 890.6259371064168, 881.9338549608773, 889.0931250124869, 889.8665200219987, 892.295086881363, 894.2622336572322, 936.3773090894547, 945.1540870920556, 948.1987720376271, 949.7625593601599, 949.8480243161096, 937.8452555328363, 939.3330735178066, 940.1961323068746, 940.2759874896326, 941.251704894607, 688.215434404774, 690.2855544511407, 690.7720452250745, 690.7789507357647, 692.536000879412, 14844.851551484455, 14871.33079011447, 14880.851191488055, 14917.627059323604, 14952.775708364383, 16555.172241388, 16561.751573726404, 16846.83153168465, 17171.313147474088, 17406.0, 12192.695182620417, 12240.755184896341, 12268.32524211168, 12739.872601274054, 12979.805302920464, 4891.4308351283835, 4921.0, 4985.850424487271, 5026.321446604698, 5131.563817075553, 77652.0, 78412.60793695995, 79177.60411197964, 80199.59900200462, 82783.0, 12385.876141238652, 12850.807237891253, 12852.742945141232, 12986.220826750425, 13016.869831301567, 23096.422589435064, 23099.653505197435, 23115.88442057779, 23125.653115203284, 23156.18953336625, 9138.543072846463, 9430.811383772287, 9482.95258523703, 9553.187979021723, 9601.90398096024, 5101.668391554537, 5177.663451875616, 5212.661177023481, 5241.947580524222, 5378.677279363251, 3792.7534710243744, 3855.248226595787, 3864.478295430081, 3874.1283211277237, 3900.8244628991765, 639.3446717114902, 644.2784081828382, 672.2537982839045, 703.9788806335819, 714.4820005496077, 725.8366867454886, 794.6026986506747, 813.4834380168636, 824.723717554626, 864.9437786543855, 10948.397838118979, 10975.615853445252, 11040.116790656728, 11093.944530277297, 11223.551057957753, 736.3336180756424, 801.3869389916719, 832.367400775403, 835.2733122183739, 853.0658928473312, 5246.422893481714, 5318.946810531923, 5328.387235467893, 5370.91943620846, 5400.540954018874, 119568.0, 122955.0, 125536.37231813783, 125908.37045814896, 131925.3403732975, 80276.59861700654, 110915.44542277238, 113303.0, 113692.0, 114312.42843785728, 76694.616526917, 78209.0, 78230.6088469554, 91375.54312228397, 92315.0, 10153.492325383553, 10323.793524129625, 10491.94754026225, 10617.522211500656, 10786.406747628957, 50998.0, 55945.44054559402, 56419.94750656168, 56694.0, 57322.0, 79715.20284797078, 81153.59423202847, 82305.17694822975, 82974.0, 84029.57985210035, 13719.657008574866, 13793.862061379257, 13826.930865345608, 13967.93016034954, 14321.424643289021, 15353.155576443403, 15557.45548905783, 15668.92165539165, 16198.595035124215, 17132.229049692545, 14949.551513454613, 15216.923915380352, 15219.543413697607, 15271.694566108394, 15419.378705619847, 15417.0, 15505.767413488582, 15616.297266623256, 15877.52367428979, 16013.119278439797, 14853.925730371278, 14934.551963441114, 15223.923880380527, 15230.314635841192, 15989.200539973188, 12574.937125314314, 12579.87420125787, 12653.810192847299, 12751.808722868978, 13003.869961300266, 12727.93636031814, 12798.808017879925, 12808.10343275999, 12915.870841291468, 13219.074664773758], "value": 8310.085343138146, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 111.0, 111.0, 111.0, 110.0, 109.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 151.0, 178.0, 126.0, 154.0, 150.0, 126.0, 175.0, 127.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 165.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0, 159.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 177.0, 76.0, 76.0, 75.0, 79.0, 168.0, 75.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 139.0, 84.0, 86.0, 86.0, 135.0, 85.0, 85.0, 135.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 100.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 61.0, 59.0, 60.0, 60.0, 64.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 77.0, 76.0, 77.0, 79.0, 79.0, 80.0, 114.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 131.0, 138.0, 158.0, 124.0, 117.0, 125.0, 123.0, 125.0, 121.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 153.0, 153.0, 154.0, 152.0, 158.0, 157.0, 158.0, 156.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 61.0, 63.0, 62.0, 68.0, 61.0, 59.0, 63.0], "value": 62.7, "unit": "score"}]}]} 15:38:42 INFO - Return code: 0 15:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:42 ERROR - # TBPL SUCCESS # 15:38:42 INFO - Running post-action listener: _resource_record_post_action 15:38:42 INFO - ##### 15:38:42 INFO - ##### Finished run-tests step (success) 15:38:42 INFO - ##### 15:38:42 INFO - Running post-run listener: _resource_record_post_run 15:38:42 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 7909376; Write bytes: 384032768; Read time: 1076; Write time: 273980 15:38:42 INFO - TinderboxPrint: CPU usage
13.3% 15:38:42 INFO - TinderboxPrint: I/O read bytes / time
7,909,376 / 1,076 15:38:42 INFO - TinderboxPrint: I/O write bytes / time
384,032,768 / 273,980 15:38:42 INFO - TinderboxPrint: CPU idle
8,214.5 (86.7%) 15:38:42 INFO - TinderboxPrint: CPU user
1,208.8 (12.8%) 15:38:42 INFO - TinderboxPrint: Swap in / out
0 / 0 15:38:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112209920; Read time: 0; Write time: 109012 15:38:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6148096; Write bytes: 271822848; Read time: 1004; Write time: 164968 15:38:42 INFO - Running post-run listener: _upload_blobber_files 15:38:42 INFO - Blob upload gear active. 15:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:42 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 15:38:42 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'] 15:38:42 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 15:38:43 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:43 INFO - (blobuploader) - INFO - Done attempting. 15:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:47 INFO - (blobuploader) - INFO - Done attempting. 15:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:48 INFO - (blobuploader) - INFO - Done attempting. 15:38:48 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:48 INFO - Return code: 0 15:38:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/848460aa0f873cc3313762b61f4e85ada38d194ba67e477d548946a50012fec57f20cb26edd0c624b7f6e84fd6a632334a0a31c789ed8fa6de57ad728ba278e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512d7f82c9d6d0deffbccb186017b9c66e5f88112c752363f4cb3beaf01a9e2bb3d07b528fed83caa58a435b73e0d22d23df9d82f7e09983cd89c897c3f23bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db7d5a1359c3258ddba505e81886f785340165f65fc02127ee3902bcaacbbf00866f8c4993a7f6e9348c2fa50dbd52ff3c604b6af301facb1a8cc3118e0e44fe"} 15:38:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:48 INFO - Contents: 15:38:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/848460aa0f873cc3313762b61f4e85ada38d194ba67e477d548946a50012fec57f20cb26edd0c624b7f6e84fd6a632334a0a31c789ed8fa6de57ad728ba278e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512d7f82c9d6d0deffbccb186017b9c66e5f88112c752363f4cb3beaf01a9e2bb3d07b528fed83caa58a435b73e0d22d23df9d82f7e09983cd89c897c3f23bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db7d5a1359c3258ddba505e81886f785340165f65fc02127ee3902bcaacbbf00866f8c4993a7f6e9348c2fa50dbd52ff3c604b6af301facb1a8cc3118e0e44fe"} 15:38:48 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:48 INFO - Copying logs to upload dir... 15:38:48 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.337337 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-10 15:38:48.311328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:48.317044) ========= 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=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/848460aa0f873cc3313762b61f4e85ada38d194ba67e477d548946a50012fec57f20cb26edd0c624b7f6e84fd6a632334a0a31c789ed8fa6de57ad728ba278e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512d7f82c9d6d0deffbccb186017b9c66e5f88112c752363f4cb3beaf01a9e2bb3d07b528fed83caa58a435b73e0d22d23df9d82f7e09983cd89c897c3f23bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db7d5a1359c3258ddba505e81886f785340165f65fc02127ee3902bcaacbbf00866f8c4993a7f6e9348c2fa50dbd52ff3c604b6af301facb1a8cc3118e0e44fe"} build_url:https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/OSuCNmwjRYGaIW9gCGnI4g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/848460aa0f873cc3313762b61f4e85ada38d194ba67e477d548946a50012fec57f20cb26edd0c624b7f6e84fd6a632334a0a31c789ed8fa6de57ad728ba278e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512d7f82c9d6d0deffbccb186017b9c66e5f88112c752363f4cb3beaf01a9e2bb3d07b528fed83caa58a435b73e0d22d23df9d82f7e09983cd89c897c3f23bd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db7d5a1359c3258ddba505e81886f785340165f65fc02127ee3902bcaacbbf00866f8c4993a7f6e9348c2fa50dbd52ff3c604b6af301facb1a8cc3118e0e44fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:48.342010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:48.342339) ========= 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=d2a8c569965ab8367867b893000001a1-1468178804.489682-953865346 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 15:38:48.427250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 15:38:48.427573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 15:38:48.427858) ========= ========= Total master_lag: 0.19 =========