builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1467048796.59 results: success (0) buildid: 20160627075218 builduid: 3a32e27063da48c3a4915fe84f33b85c revision: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.591281) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.591819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.592199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.610929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.611302) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 10:33:16-- 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% 225M=0s 2016-06-27 10:33:16 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.704924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.705338) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015860 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.909817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:16.910259) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 --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 c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 --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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 10:33:17,165 truncating revision to first 12 chars 2016-06-27 10:33:17,165 Setting DEBUG logging. 2016-06-27 10:33:17,165 attempt 1/10 2016-06-27 10:33:17,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c0c2a83ca397?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 10:33:17,463 unpacking tar archive at: mozilla-aurora-c0c2a83ca397/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:17.606825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:17.607209) ========= script_repo_revision: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:17.607655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:17.607974) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 10:33:17.617616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-27 10:33:17.617972) ========= /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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:33:17 INFO - MultiFileLogger online at 20160627 10:33:17 in /builds/slave/test 10:33:17 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 10:33:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:17 INFO - {'append_to_log': False, 10:33:17 INFO - 'base_work_dir': '/builds/slave/test', 10:33:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:33:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:17 INFO - 'branch': 'Mozilla-Aurora', 10:33:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:17 INFO - 'config_files': ('talos/linux_config.py',), 10:33:17 INFO - 'default_actions': ('clobber', 10:33:17 INFO - 'read-buildbot-config', 10:33:17 INFO - 'download-and-extract', 10:33:17 INFO - 'populate-webroot', 10:33:17 INFO - 'create-virtualenv', 10:33:17 INFO - 'install', 10:33:17 INFO - 'run-tests'), 10:33:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:17 INFO - 'download_minidump_stackwalk': True, 10:33:17 INFO - 'download_symbols': 'ondemand', 10:33:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:17 INFO - 'installer_path': 'installer.exe', 10:33:17 INFO - 'log_level': 'info', 10:33:17 INFO - 'log_name': 'talos', 10:33:17 INFO - 'log_to_console': True, 10:33:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:33:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:33:17 INFO - 'opt_config_files': (), 10:33:17 INFO - 'pip_index': False, 10:33:17 INFO - 'sps_profile': False, 10:33:17 INFO - 'sps_profile_interval': 0, 10:33:17 INFO - 'suite': 'dromaeojs-e10s', 10:33:17 INFO - 'system_bits': '32', 10:33:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:17 INFO - 'title': 'talos-linux64-ix-023', 10:33:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:17 INFO - 'use_talos_json': True, 10:33:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:17 INFO - 'work_dir': 'build'} 10:33:17 INFO - ##### 10:33:17 INFO - ##### Running clobber step. 10:33:17 INFO - ##### 10:33:17 INFO - Running pre-action listener: _resource_record_pre_action 10:33:17 INFO - Running main action method: clobber 10:33:17 INFO - rmtree: /builds/slave/test/build 10:33:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:18 INFO - Running post-action listener: _resource_record_post_action 10:33:18 INFO - ##### 10:33:18 INFO - ##### Finished clobber step (success) 10:33:18 INFO - ##### 10:33:18 INFO - ##### 10:33:18 INFO - ##### Running read-buildbot-config step. 10:33:18 INFO - ##### 10:33:18 INFO - Running pre-action listener: _resource_record_pre_action 10:33:18 INFO - Running main action method: read_buildbot_config 10:33:18 INFO - Using buildbot properties: 10:33:18 INFO - { 10:33:18 INFO - "project": "", 10:33:18 INFO - "product": "firefox", 10:33:18 INFO - "script_repo_revision": "production", 10:33:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:33:18 INFO - "repository": "", 10:33:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:33:18 INFO - "buildid": "20160627075218", 10:33:18 INFO - "pgo_build": "True", 10:33:18 INFO - "basedir": "/builds/slave/test", 10:33:18 INFO - "buildnumber": 419, 10:33:18 INFO - "slavename": "talos-linux64-ix-023", 10:33:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:33:18 INFO - "platform": "ubuntu64_hw", 10:33:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:33:18 INFO - "branch": "mozilla-aurora", 10:33:18 INFO - "repo_path": "releases/mozilla-aurora", 10:33:18 INFO - "revision": "c0c2a83ca3973e5732b1d739ab9fefa551e3cd05", 10:33:18 INFO - "stage_platform": "linux64-pgo", 10:33:18 INFO - "builduid": "3a32e27063da48c3a4915fe84f33b85c", 10:33:18 INFO - "slavebuilddir": "test" 10:33:18 INFO - } 10:33:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 10:33:18 INFO - Running post-action listener: _resource_record_post_action 10:33:18 INFO - ##### 10:33:18 INFO - ##### Finished read-buildbot-config step (success) 10:33:18 INFO - ##### 10:33:18 INFO - ##### 10:33:18 INFO - ##### Running download-and-extract step. 10:33:18 INFO - ##### 10:33:18 INFO - Running pre-action listener: _resource_record_pre_action 10:33:18 INFO - Running main action method: download_and_extract 10:33:18 INFO - mkdir: /builds/slave/test/build/tests 10:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:18 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:33:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:33:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:33:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:19 INFO - Downloaded 1361 bytes. 10:33:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 10:33:19 INFO - Using the following test package requirements: 10:33:19 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:33:19 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:33:19 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:33:19 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'jsshell-linux-x86_64.zip'], 10:33:19 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:33:19 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 10:33:19 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:33:19 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:33:19 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:33:19 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:33:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:33: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')]} 10:33:19 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:33:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:33:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:20 INFO - Downloaded 24522704 bytes. 10:33: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'] 10:33: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 10:33:21 INFO - Return code: 0 10:33:21 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 10:33: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')]} 10:33:21 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 10:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:22 INFO - Downloaded 24522704 bytes. 10:33:22 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'] 10:33:22 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 10:33:23 INFO - Return code: 0 10:33: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')]} 10:33:23 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 10:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:24 INFO - Downloaded 10833369 bytes. 10:33:24 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'] 10:33:24 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 10:33:25 INFO - Return code: 0 10:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:25 INFO - https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:33:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:33:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:33:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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 10:33:26 INFO - Downloaded 63613651 bytes. 10:33:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:33:26 INFO - mkdir: /builds/slave/test/properties 10:33:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:26 INFO - Contents: 10:33:26 INFO - build_url:https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 10:33:27 INFO - Running post-action listener: _resource_record_post_action 10:33:27 INFO - Running post-action listener: set_extra_try_arguments 10:33:27 INFO - ##### 10:33:27 INFO - ##### Finished download-and-extract step (success) 10:33:27 INFO - ##### 10:33:27 INFO - ##### 10:33:27 INFO - ##### Running populate-webroot step. 10:33:27 INFO - ##### 10:33:27 INFO - Running pre-action listener: _resource_record_pre_action 10:33:27 INFO - Running main action method: populate_webroot 10:33:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:27 INFO - '--tppagecycles', 10:33:27 INFO - '7'], 10:33:27 INFO - 'tests': ['tsvgm']}}, 10:33:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['damp', 'tps']}, 10:33:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'tests': ['damp', 'tps']}, 10:33:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['dromaeo_dom']}, 10:33:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['a11yr', 10:33:27 INFO - 'ts_paint', 10:33:27 INFO - 'tpaint', 10:33:27 INFO - 'sessionrestore', 10:33:27 INFO - 'sessionrestore_no_auto_restore', 10:33:27 INFO - 'tabpaint']}, 10:33:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['tsvgx', 10:33:27 INFO - 'tsvgr_opacity', 10:33:27 INFO - 'tart', 10:33:27 INFO - 'tscrollx', 10:33:27 INFO - 'cart']}, 10:33:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:27 INFO - 'tsvgr_opacity', 10:33:27 INFO - 'tart', 10:33:27 INFO - 'tscrollx', 10:33:27 INFO - 'cart']}, 10:33:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'talos_options': ['--disable-e10s'], 10:33:27 INFO - 'tests': ['tp5o']}, 10:33:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'tests': ['tp5o']}, 10:33:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'talos_options': ['--disable-e10s', 10:33:27 INFO - '--xperf_path', 10:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:27 INFO - 'tests': ['tp5n']}, 10:33:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:27 INFO - 'talos_options': ['--xperf_path', 10:33:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:27 INFO - 'tests': ['tp5n']}}, 10:33:27 INFO - 'talos.zip': {'path': '', 10:33:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:27 INFO - Running post-action listener: _resource_record_post_action 10:33:27 INFO - ##### 10:33:27 INFO - ##### Finished populate-webroot step (success) 10:33:27 INFO - ##### 10:33:27 INFO - ##### 10:33:27 INFO - ##### Running create-virtualenv step. 10:33:27 INFO - ##### 10:33:27 INFO - Running pre-action listener: _resource_record_pre_action 10:33:27 INFO - Running main action method: create_virtualenv 10:33:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:33:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:27 INFO - Using real prefix '/usr' 10:33:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:29 INFO - Installing pip.................done. 10:33:29 INFO - Return code: 0 10:33:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 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 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:33:29 INFO - Using env: {'DISPLAY': ':0', 10:33:29 INFO - 'HOME': '/home/cltbld', 10:33:29 INFO - 'LANG': 'en_US.UTF-8', 10:33:29 INFO - 'LANGUAGE': 'en_US:en', 10:33:29 INFO - 'LOGNAME': 'cltbld', 10:33:29 INFO - 'MAIL': '/var/mail/cltbld', 10:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:29 INFO - 'MOZ_NO_REMOTE': '1', 10:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:29 INFO - 'NO_EM_RESTART': '1', 10:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:29 INFO - 'PWD': '/builds/slave/test', 10:33:29 INFO - 'SHELL': '/bin/bash', 10:33:29 INFO - 'SHLVL': '1', 10:33:29 INFO - 'TERM': 'linux', 10:33:29 INFO - 'TMOUT': '86400', 10:33:29 INFO - 'USER': 'cltbld', 10:33:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:29 INFO - '_': '/tools/buildbot/bin/python'} 10:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33: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 10:33:30 INFO - Cleaning up... 10:33:30 INFO - Return code: 0 10:33:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33: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 10:33: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 10:33:30 INFO - Using env: {'DISPLAY': ':0', 10:33:30 INFO - 'HOME': '/home/cltbld', 10:33:30 INFO - 'LANG': 'en_US.UTF-8', 10:33:30 INFO - 'LANGUAGE': 'en_US:en', 10:33:30 INFO - 'LOGNAME': 'cltbld', 10:33:30 INFO - 'MAIL': '/var/mail/cltbld', 10:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:30 INFO - 'MOZ_NO_REMOTE': '1', 10:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:30 INFO - 'NO_EM_RESTART': '1', 10:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:30 INFO - 'PWD': '/builds/slave/test', 10:33:30 INFO - 'SHELL': '/bin/bash', 10:33:30 INFO - 'SHLVL': '1', 10:33:30 INFO - 'TERM': 'linux', 10:33:30 INFO - 'TMOUT': '86400', 10:33:30 INFO - 'USER': 'cltbld', 10:33:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:30 INFO - '_': '/tools/buildbot/bin/python'} 10:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:30 INFO - Downloading/unpacking psutil>=3.1.1 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:32 INFO - Installing collected packages: psutil 10:33:32 INFO - Running setup.py install for psutil 10:33:32 INFO - building 'psutil._psutil_linux' extension 10:33:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:33:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:33:32 INFO - building 'psutil._psutil_posix' extension 10:33:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:33:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:33:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:32 INFO - Successfully installed psutil 10:33:32 INFO - Cleaning up... 10:33:32 INFO - Return code: 0 10:33:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:32 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 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:33:32 INFO - Using env: {'DISPLAY': ':0', 10:33:32 INFO - 'HOME': '/home/cltbld', 10:33:32 INFO - 'LANG': 'en_US.UTF-8', 10:33:32 INFO - 'LANGUAGE': 'en_US:en', 10:33:32 INFO - 'LOGNAME': 'cltbld', 10:33:32 INFO - 'MAIL': '/var/mail/cltbld', 10:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:32 INFO - 'MOZ_NO_REMOTE': '1', 10:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:32 INFO - 'NO_EM_RESTART': '1', 10:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:32 INFO - 'PWD': '/builds/slave/test', 10:33:32 INFO - 'SHELL': '/bin/bash', 10:33:32 INFO - 'SHLVL': '1', 10:33:32 INFO - 'TERM': 'linux', 10:33:32 INFO - 'TMOUT': '86400', 10:33:32 INFO - 'USER': 'cltbld', 10:33:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:32 INFO - '_': '/tools/buildbot/bin/python'} 10:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:33:35 INFO - Installing collected packages: mozsystemmonitor 10:33:35 INFO - Running setup.py install for mozsystemmonitor 10:33:35 INFO - Successfully installed mozsystemmonitor 10:33:35 INFO - Cleaning up... 10:33:35 INFO - Return code: 0 10:33:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:35 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 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:33:35 INFO - Using env: {'DISPLAY': ':0', 10:33:35 INFO - 'HOME': '/home/cltbld', 10:33:35 INFO - 'LANG': 'en_US.UTF-8', 10:33:35 INFO - 'LANGUAGE': 'en_US:en', 10:33:35 INFO - 'LOGNAME': 'cltbld', 10:33:35 INFO - 'MAIL': '/var/mail/cltbld', 10:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:35 INFO - 'MOZ_NO_REMOTE': '1', 10:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:35 INFO - 'NO_EM_RESTART': '1', 10:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:35 INFO - 'PWD': '/builds/slave/test', 10:33:35 INFO - 'SHELL': '/bin/bash', 10:33:35 INFO - 'SHLVL': '1', 10:33:35 INFO - 'TERM': 'linux', 10:33:35 INFO - 'TMOUT': '86400', 10:33:35 INFO - 'USER': 'cltbld', 10:33:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:35 INFO - '_': '/tools/buildbot/bin/python'} 10:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:33:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:33:37 INFO - warning: no files found matching '*.txt' 10:33:37 INFO - no previously-included directories found matching 'build' 10:33:37 INFO - no previously-included directories found matching 'dist' 10:33:37 INFO - no previously-included directories found matching '.git*' 10:33:37 INFO - Installing collected packages: jsonschema, functools32 10:33:37 INFO - Running setup.py install for functools32 10:33:37 INFO - warning: no files found matching '*.txt' 10:33:37 INFO - no previously-included directories found matching 'build' 10:33:37 INFO - no previously-included directories found matching 'dist' 10:33:37 INFO - no previously-included directories found matching '.git*' 10:33:37 INFO - Successfully installed jsonschema functools32 10:33:37 INFO - Cleaning up... 10:33:37 INFO - Return code: 0 10:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:33:37 INFO - Using env: {'DISPLAY': ':0', 10:33:37 INFO - 'HOME': '/home/cltbld', 10:33:37 INFO - 'LANG': 'en_US.UTF-8', 10:33:37 INFO - 'LANGUAGE': 'en_US:en', 10:33:37 INFO - 'LOGNAME': 'cltbld', 10:33:37 INFO - 'MAIL': '/var/mail/cltbld', 10:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:37 INFO - 'MOZ_NO_REMOTE': '1', 10:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:37 INFO - 'NO_EM_RESTART': '1', 10:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:37 INFO - 'PWD': '/builds/slave/test', 10:33:37 INFO - 'SHELL': '/bin/bash', 10:33:37 INFO - 'SHLVL': '1', 10:33:37 INFO - 'TERM': 'linux', 10:33:37 INFO - 'TMOUT': '86400', 10:33:37 INFO - 'USER': 'cltbld', 10:33:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:37 INFO - '_': '/tools/buildbot/bin/python'} 10:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - Downloading docopt-0.6.1.tar.gz 10:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:40 INFO - Running setup.py install for blobuploader 10:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:40 INFO - Running setup.py install for requests 10:33:41 INFO - Running setup.py install for docopt 10:33:41 INFO - Successfully installed blobuploader requests docopt 10:33:41 INFO - Cleaning up... 10:33:41 INFO - Return code: 0 10:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:33:41 INFO - Using env: {'DISPLAY': ':0', 10:33:41 INFO - 'HOME': '/home/cltbld', 10:33:41 INFO - 'LANG': 'en_US.UTF-8', 10:33:41 INFO - 'LANGUAGE': 'en_US:en', 10:33:41 INFO - 'LOGNAME': 'cltbld', 10:33:41 INFO - 'MAIL': '/var/mail/cltbld', 10:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:41 INFO - 'MOZ_NO_REMOTE': '1', 10:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:41 INFO - 'NO_EM_RESTART': '1', 10:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:41 INFO - 'PWD': '/builds/slave/test', 10:33:41 INFO - 'SHELL': '/bin/bash', 10:33:41 INFO - 'SHLVL': '1', 10:33:41 INFO - 'TERM': 'linux', 10:33:41 INFO - 'TMOUT': '86400', 10:33:41 INFO - 'USER': 'cltbld', 10:33:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:41 INFO - '_': '/tools/buildbot/bin/python'} 10:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:41 INFO - Running setup.py (path:/tmp/pip-IwRBGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:41 INFO - Running setup.py (path:/tmp/pip-SnN04L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:41 INFO - Running setup.py (path:/tmp/pip-Gr1ZUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:41 INFO - Running setup.py (path:/tmp/pip-ia8Fe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:41 INFO - Running setup.py (path:/tmp/pip-0S9MtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:41 INFO - Running setup.py (path:/tmp/pip-eijMSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:41 INFO - Running setup.py (path:/tmp/pip-1WYO5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:41 INFO - Running setup.py (path:/tmp/pip-oE_2xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:42 INFO - Running setup.py (path:/tmp/pip-ZmqBQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:42 INFO - Running setup.py (path:/tmp/pip-_1AqMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:42 INFO - Running setup.py (path:/tmp/pip-LxMm4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:42 INFO - Running setup.py (path:/tmp/pip-2GnjUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:42 INFO - Running setup.py (path:/tmp/pip-cBPWQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:42 INFO - Running setup.py (path:/tmp/pip-aMtQce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:42 INFO - Running setup.py (path:/tmp/pip-jjpy04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:42 INFO - Running setup.py (path:/tmp/pip-r_SKH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:42 INFO - Running setup.py (path:/tmp/pip-o2yNsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:42 INFO - Running setup.py install for manifestparser 10:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:42 INFO - Running setup.py install for mozcrash 10:33:42 INFO - Running setup.py install for mozdebug 10:33:43 INFO - Running setup.py install for mozdevice 10:33:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for mozfile 10:33:43 INFO - Running setup.py install for mozhttpd 10:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for mozinfo 10:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for mozInstall 10:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for mozleak 10:33:43 INFO - Running setup.py install for mozlog 10:33:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for moznetwork 10:33:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:33:43 INFO - Running setup.py install for mozprocess 10:33:43 INFO - Running setup.py install for mozprofile 10:33:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Running setup.py install for mozrunner 10:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Running setup.py install for mozscreenshot 10:33:44 INFO - Running setup.py install for moztest 10:33:44 INFO - Running setup.py install for mozversion 10:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:44 INFO - Cleaning up... 10:33:44 INFO - Return code: 0 10:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:33:44 INFO - Using env: {'DISPLAY': ':0', 10:33:44 INFO - 'HOME': '/home/cltbld', 10:33:44 INFO - 'LANG': 'en_US.UTF-8', 10:33:44 INFO - 'LANGUAGE': 'en_US:en', 10:33:44 INFO - 'LOGNAME': 'cltbld', 10:33:44 INFO - 'MAIL': '/var/mail/cltbld', 10:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:44 INFO - 'MOZ_NO_REMOTE': '1', 10:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:44 INFO - 'NO_EM_RESTART': '1', 10:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:44 INFO - 'PWD': '/builds/slave/test', 10:33:44 INFO - 'SHELL': '/bin/bash', 10:33:44 INFO - 'SHLVL': '1', 10:33:44 INFO - 'TERM': 'linux', 10:33:44 INFO - 'TMOUT': '86400', 10:33:44 INFO - 'USER': 'cltbld', 10:33:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:44 INFO - '_': '/tools/buildbot/bin/python'} 10:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:44 INFO - Running setup.py (path:/tmp/pip-QHgtcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:44 INFO - Running setup.py (path:/tmp/pip-5ckeDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:44 INFO - Running setup.py (path:/tmp/pip-B8zAip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:44 INFO - Running setup.py (path:/tmp/pip-0Rn1N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:45 INFO - Running setup.py (path:/tmp/pip-m8nV5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:45 INFO - Running setup.py (path:/tmp/pip-EXSwJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:45 INFO - Running setup.py (path:/tmp/pip-JqzZrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:45 INFO - Running setup.py (path:/tmp/pip-h_Uzdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:45 INFO - Running setup.py (path:/tmp/pip-nXx8Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:45 INFO - Running setup.py (path:/tmp/pip-3JfX9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:45 INFO - Running setup.py (path:/tmp/pip-4A8VK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:45 INFO - Running setup.py (path:/tmp/pip-ZRMtok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:45 INFO - Running setup.py (path:/tmp/pip-4zVGhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:45 INFO - Running setup.py (path:/tmp/pip-lqGJ5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:45 INFO - Running setup.py (path:/tmp/pip-MnH5vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:45 INFO - Running setup.py (path:/tmp/pip-RcLIMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:45 INFO - Running setup.py (path:/tmp/pip-TzBeUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:47 INFO - Downloading blessings-1.6.tar.gz 10:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:47 INFO - Installing collected packages: blessings 10:33:47 INFO - Running setup.py install for blessings 10:33:48 INFO - Successfully installed blessings 10:33:48 INFO - Cleaning up... 10:33:48 INFO - Return code: 0 10:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:48 INFO - Reading from file tmpfile_stdout 10:33:48 INFO - Current package versions: 10:33:48 INFO - argparse == 1.2.1 10:33:48 INFO - blessings == 1.6 10:33:48 INFO - blobuploader == 1.2.4 10:33:48 INFO - docopt == 0.6.1 10:33:48 INFO - functools32 == 3.2.3-2 10:33:48 INFO - jsonschema == 2.5.1 10:33:48 INFO - manifestparser == 1.1 10:33:48 INFO - mozInstall == 1.12 10:33:48 INFO - mozcrash == 0.17 10:33:48 INFO - mozdebug == 0.1 10:33:48 INFO - mozdevice == 0.48 10:33:48 INFO - mozfile == 1.2 10:33:48 INFO - mozhttpd == 0.7 10:33:48 INFO - mozinfo == 0.9 10:33:48 INFO - mozleak == 0.1 10:33:48 INFO - mozlog == 3.2 10:33:48 INFO - moznetwork == 0.27 10:33:48 INFO - mozprocess == 0.22 10:33:48 INFO - mozprofile == 0.28 10:33:48 INFO - mozrunner == 6.11 10:33:48 INFO - mozscreenshot == 0.1 10:33:48 INFO - mozsystemmonitor == 0.3 10:33:48 INFO - moztest == 0.7 10:33:48 INFO - mozversion == 1.4 10:33:48 INFO - psutil == 3.1.1 10:33:48 INFO - requests == 1.2.3 10:33:48 INFO - wsgiref == 0.1.2 10:33:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:33:48 INFO - Using env: {'DISPLAY': ':0', 10:33:48 INFO - 'HOME': '/home/cltbld', 10:33:48 INFO - 'LANG': 'en_US.UTF-8', 10:33:48 INFO - 'LANGUAGE': 'en_US:en', 10:33:48 INFO - 'LOGNAME': 'cltbld', 10:33:48 INFO - 'MAIL': '/var/mail/cltbld', 10:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:48 INFO - 'MOZ_NO_REMOTE': '1', 10:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:48 INFO - 'NO_EM_RESTART': '1', 10:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:48 INFO - 'PWD': '/builds/slave/test', 10:33:48 INFO - 'SHELL': '/bin/bash', 10:33:48 INFO - 'SHLVL': '1', 10:33:48 INFO - 'TERM': 'linux', 10:33:48 INFO - 'TMOUT': '86400', 10:33:48 INFO - 'USER': 'cltbld', 10:33:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:48 INFO - '_': '/tools/buildbot/bin/python'} 10:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:33:48 INFO - Cleaning up... 10:33:48 INFO - Return code: 0 10:33:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:33:48 INFO - Using env: {'DISPLAY': ':0', 10:33:48 INFO - 'HOME': '/home/cltbld', 10:33:48 INFO - 'LANG': 'en_US.UTF-8', 10:33:48 INFO - 'LANGUAGE': 'en_US:en', 10:33:48 INFO - 'LOGNAME': 'cltbld', 10:33:48 INFO - 'MAIL': '/var/mail/cltbld', 10:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:48 INFO - 'MOZ_NO_REMOTE': '1', 10:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:48 INFO - 'NO_EM_RESTART': '1', 10:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:48 INFO - 'PWD': '/builds/slave/test', 10:33:48 INFO - 'SHELL': '/bin/bash', 10:33:48 INFO - 'SHLVL': '1', 10:33:48 INFO - 'TERM': 'linux', 10:33:48 INFO - 'TMOUT': '86400', 10:33:48 INFO - 'USER': 'cltbld', 10:33:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:48 INFO - '_': '/tools/buildbot/bin/python'} 10:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:33:48 INFO - Cleaning up... 10:33:48 INFO - Return code: 0 10:33:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a6bb0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2127350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, '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': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:33:48 INFO - Using env: {'DISPLAY': ':0', 10:33:48 INFO - 'HOME': '/home/cltbld', 10:33:48 INFO - 'LANG': 'en_US.UTF-8', 10:33:48 INFO - 'LANGUAGE': 'en_US:en', 10:33:48 INFO - 'LOGNAME': 'cltbld', 10:33:48 INFO - 'MAIL': '/var/mail/cltbld', 10:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:48 INFO - 'MOZ_NO_REMOTE': '1', 10:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:48 INFO - 'NO_EM_RESTART': '1', 10:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:48 INFO - 'PWD': '/builds/slave/test', 10:33:48 INFO - 'SHELL': '/bin/bash', 10:33:48 INFO - 'SHLVL': '1', 10:33:48 INFO - 'TERM': 'linux', 10:33:48 INFO - 'TMOUT': '86400', 10:33:48 INFO - 'USER': 'cltbld', 10:33:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:48 INFO - '_': '/tools/buildbot/bin/python'} 10:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:48 INFO - Downloading/unpacking flake8 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:33:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:33:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:33:51 INFO - no previously-included directories found matching 'docs/_build' 10:33:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:33:51 INFO - Running setup.py install for pep8 10:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:33:51 INFO - no previously-included directories found matching 'docs/_build' 10:33:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:33:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:33:51 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Running post-action listener: _resource_record_post_action 10:33:51 INFO - Running post-action listener: _start_resource_monitoring 10:33:51 INFO - Starting resource monitoring. 10:33:51 INFO - ##### 10:33:51 INFO - ##### Finished create-virtualenv step (success) 10:33:51 INFO - ##### 10:33:51 INFO - ##### 10:33:51 INFO - ##### Running install step. 10:33:51 INFO - ##### 10:33:51 INFO - Running pre-action listener: _resource_record_pre_action 10:33:51 INFO - Running main action method: install 10:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:52 INFO - Reading from file tmpfile_stdout 10:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:52 INFO - Reading from file tmpfile_stdout 10:33:52 INFO - Output received: 10:33:52 INFO - Usage: mozinstall [options] installer 10:33:52 INFO - Options: 10:33:52 INFO - -h, --help show this help message and exit 10:33:52 INFO - -d DEST, --destination=DEST 10:33:52 INFO - Directory to install application into. [default: 10:33:52 INFO - "/builds/slave/test"] 10:33:52 INFO - --app=APP Application being installed. [default: firefox] 10:33:52 INFO - mkdir: /builds/slave/test/build/application 10:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:34:08 INFO - Reading from file tmpfile_stdout 10:34:08 INFO - Output received: 10:34:08 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:08 INFO - Running post-action listener: _resource_record_post_action 10:34:08 INFO - ##### 10:34:08 INFO - ##### Finished install step (success) 10:34:08 INFO - ##### 10:34:08 INFO - ##### 10:34:08 INFO - ##### Running run-tests step. 10:34:08 INFO - ##### 10:34:08 INFO - Running pre-action listener: _resource_record_pre_action 10:34:08 INFO - Running main action method: run_tests 10:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:08 INFO - Python 2.7.3 10:34:08 INFO - Return code: 0 10:34:08 INFO - grabbing minidump binary from tooltool 10:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:08 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 0x21b61c0>, '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 0x21b70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:34:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:34:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:34:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:08 INFO - Return code: 0 10:34:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:34:09 INFO - Return code: 0 10:34:09 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/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:34:09 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/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:34:09 INFO - Using env: {'DISPLAY': ':0', 10:34:09 INFO - 'HOME': '/home/cltbld', 10:34:09 INFO - 'LANG': 'en_US.UTF-8', 10:34:09 INFO - 'LANGUAGE': 'en_US:en', 10:34:09 INFO - 'LOGNAME': 'cltbld', 10:34:09 INFO - 'MAIL': '/var/mail/cltbld', 10:34:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:09 INFO - 'MOZ_NO_REMOTE': '1', 10:34:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:09 INFO - 'NO_EM_RESTART': '1', 10:34:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:09 INFO - 'PWD': '/builds/slave/test', 10:34:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:09 INFO - 'SHELL': '/bin/bash', 10:34:09 INFO - 'SHLVL': '1', 10:34:09 INFO - 'TERM': 'linux', 10:34:09 INFO - 'TMOUT': '86400', 10:34:09 INFO - 'USER': 'cltbld', 10:34:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883', 10:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:09 INFO - '_': '/tools/buildbot/bin/python'} 10:34:09 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/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:34:09 INFO - mozversion application_buildid: 20160627075218 10:34:09 INFO - mozversion application_changeset: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 10:34:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:34:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:09 INFO - mozversion application_name: Firefox 10:34:09 INFO - mozversion application_remotingname: firefox-dev 10:34:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:34:09 INFO - mozversion application_vendor: Mozilla 10:34:09 INFO - mozversion application_version: 49.0a2 10:34:09 INFO - mozversion platform_buildid: 20160627075218 10:34:09 INFO - mozversion platform_changeset: c0c2a83ca3973e5732b1d739ab9fefa551e3cd05 10:34:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:34:09 INFO - mozversion platform_version: 49.0a2 10:34:09 INFO - using testdate: 1467048849 10:34:09 INFO - actual date: 1467048849 10:34:09 INFO - starting webserver on 'localhost:48016' 10:34:09 INFO - SUITE-START | Running 2 tests 10:34:09 INFO - TEST-START | dromaeo_css 10:34:09 INFO - operating with platform_type : linux_ 10:34:09 INFO - Initialising browser for dromaeo_css test... 10:34:09 INFO - TEST-INFO | started process 13637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKv7Tr3/profile http://localhost:48016/getInfo.html) 10:34:13 INFO - PROCESS | 13637 | __metrics Screen width/height:1600/1200 10:34:13 INFO - PROCESS | 13637 | colorDepth:24 10:34:13 INFO - PROCESS | 13637 | Browser inner width/height: 1024/697 10:34:13 INFO - PROCESS | 13637 | __metrics 10:34:14 ERROR - PROCESS | 13637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:34:15 INFO - TEST-INFO | 13637: exit 0 10:34:15 INFO - Browser initialized. 10:34:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:15 INFO - TEST-INFO | started process 13768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKv7Tr3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:26 INFO - PROCESS | 13768 | RSS: Main: 156254208 10:34:26 INFO - PROCESS | 13768 | 10:35:16 INFO - PROCESS | 13768 | 1467048916557 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:37:24 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48016/tests/dromaeo/cssquery-ext.html) 10:37:25 INFO - PROCESS | 13768 | RSS: Main: 159629312 10:37:25 INFO - PROCESS | 13768 | 10:40:27 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-ext.html (next: http://localhost:48016/tests/dromaeo/cssquery-jquery.html) 10:40:27 INFO - PROCESS | 13768 | RSS: Main: 157847552 10:40:27 INFO - PROCESS | 13768 | 10:43:29 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48016/tests/dromaeo/cssquery-mootools.html) 10:43:30 INFO - PROCESS | 13768 | RSS: Main: 157155328 10:43:30 INFO - PROCESS | 13768 | 10:46:32 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48016/tests/dromaeo/cssquery-prototype.html) 10:46:32 INFO - PROCESS | 13768 | RSS: Main: 157085696 10:46:32 INFO - PROCESS | 13768 | 10:49:35 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48016/tests/dromaeo/cssquery-yui.html) 10:49:35 INFO - PROCESS | 13768 | RSS: Main: 158986240 10:49:35 INFO - PROCESS | 13768 | 10:52:37 INFO - PROCESS | 13768 | Cycle 1(1): loaded http://localhost:48016/tests/dromaeo/cssquery-yui.html (next: http://localhost:48016/tests/dromaeo/cssquery-dojo.html) 10:52:38 INFO - PROCESS | 13768 | RSS: Main: 158986240 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | __start_tp_report 10:52:38 INFO - PROCESS | 13768 | _x_x_mozilla_page_load 10:52:38 INFO - PROCESS | 13768 | _x_x_mozilla_page_load_details 10:52:38 INFO - PROCESS | 13768 | |i|pagename|runs| 10:52:38 INFO - PROCESS | 13768 | |0;dojo.html;3354.5806774153225;3373.0724050885988;3386.2211691311;3401.2857299967004;3407.505911642812;5645.322561292641;5703;5704.65772053677;5711.7144142792795;5716.1711551824965;5735.139729040646;5740.052891272945;5769.884602307951;5781.595288329819;5785.479306862381;5138.614603904713;5199.766010529516;5263.736813159346;5273.1035723927025;5293.364796224459;5046.97476512617;5099.184130539114;5236.450172731866;5278.762455689503;5281.973590132063;5176.689398636075;5196.402413722432;5208.479152084799;5208.609354298424;5249.265102885599;5207;5208.2968799212185;5252.658577192508;5299.470052994709;5299.54953828925;5159.458256883048;5221.242919776611;5259.184826351921;5292.153255479105;5314.362276526842;5478.534324582415;5592.189132575794;5643.351014633287;5657.519110875581;5718.056520674084;6213.409726076015;6247.281562620311;6253.624782513064;6257.9687101564205;6268.49852011838;6010.729517171738;6284.434400903895;6318.4313411793155;6331.841703957438;6334.3032266450655;5811.070228763378;5831.387704291031;5842.883142337215;5866.882662346729;5881.970590147064;6270.404311590391;6275.654838983808;6299.212598425197;6328.430441260309;6366.427021568081;5896.262967129109;5970.611910225822;6082.391760823971;6116.816495505142;6124.724387402578;6043.395660433922;6195.876082478325;6196.783112591038;6243.656598887105;6254.2807577129215;6174.722137503823;6181.567290289637;6182.165407669997;6189.96905015481;6203.379662033761;6012.969935150296;6087.086936959491;6089.421504957022;6181.752729890754;6193.163922870445;4714.6464015199;4719.2921061841;4723.48041715411;4747.430308362949;4762.499937506512;4211.241976444208;4221.092465120014;4224.218519573888;4229.154169166179;4252.107057517894;5864.354920958691;5879.206307148565;5929.970350148308;5954.225950626391;5983.820485385445;6018.668973206516;6092.238470191226;6096.390360963868;6123.28262147438;6148.3236843948025;5894.970525147347;5939.406059394112;5946.643201407929;5953.077273022602;5954.345022047572;5150.845474635767;5267.341582302212;5327;5327.573794096463;5365.839024829262;6318.399752023551;6380.425761681471;6387.840303992437;6396.808095757135;6400.295967443578;6190.81427557174;6191.25704915404;6238.750449982132;6240.906386404116;6254.655993920378;6159.969200153971;6263.874722505433;6306.432421081941;6423.325550817097;6433.742650293936;6125.388069147199;6129.264488261437;6130.896438641087;6133.9079913802225;6149.96925015372;6208.0998255253635;6244.937550624436;6246.750129994749;6247.937520624918;6252.406021427957;5901.616394934315;5920.940790592039;5935;5986.88026239464;6089.725962331617;6003.489703375262;6046.667433291212;6050.697465126814;6056.333803281724;6061.454469097803;5919.378465261086;5963.850903727442;5973.462388385066;5979.312379076462;5993.220881285405;5875.588708790344;5970.850728731816;5990.64056156632;6077.392260773887;6086.391360863879;5974.820755377345;5993.820185394445;5996;6008.098785182257;6009.939900600938 10:52:38 INFO - PROCESS | 13768 | |1;ext.html;603.9637621742696;645.9386358295961;666.8266250774799;668.7091115364814;679.5956405938465;41449.58550414499;44725.32912006322;45153;45299;45419.54580454199;46120.76939615297;46821.29768053482;46860.297095543596;46889.29666055003;46920.8885600148;8896.510691911943;9019.45883247004;9027;9031.503267320295;9034.548272586377;8790.64837406503;8825.205731484166;8909.376343655947;8918.910810891904;8948.507832069234;8958.104189581023;8991.640334386617;9001.414908030989;9012.8648070279;9014.774630634221;8994.370394072417;9009.864852027225;9026.277897768196;9028;9046.185843274137;8875.423097498706;8892.644294228223;8937.73186804397;8949.910500894974;8963;42506.78746606278;42723.35914961278;43007;43039.139217215794;43210.56789432097;3766.7551609145594;3844.1350696093155;3973.721839471238;4147.39862719907;4413.3159360299205;33053;33831.6616833831;34127.65872341295;34418.82790586031;34730;4368.344748287751;4369.759663218521;4375.12497500498;4480.775961201959;4521.615662668644;375157;379451;380452;381387.0930645357;381497;39151.80424097918;63208;63674;63680.68159659172;63878.6806065976;39400.408993865116;39534.60465395367;39541.406878896836;39683.80158099191;39758.2048359037;16845.157742112846;16891.577710557336;16982.150892455327;17065.14674266282;17085.402010929807;14215.50245741394;14350.928245358706;14429.49496767608;14441.916856235825;14478.131312121306;9206.217471514863;9208.447493150432;9229.584668689926;9239.676611318571;9275.350725449154;3401.2517246205794;3489.9825500872334;3539.9292014159573;3582.2119133790525;3582.964170358315;1015.314662602755;1067.5516283161091;1085.1361127352247;1153.4636394076795;1167.5271515036425;32238.83880580629;32756.83621581877;32823.67176328254;32858.671413286036;33082;1169.5847973969119;1177.7879981603223;1214.8117041858527;1228.5761412312738;1269.7270086931169;17346.566335841453;17352.13239338028;17657.646847062988;17696.29214831418;17728.55678608045;463455;623577;915080;926154;931772;61482.69258653678;62662.373376266565;62827;62924;63145.368546314865;1447.840737518893;1507.4196434372845;1509.7207016701725;1512.5235550801683;1538.2770098053898;32974.67025329716;33746;33918.321633567684;34188.65811341855;34239;54235.45764542304;54828.45171548393;54931.725341373036;54953.45046549483;54995;576222;581682;582906;583028;583326;29355.706442935298;30380.5442918352;30498.84750576233;30807.84596077095;30824.69175308308;49112;49719.751401242764;50269;50327.74836125796;50546.74726626343;41114;42066.57933420749;42128;42194;43863;41036;41903.7904810474;42453;43296.350554742334;43539.12921741484;41980.58019419767;42772.35841462318;42845.78577107094;43249;43314.78342608267;36874.26251474902;37307;37531.24937501289;37827;38263;29183.70816291895;29321.56017659694;29362.412751745273;29771;29887.103386898427 10:52:38 INFO - PROCESS | 13768 | |2;jquery.html;419.10521037584755;422.5331009234794;423.5341124762761;427.508365379813;444.88433007418064;18717.532061698446;19985;20805.27181548646;20827.27104551341;20844.062017209224;19397.321093761722;19414.611707765835;19629.607407851836;20385;20491.282805101826;5889.352171261147;6067.150598916155;6085.726142323606;6094.96952515239;6107.969460152693;5679.545636349103;5971.492423144038;5976.790812321569;6025.849353766147;6043;5988.700564971756;6005.099235114724;6018;6028.3067447243475;6050.606710563821;6708.49686273529;6734.326567343275;6760.932390676104;6780.932190678104;6783.42340901024;5796.434962560127;5991.730372133265;6053.273607167168;6059.454649081604;6083.48290395317;14294.213818239992;14718.116912985255;14783;14848.703025939529;14860.108393496317;2396.341006223285;2406.3984003999;2418.891149898259;2630.434456591842;2825.9010934617395;9876.35803672759;10379.325343852626;10539;10594.576216951313;10657;2023.3525271912995;2065.1713922979234;2107.4309936317263;2151.806337429623;2153.386284908809;83372;83633.58183209106;85136.14863851406;85569.57215213885;86319.99999999937;11376.658700239006;11566.653000409833;11568.074554035657;11611.825822612667;11860.406979650983;16264.918675406783;16452.506424807274;16472.42346517866;16493.17534123313;16509.422170223985;8758.649654013896;8802.735917922473;8832.55837208137;8965.462072275684;9037.231835293942;8562.529060901586;8614.095519970439;8680.6527738891;8728.345374096842;8777.824443511094;4933.703977761274;5010.89978200434;5041.6470847040355;5045.293658887758;5077.568406685473;2042.0504465423649;2052.9076191571417;2062.494688801223;2070.3892351756267;2139.2405695978014;971.145392054987;996.940183588987;1007.8337074382791;1009.7627057641448;1090.7109615951779;19890.30383936555;20278;20519.692204616942;20737;20807.06368213434;1058.6347710040025;1077.4289626497969;1097.8572785537829;1099.9780004399868;1121.9046381057701;11080.778384432428;11271.94364028191;11420.486078126338;11589.826152607717;11596.304221746723;445079;459900;459915;463567;467525;79012;88592.5570372144;91090;96016.51991739997;97818.51090744643;1070.6948519672012;1098.8681358236902;1136.9147313951487;1149.4137989625185;1153.8326942593444;18638.906805465886;18680.813191867906;18847.24611015599;18889.244430223185;19103.52241193981;38746.61253387543;39854.40218396668;44880.551194487634;44999.32501012422;45005;57823;58063;59224.703876480344;59908.70045649744;60533;9159.542022898962;9374.343795934219;9533.142017218484;9594.568244429158;9677.129058384498;13372.866271337161;14130.434782608581;14246.002779805729;14301.92849035748;14315.427382904567;12104.878951210727;12240.326782027074;12302.384880756106;12352;12833.679158021125;12251;12339;12574.245545267313;12656.367181641066;12712.046596505485;6837.453003759787;9914.504274786375;12545.184563003375;12864.742705146033;13082.934585327013;7973.9202607973175;8394.082172068798;8582.871256931026;9538.761530961781;9585.664501742405;12083.154179207722;12716.618501444971;12775.552855650008;12823.230606163661;12833.486660533848 10:52:38 INFO - PROCESS | 13768 | |3;mootools.html;1554.0830909763238;1607.8311777263386;1762.162972588021;1858.49820548452;1893.1953919584191;8849.557522123883;8981.281497480202;9144.359894807367;9728;9730.85403718944;9301.720948371543;9306.906930930705;9416.62333506659;9436.245100391969;9444.433333999965;2509.2848538166627;2520.3825062859623;2534.480431511545;2538.746125387456;2549.235229431163;2433.634954756783;2501.524710305045;2502.3368807265997;2505.1983365323103;2509.1970569417795;2485.2047344849657;2493.613489909067;2541.097910241865;2542.529632018083;2548.324693956103;2413.070967677448;2470.1231062972656;2477.2568229531157;2490.96263556045;2501.6247562865533;2365.455945132629;2393.676853624756;2396.928092157238;2432.8661923594195;2512.836665616729;9355.111264429868;9539.761505962337;9551.856722149174;9551.997040310805;9583.329166958316;5692.117721753093;5810.941890581083;5826;5830.5044071254;5856.853578660525;3494.1439347359806;3598.24436868258;3647.6170002149925;3690;3702.352088384549;1211.1340391619947;1226.564569577796;1237.993810030953;1238.195173137468;1241.509603706531;13848.723025539433;14025.78961315581;14139.080959737585;14169.362378692984;14183.645408864757;5072.717277225263;5117.718525481134;5176.404713457925;5176.482351764794;5235.633505654568;11603.419829008515;11728.88271117295;11733.88266117345;11753.823692644617;11776.293422394683;5716.08542633185;5796.101604251347;5817.447342502455;5818.069108942549;5883;4756.262779269219;5209.713465759344;5345.625806193529;5356;5390.460953904657;4452.710573812692;4485.192665320208;4529.207388706963;4557.407537020166;4611.608013318905;1342.5703774792169;1390.958271251864;1413.6889884225454;1425.1520345394474;1434.5696291112624;915.7390143808982;1031;1031.8039572481205;1039.9896001040045;1043.7390652336917;6274.905876411857;6314.400131987546;6321.873562528724;6347.55567110307;6408.423241908157;471.63919601504875;472.0134918021352;479.8968221832323;481.78801327415823;482.32233711635206;4224.852130175429;4258.1057977825;4266.957330426718;4282;4342.413774140514;11807.763844723057;12248.938755306166;12274.263544187199;12290.385480725929;12338.3830808461;12013.699657508632;12045.51817927273;12066.155369124077;12379.6905077372;12417.565385211474;9013.549322533847;9101.499417531966;9108.225800807006;9206.355555111079;9229.676961306322;6430.903536447051;6511.218653761579;6536.607803531803;6625.635590042594;6747.460203183831;11070.723231918944;11237.831432528683;11504.309741415207;11575.42122893835;11593.768124637292;11551.711207219887;11654.76690466169;11691.941540292244;11728.41357932083;11839.822402663794;7952.801179970547;8394.328453723809;8562.143785621389;8562.357823163413;8717.476951382938;9375.671851485165;9396.389234699722;9396.530173491436;9505.049495050716;9520.23838092937;8283.08886022549;8519.787005324917;8522.019967703793;8667.523286219319;8700.695475658322;8272.545010024507;8338.124496927736;8504.319654427507;8518.488890666333;8520.74437766868;7455.142658594331;7549.1695913448375;7574.431917606092;7583.05211848519;7628.885566716614;5396.64921780083;5448.291722076105;5455.1544510600925;5564.55483561306;5572.275604171432;5421.891562168814;5490.258815060076;5565.888682226414;5635.8591035224445;5671.744771485211 10:52:38 INFO - PROCESS | 13768 | |4;prototype.html;340.6287147009759;341.53039570590437;345.1199441424368;352.7548353894045;353.9964600353996;5654.321481422225;5724.8855022899625;5856.297244330681;5858.502027327677;5902.114682797583;5712.285964254468;5728.541716662668;5737.942620573793;5747.4365893146205;5751.971240143804;4498.52765459627;4501.099780043996;4513.390692256553;4515.674427669753;4529.569690879362;4436.97781511092;4485.798139083733;4490.281554951209;4502.144592527409;4539.092181563684;4387.1445068211715;4404.889877753066;4411.09572537629;4435.8225670973125;4444.466664000308;4411.6250118739945;4463.218936686083;4466.9106617867465;4523.705959112647;4533.773311334453;3927.842886284574;4002.2995975704425;4010.1177740896956;4027.114034912344;4046.4941882264716;5561.610687251894;5575.442455754433;5578.693171875545;5590.86022849428;5604.859878503029;5248.317718696545;5251.264822924793;5257.342832145981;5258.843054527998;5279.234510995884;5927.261318419702;6031.698415079229;6055.303640081403;6064.272287325505;6085.513158947318;4431.689781715281;4451.399061126739;4458.4426946631675;4475.261581839025;4480.910381792379;6287.717052732638;6293.685315734195;6332.778352757678;6340.492760579143;6357.1735674362035;4149.024979129962;4360.520342762294;4365.650747940157;4369.934450983238;4389.802458889358;4399.274119770266;4410.787033565731;4416.895776055986;4419.491758447755;4439.644828413784;5074.391073071255;5079.339685840817;5098.082345177903;5117.462666420047;5119.436861945183;5920.851978700481;6022.638641681513;6022.759089636453;6023.759049638053;6034.456898879122;1497.9925100374646;1505.728968785607;1525.3669727063145;1529.4341093795144;1533.8159420869567;930.6361840923977;930.8364544319601;939.6335429182624;957.305953183936;988.6885631026204;5145.919356935011;5198.4801519847715;5214.7914083437;5234.345706786652;5255.474452554714;5421.241026256248;5510.889782204334;5514.222757411186;5523.287780787969;5559.583031272671;4909.656324057353;5183.45573714762;5194.545527252375;5220.712860792617;5281.920771188358;2922.2694326418396;2935.471615109258;2965.4431423502833;2986.522156454957;2988.551717242431;5650.265465489542;5696.743646535916;5724.398938111522;5729.8567535811935;5739.741711622987;5277.208418737144;5584;5667.914981275284;5681.318241811009;5696.629719068247;5615.691136987423;5674.886502269931;5706.686132262766;5715.571332150105;5729.942700572941;5129.076766182123;5476.151196564539;5519.69641669712;5534.225208470737;5619.325680918316;5441.401445841034;5459.918101228405;5460.798624302806;5502.477264659851;5526.778928842801;5559.916601250903;5651.463111004448;5687.971560142173;5706.2011318414625;5756.30924289088;3931.8820435386983;3950.30869597825;3960.5445373782386;4283.892902677458;4297.72064815786;6076.696165191811;6154.507639388748;6181.598196117238;6230.283517395376;6295.685215739103;6101.176341194059;6101.359357267423;6110.816675499742;6119.724612392364;6138.386161383826;6040.818775436744;6068.7269072892705;6087.604305720114;6149.96925015372;6160.784372546939;5698.800541981011;6013.7293821779;6023.397660234117;6044.486218671462;6051.7579296827635;6113.877722445437;6117.541184411276;6142.877142457037;6172.598781079216;6189.442950134509;5799.9130013049;6014.849628759316;6028.728707208098;6048.697565121638;6051.184644606512 10:52:38 INFO - PROCESS | 13768 | |5;yui.html;705.9435245180387;757.9956557561233;817.546261824687;854.4275335525198;900.1628485508479;15072.095674259552;16031.919840400811;16128.354865805353;16165.434209802645;16189.514314570568;15417.383304667828;15452.381904723798;15588.376464941388;15618.76571851423;15683.137427441487;722.072137303565;853.9615717292705;877.5831480046991;881.5812489067706;884.2483888694622;871.7297637732291;878.1043335797483;881.7927786970057;884.8363052835214;885.2829208341232;931.7577429868215;932.1051790281305;932.7061975477736;934.1965909318016;938.2775263047449;924.5700749151677;924.7872989212451;925.7315378540216;926.3932124458457;926.7080869526111;674.865026994603;675.1290834823072;679.7179170644176;679.8266442057293;681.1281559603666;15072.246387680681;15141.394344226217;15163.166025868573;15167.317470713733;15191.468298609607;15217.695646087017;15682.529524114294;15867.04797712141;15908.363665453484;16251.51245462638;12406.627801165889;12649.810252846215;12684.112112152154;12716.554920577735;12945.223286602833;4162.500499939996;4196.349565817303;4237.7669228192435;4245.341971994346;4281.165172791307;78825.21174788293;80113.99999999942;80822.19177808205;81487.18512814856;81813;12798.552050678181;12816.679583010313;12886.420111094836;12888.871111288767;13075.869241307466;24443.63334549983;24456;24481.755182448305;24524.754752452605;24728.381790455383;9490.240780737524;9507.809843803223;9601.519924003773;9707.757306067404;9758.902410975941;5011.774470148852;5064.164412871834;5115.335006449138;5274.815381461631;5292.9735351323;3828.349180639298;4034.677225821927;4035.899102522402;4058.8782336529953;4068.3897415387337;667.5327270910285;667.6061123936901;675.4562577125363;676.5636164673758;680.6086500262369;625.2902955145942;727.3017902813252;743.1194035068353;745.8843879198732;771.2441807029143;10240.180785537139;10359.63741269052;10378.325408848552;10395.636152734769;10428.895711042793;617.3178637605381;737.6311844077961;761.8590560746279;762.6682393158883;772.2470591173673;4915;5018.89962200754;5025.170846810309;5043.646944713835;5046.091703493406;102688.48655756674;122229;123337;124820.37589812174;128106;62479.6876015617;100668.49665751624;101073.4838977416;104826;107089.76927551113;91004.5449772747;91747.54126229326;92487;92970;94450.52774736083;8642;8703;8774.986063550232;8935.731928042169;8969.416987895765;40159.19681606293;44401;54645.18032229599;56676.86646267134;57564.71217643885;75284.62357688177;79320;81213.59393202997;81778;83537.16462835294;11992.520299188283;12421.254724716546;12496;12560.811587826007;12835.294058826854;13250.138740981805;13683.657908551968;13699.863001369858;13700.383482743102;14216.147031178163;12787;13033.283169425773;13110.672233193865;13169.144005639602;13536.255505947267;12259.203151795105;12355;12550.686232843887;12674.112812103065;12749.745005099661;12700.237985720887;12745.642056219629;12817.807732883828;12963.481460741465;13077.803832942704;10602.575896964343;10719.517621706886;10735.302205356627;10772.192085593768;10967.890321096687;11021;11145.777084458428;11265.774684506428;11409.885901140882;11510.884891151316 10:52:38 INFO - PROCESS | 13768 | __end_tp_report 10:52:38 INFO - PROCESS | 13768 | __start_cc_report 10:52:38 INFO - PROCESS | 13768 | _x_x_mozilla_cycle_collect,342 10:52:38 INFO - PROCESS | 13768 | __end_cc_report 10:52:38 INFO - PROCESS | 13768 | __startTimestamp1467049958180__endTimestamp 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | ------- Summary: start ------- 10:52:38 INFO - PROCESS | 13768 | Number of tests: 6 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#0] dojo.html Cycles:165 Average:5734.73 Median:5970.85 stddev:650.46 (10.9%) stddev-sans-first:625.08 10:52:38 INFO - PROCESS | 13768 | Values: 3354.6 3373.1 3386.2 3401.3 3407.5 5645.3 5703.0 5704.7 5711.7 5716.2 5735.1 5740.1 5769.9 5781.6 5785.5 5138.6 5199.8 5263.7 5273.1 5293.4 5047.0 5099.2 5236.5 5278.8 5282.0 5176.7 5196.4 5208.5 5208.6 5249.3 5207.0 5208.3 5252.7 5299.5 5299.5 5159.5 5221.2 5259.2 5292.2 5314.4 5478.5 5592.2 5643.4 5657.5 5718.1 6213.4 6247.3 6253.6 6258.0 6268.5 6010.7 6284.4 6318.4 6331.8 6334.3 5811.1 5831.4 5842.9 5866.9 5882.0 6270.4 6275.7 6299.2 6328.4 6366.4 5896.3 5970.6 6082.4 6116.8 6124.7 6043.4 6195.9 6196.8 6243.7 6254.3 6174.7 6181.6 6182.2 6190.0 6203.4 6013.0 6087.1 6089.4 6181.8 6193.2 4714.6 4719.3 4723.5 4747.4 4762.5 4211.2 4221.1 4224.2 4229.2 4252.1 5864.4 5879.2 5930.0 5954.2 5983.8 6018.7 6092.2 6096.4 6123.3 6148.3 5895.0 5939.4 5946.6 5953.1 5954.3 5150.8 5267.3 5327.0 5327.6 5365.8 6318.4 6380.4 6387.8 6396.8 6400.3 6190.8 6191.3 6238.8 6240.9 6254.7 6160.0 6263.9 6306.4 6423.3 6433.7 6125.4 6129.3 6130.9 6133.9 6150.0 6208.1 6244.9 6246.8 6247.9 6252.4 5901.6 5920.9 5935.0 5986.9 6089.7 6003.5 6046.7 6050.7 6056.3 6061.5 5919.4 5963.9 5973.5 5979.3 5993.2 5875.6 5970.9 5990.6 6077.4 6086.4 5974.8 5993.8 5996.0 6008.1 6009.9 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#1] ext.html Cycles:180 Average:71604.01 Median:42747.86 stddev:164168.81 (384.0%) stddev-sans-first:164542.80 10:52:38 INFO - PROCESS | 13768 | Values: 604.0 645.9 666.8 668.7 679.6 41449.6 44725.3 45153.0 45299.0 45419.5 46120.8 46821.3 46860.3 46889.3 46920.9 8896.5 9019.5 9027.0 9031.5 9034.5 8790.6 8825.2 8909.4 8918.9 8948.5 8958.1 8991.6 9001.4 9012.9 9014.8 8994.4 9009.9 9026.3 9028.0 9046.2 8875.4 8892.6 8937.7 8949.9 8963.0 42506.8 42723.4 43007.0 43039.1 43210.6 3766.8 3844.1 3973.7 4147.4 4413.3 33053.0 33831.7 34127.7 34418.8 34730.0 4368.3 4369.8 4375.1 4480.8 4521.6 375157.0 379451.0 380452.0 381387.1 381497.0 39151.8 63208.0 63674.0 63680.7 63878.7 39400.4 39534.6 39541.4 39683.8 39758.2 16845.2 16891.6 16982.2 17065.1 17085.4 14215.5 14350.9 14429.5 14441.9 14478.1 9206.2 9208.4 9229.6 9239.7 9275.4 3401.3 3490.0 3539.9 3582.2 3583.0 1015.3 1067.6 1085.1 1153.5 1167.5 32238.8 32756.8 32823.7 32858.7 33082.0 1169.6 1177.8 1214.8 1228.6 1269.7 17346.6 17352.1 17657.6 17696.3 17728.6 463455.0 623577.0 915080.0 926154.0 931772.0 61482.7 62662.4 62827.0 62924.0 63145.4 1447.8 1507.4 1509.7 1512.5 1538.3 32974.7 33746.0 33918.3 34188.7 34239.0 54235.5 54828.5 54931.7 54953.5 54995.0 576222.0 581682.0 582906.0 583028.0 583326.0 29355.7 30380.5 30498.8 30807.8 30824.7 49112.0 49719.8 50269.0 50327.7 50546.7 41114.0 42066.6 42128.0 42194.0 43863.0 41036.0 41903.8 42453.0 43296.4 43539.1 41980.6 42772.4 42845.8 43249.0 43314.8 36874.3 37307.0 37531.2 37827.0 38263.0 29183.7 29321.6 29362.4 29771.0 29887.1 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#2] jquery.html Cycles:180 Average:28468.13 Median:2401.37 stddev:75909.18 (3161.1%) stddev-sans-first:76092.91 10:52:38 INFO - PROCESS | 13768 | Values: 419.1 422.5 423.5 427.5 444.9 18717.5 19985.0 20805.3 20827.3 20844.1 19397.3 19414.6 19629.6 20385.0 20491.3 5889.4 6067.2 6085.7 6095.0 6108.0 5679.5 5971.5 5976.8 6025.8 6043.0 5988.7 6005.1 6018.0 6028.3 6050.6 6708.5 6734.3 6760.9 6780.9 6783.4 5796.4 5991.7 6053.3 6059.5 6083.5 14294.2 14718.1 14783.0 14848.7 14860.1 2396.3 2406.4 2418.9 2630.4 2825.9 9876.4 10379.3 10539.0 10594.6 10657.0 2023.4 2065.2 2107.4 2151.8 2153.4 83372.0 83633.6 85136.1 85569.6 86320.0 11376.7 11566.7 11568.1 11611.8 11860.4 16264.9 16452.5 16472.4 16493.2 16509.4 8758.6 8802.7 8832.6 8965.5 9037.2 8562.5 8614.1 8680.7 8728.3 8777.8 4933.7 5010.9 5041.6 5045.3 5077.6 2042.1 2052.9 2062.5 2070.4 2139.2 971.1 996.9 1007.8 1009.8 1090.7 19890.3 20278.0 20519.7 20737.0 20807.1 1058.6 1077.4 1097.9 1100.0 1121.9 11080.8 11271.9 11420.5 11589.8 11596.3 445079.0 459900.0 459915.0 463567.0 467525.0 79012.0 88592.6 91090.0 96016.5 97818.5 1070.7 1098.9 1136.9 1149.4 1153.8 18638.9 18680.8 18847.2 18889.2 19103.5 38746.6 39854.4 44880.6 44999.3 45005.0 57823.0 58063.0 59224.7 59908.7 60533.0 9159.5 9374.3 9533.1 9594.6 9677.1 13372.9 14130.4 14246.0 14301.9 14315.4 12104.9 12240.3 12302.4 12352.0 12833.7 12251.0 12339.0 12574.2 12656.4 12712.0 6837.5 9914.5 12545.2 12864.7 13082.9 7973.9 8394.1 8582.9 9538.8 9585.7 12083.2 12716.6 12775.6 12823.2 12833.5 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#3] mootools.html Cycles:180 Average:6378.46 Median:2614.14 stddev:3739.44 (143.0%) stddev-sans-first:3732.36 10:52:38 INFO - PROCESS | 13768 | Values: 1554.1 1607.8 1762.2 1858.5 1893.2 8849.6 8981.3 9144.4 9728.0 9730.9 9301.7 9306.9 9416.6 9436.2 9444.4 2509.3 2520.4 2534.5 2538.7 2549.2 2433.6 2501.5 2502.3 2505.2 2509.2 2485.2 2493.6 2541.1 2542.5 2548.3 2413.1 2470.1 2477.3 2491.0 2501.6 2365.5 2393.7 2396.9 2432.9 2512.8 9355.1 9539.8 9551.9 9552.0 9583.3 5692.1 5810.9 5826.0 5830.5 5856.9 3494.1 3598.2 3647.6 3690.0 3702.4 1211.1 1226.6 1238.0 1238.2 1241.5 13848.7 14025.8 14139.1 14169.4 14183.6 5072.7 5117.7 5176.4 5176.5 5235.6 11603.4 11728.9 11733.9 11753.8 11776.3 5716.1 5796.1 5817.4 5818.1 5883.0 4756.3 5209.7 5345.6 5356.0 5390.5 4452.7 4485.2 4529.2 4557.4 4611.6 1342.6 1391.0 1413.7 1425.2 1434.6 915.7 1031.0 1031.8 1040.0 1043.7 6274.9 6314.4 6321.9 6347.6 6408.4 471.6 472.0 479.9 481.8 482.3 4224.9 4258.1 4267.0 4282.0 4342.4 11807.8 12248.9 12274.3 12290.4 12338.4 12013.7 12045.5 12066.2 12379.7 12417.6 9013.5 9101.5 9108.2 9206.4 9229.7 6430.9 6511.2 6536.6 6625.6 6747.5 11070.7 11237.8 11504.3 11575.4 11593.8 11551.7 11654.8 11691.9 11728.4 11839.8 7952.8 8394.3 8562.1 8562.4 8717.5 9375.7 9396.4 9396.5 9505.0 9520.2 8283.1 8519.8 8522.0 8667.5 8700.7 8272.5 8338.1 8504.3 8518.5 8520.7 7455.1 7549.2 7574.4 7583.1 7628.9 5396.6 5448.3 5455.2 5564.6 5572.3 5421.9 5490.3 5565.9 5635.9 5671.7 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#4] prototype.html Cycles:180 Average:4910.08 Median:5521.49 stddev:1430.86 (25.9%) stddev-sans-first:1393.16 10:52:38 INFO - PROCESS | 13768 | Values: 340.6 341.5 345.1 352.8 354.0 5654.3 5724.9 5856.3 5858.5 5902.1 5712.3 5728.5 5737.9 5747.4 5752.0 4498.5 4501.1 4513.4 4515.7 4529.6 4437.0 4485.8 4490.3 4502.1 4539.1 4387.1 4404.9 4411.1 4435.8 4444.5 4411.6 4463.2 4466.9 4523.7 4533.8 3927.8 4002.3 4010.1 4027.1 4046.5 5561.6 5575.4 5578.7 5590.9 5604.9 5248.3 5251.3 5257.3 5258.8 5279.2 5927.3 6031.7 6055.3 6064.3 6085.5 4431.7 4451.4 4458.4 4475.3 4480.9 6287.7 6293.7 6332.8 6340.5 6357.2 4149.0 4360.5 4365.7 4369.9 4389.8 4399.3 4410.8 4416.9 4419.5 4439.6 5074.4 5079.3 5098.1 5117.5 5119.4 5920.9 6022.6 6022.8 6023.8 6034.5 1498.0 1505.7 1525.4 1529.4 1533.8 930.6 930.8 939.6 957.3 988.7 5145.9 5198.5 5214.8 5234.3 5255.5 5421.2 5510.9 5514.2 5523.3 5559.6 4909.7 5183.5 5194.5 5220.7 5281.9 2922.3 2935.5 2965.4 2986.5 2988.6 5650.3 5696.7 5724.4 5729.9 5739.7 5277.2 5584.0 5667.9 5681.3 5696.6 5615.7 5674.9 5706.7 5715.6 5729.9 5129.1 5476.2 5519.7 5534.2 5619.3 5441.4 5459.9 5460.8 5502.5 5526.8 5559.9 5651.5 5688.0 5706.2 5756.3 3931.9 3950.3 3960.5 4283.9 4297.7 6076.7 6154.5 6181.6 6230.3 6295.7 6101.2 6101.4 6110.8 6119.7 6138.4 6040.8 6068.7 6087.6 6150.0 6160.8 5698.8 6013.7 6023.4 6044.5 6051.8 6113.9 6117.5 6142.9 6172.6 6189.4 5799.9 6014.8 6028.7 6048.7 6051.2 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - PROCESS | 13768 | [#5] yui.html Cycles:180 Average:21474.99 Median:4179.43 stddev:31158.37 (745.5%) stddev-sans-first:31206.75 10:52:38 INFO - PROCESS | 13768 | Values: 705.9 758.0 817.5 854.4 900.2 15072.1 16031.9 16128.4 16165.4 16189.5 15417.4 15452.4 15588.4 15618.8 15683.1 722.1 854.0 877.6 881.6 884.2 871.7 878.1 881.8 884.8 885.3 931.8 932.1 932.7 934.2 938.3 924.6 924.8 925.7 926.4 926.7 674.9 675.1 679.7 679.8 681.1 15072.2 15141.4 15163.2 15167.3 15191.5 15217.7 15682.5 15867.0 15908.4 16251.5 12406.6 12649.8 12684.1 12716.6 12945.2 4162.5 4196.3 4237.8 4245.3 4281.2 78825.2 80114.0 80822.2 81487.2 81813.0 12798.6 12816.7 12886.4 12888.9 13075.9 24443.6 24456.0 24481.8 24524.8 24728.4 9490.2 9507.8 9601.5 9707.8 9758.9 5011.8 5064.2 5115.3 5274.8 5293.0 3828.3 4034.7 4035.9 4058.9 4068.4 667.5 667.6 675.5 676.6 680.6 625.3 727.3 743.1 745.9 771.2 10240.2 10359.6 10378.3 10395.6 10428.9 617.3 737.6 761.9 762.7 772.2 4915.0 5018.9 5025.2 5043.6 5046.1 102688.5 122229.0 123337.0 124820.4 128106.0 62479.7 100668.5 101073.5 104826.0 107089.8 91004.5 91747.5 92487.0 92970.0 94450.5 8642.0 8703.0 8775.0 8935.7 8969.4 40159.2 44401.0 54645.2 56676.9 57564.7 75284.6 79320.0 81213.6 81778.0 83537.2 11992.5 12421.3 12496.0 12560.8 12835.3 13250.1 13683.7 13699.9 13700.4 14216.1 12787.0 13033.3 13110.7 13169.1 13536.3 12259.2 12355.0 12550.7 12674.1 12749.7 12700.2 12745.6 12817.8 12963.5 13077.8 10602.6 10719.5 10735.3 10772.2 10967.9 11021.0 11145.8 11265.8 11409.9 11510.9 10:52:38 INFO - PROCESS | 13768 | -------- Summary: end -------- 10:52:38 INFO - PROCESS | 13768 | 10:52:38 INFO - TEST-INFO | 13768: exit 0 10:52:38 INFO - TEST-OK | dromaeo_css | took 1109646ms 10:52:38 INFO - TEST-START | kraken 10:52:38 INFO - operating with platform_type : linux_ 10:52:38 INFO - Initialising browser for kraken test... 10:52:38 INFO - TEST-INFO | started process 14008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIssGKs/profile http://localhost:48016/getInfo.html) 10:52:43 INFO - PROCESS | 14008 | __metrics Screen width/height:1600/1200 10:52:43 INFO - PROCESS | 14008 | colorDepth:24 10:52:43 INFO - PROCESS | 14008 | Browser inner width/height: 1024/697 10:52:43 INFO - PROCESS | 14008 | __metrics 10:52:43 ERROR - PROCESS | 14008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:52:44 INFO - TEST-INFO | 14008: exit 0 10:52:44 INFO - Browser initialized. 10:52:44 INFO - Running cycle 1/1 for kraken test... 10:52:44 INFO - TEST-INFO | started process 14136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIssGKs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:56 INFO - PROCESS | 14136 | RSS: Main: 155938816 10:52:56 INFO - PROCESS | 14136 | 10:52:58 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:59 INFO - PROCESS | 14136 | RSS: Main: 161136640 10:52:59 INFO - PROCESS | 14136 | 10:53:02 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-dft) 10:53:03 INFO - PROCESS | 14136 | RSS: Main: 160088064 10:53:03 INFO - PROCESS | 14136 | 10:53:05 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-fft) 10:53:06 INFO - PROCESS | 14136 | RSS: Main: 161619968 10:53:06 INFO - PROCESS | 14136 | 10:53:08 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48016/tests/kraken/driver.html?testName=audio-oscillator) 10:53:09 INFO - PROCESS | 14136 | RSS: Main: 160641024 10:53:09 INFO - PROCESS | 14136 | 10:53:11 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:12 INFO - PROCESS | 14136 | RSS: Main: 161542144 10:53:12 INFO - PROCESS | 14136 | 10:53:15 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:15 INFO - PROCESS | 14136 | RSS: Main: 160616448 10:53:15 INFO - PROCESS | 14136 | 10:53:19 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48016/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:19 INFO - PROCESS | 14136 | RSS: Main: 160772096 10:53:19 INFO - PROCESS | 14136 | 10:53:22 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48016/tests/kraken/driver.html?testName=json-parse-financial) 10:53:23 INFO - PROCESS | 14136 | RSS: Main: 160940032 10:53:23 INFO - PROCESS | 14136 | 10:53:24 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:25 INFO - PROCESS | 14136 | RSS: Main: 160706560 10:53:25 INFO - PROCESS | 14136 | 10:53:27 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:27 INFO - PROCESS | 14136 | RSS: Main: 160591872 10:53:27 INFO - PROCESS | 14136 | 10:53:29 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:30 INFO - PROCESS | 14136 | RSS: Main: 160923648 10:53:30 INFO - PROCESS | 14136 | 10:53:33 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:33 INFO - PROCESS | 14136 | RSS: Main: 161435648 10:53:33 INFO - PROCESS | 14136 | 10:53:36 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:36 INFO - PROCESS | 14136 | RSS: Main: 161148928 10:53:36 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | Cycle 1(1): loaded http://localhost:48016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48016/tests/kraken/driver.html?testName=ai-astar) 10:53:38 INFO - PROCESS | 14136 | RSS: Main: 162349056 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | __start_tp_report 10:53:38 INFO - PROCESS | 14136 | _x_x_mozilla_page_load 10:53:38 INFO - PROCESS | 14136 | _x_x_mozilla_page_load_details 10:53:38 INFO - PROCESS | 14136 | |i|pagename|runs| 10:53:38 INFO - PROCESS | 14136 | |0;ai-astar;113;105;111;112;111;113;113;112;110;110 10:53:38 INFO - PROCESS | 14136 | |1;audio-beat-detection;150;130;149;177;127;157;155;123;181;129 10:53:38 INFO - PROCESS | 14136 | |2;audio-dft;161;163;162;161;162;163;162;162;162;162 10:53:38 INFO - PROCESS | 14136 | |3;audio-fft;75;76;75;182;77;76;75;75;164;77 10:53:38 INFO - PROCESS | 14136 | |4;audio-oscillator;85;84;161;84;85;84;148;86;84;140 10:53:38 INFO - PROCESS | 14136 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;118;117 10:53:38 INFO - PROCESS | 14136 | |6;imaging-darkroom;147;146;147;146;146;147;146;147;147;149 10:53:38 INFO - PROCESS | 14136 | |7;imaging-desaturate;96;96;97;97;95;95;95;96;96;96 10:53:38 INFO - PROCESS | 14136 | |8;json-parse-financial;54;53;51;53;53;53;53;53;52;53 10:53:38 INFO - PROCESS | 14136 | |9;json-stringify-tinderbox;60;61;60;61;61;60;60;60;62;69 10:53:38 INFO - PROCESS | 14136 | |10;stanford-crypto-aes;83;77;78;77;80;83;79;78;102;76 10:53:38 INFO - PROCESS | 14136 | |11;stanford-crypto-ccm;119;120;126;118;124;133;118;118;134;138 10:53:38 INFO - PROCESS | 14136 | |12;stanford-crypto-pbkdf2;152;153;156;152;162;159;154;151;154;155 10:53:38 INFO - PROCESS | 14136 | |13;stanford-crypto-sha256-iterative;63;62;61;65;60;61;61;61;63;61 10:53:38 INFO - PROCESS | 14136 | __end_tp_report 10:53:38 INFO - PROCESS | 14136 | __start_cc_report 10:53:38 INFO - PROCESS | 14136 | _x_x_mozilla_cycle_collect,894 10:53:38 INFO - PROCESS | 14136 | __end_cc_report 10:53:38 INFO - PROCESS | 14136 | __startTimestamp1467050018816__endTimestamp 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | ------- Summary: start ------- 10:53:38 INFO - PROCESS | 14136 | Number of tests: 14 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.40 (2.1%) stddev-sans-first:2.44 10:53:38 INFO - PROCESS | 14136 | Values: 113.0 105.0 111.0 112.0 111.0 113.0 113.0 112.0 110.0 110.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.50 stddev:20.59 (13.5%) stddev-sans-first:21.82 10:53:38 INFO - PROCESS | 14136 | Values: 150.0 130.0 149.0 177.0 127.0 157.0 155.0 123.0 181.0 129.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 10:53:38 INFO - PROCESS | 14136 | Values: 161.0 163.0 162.0 161.0 162.0 163.0 162.0 162.0 162.0 162.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:41.23 (54.6%) stddev-sans-first:43.08 10:53:38 INFO - PROCESS | 14136 | Values: 75.0 76.0 75.0 182.0 77.0 76.0 75.0 75.0 164.0 77.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:84.00 stddev:31.84 (37.9%) stddev-sans-first:33.02 10:53:38 INFO - PROCESS | 14136 | Values: 85.0 84.0 161.0 84.0 85.0 84.0 148.0 86.0 84.0 140.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:53:38 INFO - PROCESS | 14136 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 10:53:38 INFO - PROCESS | 14136 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 149.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:53:38 INFO - PROCESS | 14136 | Values: 96.0 96.0 97.0 97.0 95.0 95.0 95.0 96.0 96.0 96.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 10:53:38 INFO - PROCESS | 14136 | Values: 54.0 53.0 51.0 53.0 53.0 53.0 53.0 53.0 52.0 53.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:2.76 (4.5%) stddev-sans-first:2.88 10:53:38 INFO - PROCESS | 14136 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 60.0 60.0 62.0 69.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:78.50 stddev:7.66 (9.8%) stddev-sans-first:8.10 10:53:38 INFO - PROCESS | 14136 | Values: 83.0 77.0 78.0 77.0 80.0 83.0 79.0 78.0 102.0 76.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.00 stddev:7.63 (6.1%) stddev-sans-first:7.80 10:53:38 INFO - PROCESS | 14136 | Values: 119.0 120.0 126.0 118.0 124.0 133.0 118.0 118.0 134.0 138.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:154.50 stddev:3.43 (2.2%) stddev-sans-first:3.48 10:53:38 INFO - PROCESS | 14136 | Values: 152.0 153.0 156.0 152.0 162.0 159.0 154.0 151.0 154.0 155.0 10:53:38 INFO - PROCESS | 14136 | 10:53:38 INFO - PROCESS | 14136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:1.48 (2.4%) stddev-sans-first:1.50 10:53:38 INFO - PROCESS | 14136 | Values: 63.0 62.0 61.0 65.0 60.0 61.0 61.0 61.0 63.0 61.0 10:53:38 INFO - PROCESS | 14136 | -------- Summary: end -------- 10:53:38 INFO - PROCESS | 14136 | 10:53:39 INFO - TEST-INFO | 14136: exit 0 10:53:39 INFO - TEST-OK | kraken | took 60776ms 10:53:39 INFO - SUITE-END | took 1170s 10:53:39 INFO - Completed test suite (00:19:30) 10:53:39 INFO - javascript benchmark 10:53:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7600.001790061422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.5806774153225, 3373.0724050885988, 3386.2211691311, 3401.2857299967004, 3407.505911642812, 5645.322561292641, 5703.0, 5704.65772053677, 5711.7144142792795, 5716.1711551824965, 5735.139729040646, 5740.052891272945, 5769.884602307951, 5781.595288329819, 5785.479306862381, 5138.614603904713, 5199.766010529516, 5263.736813159346, 5273.1035723927025, 5293.364796224459, 5046.97476512617, 5099.184130539114, 5236.450172731866, 5278.762455689503, 5281.973590132063, 5176.689398636075, 5196.402413722432, 5208.479152084799, 5208.609354298424, 5249.265102885599, 5207.0, 5208.2968799212185, 5252.658577192508, 5299.470052994709, 5299.54953828925, 5159.458256883048, 5221.242919776611, 5259.184826351921, 5292.153255479105, 5314.362276526842, 5478.534324582415, 5592.189132575794, 5643.351014633287, 5657.519110875581, 5718.056520674084, 6213.409726076015, 6247.281562620311, 6253.624782513064, 6257.9687101564205, 6268.49852011838, 6010.729517171738, 6284.434400903895, 6318.4313411793155, 6331.841703957438, 6334.3032266450655, 5811.070228763378, 5831.387704291031, 5842.883142337215, 5866.882662346729, 5881.970590147064, 6270.404311590391, 6275.654838983808, 6299.212598425197, 6328.430441260309, 6366.427021568081, 5896.262967129109, 5970.611910225822, 6082.391760823971, 6116.816495505142, 6124.724387402578, 6043.395660433922, 6195.876082478325, 6196.783112591038, 6243.656598887105, 6254.2807577129215, 6174.722137503823, 6181.567290289637, 6182.165407669997, 6189.96905015481, 6203.379662033761, 6012.969935150296, 6087.086936959491, 6089.421504957022, 6181.752729890754, 6193.163922870445, 4714.6464015199, 4719.2921061841, 4723.48041715411, 4747.430308362949, 4762.499937506512, 4211.241976444208, 4221.092465120014, 4224.218519573888, 4229.154169166179, 4252.107057517894, 5864.354920958691, 5879.206307148565, 5929.970350148308, 5954.225950626391, 5983.820485385445, 6018.668973206516, 6092.238470191226, 6096.390360963868, 6123.28262147438, 6148.3236843948025, 5894.970525147347, 5939.406059394112, 5946.643201407929, 5953.077273022602, 5954.345022047572, 5150.845474635767, 5267.341582302212, 5327.0, 5327.573794096463, 5365.839024829262, 6318.399752023551, 6380.425761681471, 6387.840303992437, 6396.808095757135, 6400.295967443578, 6190.81427557174, 6191.25704915404, 6238.750449982132, 6240.906386404116, 6254.655993920378, 6159.969200153971, 6263.874722505433, 6306.432421081941, 6423.325550817097, 6433.742650293936, 6125.388069147199, 6129.264488261437, 6130.896438641087, 6133.9079913802225, 6149.96925015372, 6208.0998255253635, 6244.937550624436, 6246.750129994749, 6247.937520624918, 6252.406021427957, 5901.616394934315, 5920.940790592039, 5935.0, 5986.88026239464, 6089.725962331617, 6003.489703375262, 6046.667433291212, 6050.697465126814, 6056.333803281724, 6061.454469097803, 5919.378465261086, 5963.850903727442, 5973.462388385066, 5979.312379076462, 5993.220881285405, 5875.588708790344, 5970.850728731816, 5990.64056156632, 6077.392260773887, 6086.391360863879, 5974.820755377345, 5993.820185394445, 5996.0, 6008.098785182257, 6009.939900600938], "value": 5691.233755939348, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9637621742696, 645.9386358295961, 666.8266250774799, 668.7091115364814, 679.5956405938465, 41449.58550414499, 44725.32912006322, 45153.0, 45299.0, 45419.54580454199, 46120.76939615297, 46821.29768053482, 46860.297095543596, 46889.29666055003, 46920.8885600148, 8896.510691911943, 9019.45883247004, 9027.0, 9031.503267320295, 9034.548272586377, 8790.64837406503, 8825.205731484166, 8909.376343655947, 8918.910810891904, 8948.507832069234, 8958.104189581023, 8991.640334386617, 9001.414908030989, 9012.8648070279, 9014.774630634221, 8994.370394072417, 9009.864852027225, 9026.277897768196, 9028.0, 9046.185843274137, 8875.423097498706, 8892.644294228223, 8937.73186804397, 8949.910500894974, 8963.0, 42506.78746606278, 42723.35914961278, 43007.0, 43039.139217215794, 43210.56789432097, 3766.7551609145594, 3844.1350696093155, 3973.721839471238, 4147.39862719907, 4413.3159360299205, 33053.0, 33831.6616833831, 34127.65872341295, 34418.82790586031, 34730.0, 4368.344748287751, 4369.759663218521, 4375.12497500498, 4480.775961201959, 4521.615662668644, 375157.0, 379451.0, 380452.0, 381387.0930645357, 381497.0, 39151.80424097918, 63208.0, 63674.0, 63680.68159659172, 63878.6806065976, 39400.408993865116, 39534.60465395367, 39541.406878896836, 39683.80158099191, 39758.2048359037, 16845.157742112846, 16891.577710557336, 16982.150892455327, 17065.14674266282, 17085.402010929807, 14215.50245741394, 14350.928245358706, 14429.49496767608, 14441.916856235825, 14478.131312121306, 9206.217471514863, 9208.447493150432, 9229.584668689926, 9239.676611318571, 9275.350725449154, 3401.2517246205794, 3489.9825500872334, 3539.9292014159573, 3582.2119133790525, 3582.964170358315, 1015.314662602755, 1067.5516283161091, 1085.1361127352247, 1153.4636394076795, 1167.5271515036425, 32238.83880580629, 32756.83621581877, 32823.67176328254, 32858.671413286036, 33082.0, 1169.5847973969119, 1177.7879981603223, 1214.8117041858527, 1228.5761412312738, 1269.7270086931169, 17346.566335841453, 17352.13239338028, 17657.646847062988, 17696.29214831418, 17728.55678608045, 463455.0, 623577.0, 915080.0, 926154.0, 931772.0, 61482.69258653678, 62662.373376266565, 62827.0, 62924.0, 63145.368546314865, 1447.840737518893, 1507.4196434372845, 1509.7207016701725, 1512.5235550801683, 1538.2770098053898, 32974.67025329716, 33746.0, 33918.321633567684, 34188.65811341855, 34239.0, 54235.45764542304, 54828.45171548393, 54931.725341373036, 54953.45046549483, 54995.0, 576222.0, 581682.0, 582906.0, 583028.0, 583326.0, 29355.706442935298, 30380.5442918352, 30498.84750576233, 30807.84596077095, 30824.69175308308, 49112.0, 49719.751401242764, 50269.0, 50327.74836125796, 50546.74726626343, 41114.0, 42066.57933420749, 42128.0, 42194.0, 43863.0, 41036.0, 41903.7904810474, 42453.0, 43296.350554742334, 43539.12921741484, 41980.58019419767, 42772.35841462318, 42845.78577107094, 43249.0, 43314.78342608267, 36874.26251474902, 37307.0, 37531.24937501289, 37827.0, 38263.0, 29183.70816291895, 29321.56017659694, 29362.412751745273, 29771.0, 29887.103386898427], "value": 20268.360668358648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.10521037584755, 422.5331009234794, 423.5341124762761, 427.508365379813, 444.88433007418064, 18717.532061698446, 19985.0, 20805.27181548646, 20827.27104551341, 20844.062017209224, 19397.321093761722, 19414.611707765835, 19629.607407851836, 20385.0, 20491.282805101826, 5889.352171261147, 6067.150598916155, 6085.726142323606, 6094.96952515239, 6107.969460152693, 5679.545636349103, 5971.492423144038, 5976.790812321569, 6025.849353766147, 6043.0, 5988.700564971756, 6005.099235114724, 6018.0, 6028.3067447243475, 6050.606710563821, 6708.49686273529, 6734.326567343275, 6760.932390676104, 6780.932190678104, 6783.42340901024, 5796.434962560127, 5991.730372133265, 6053.273607167168, 6059.454649081604, 6083.48290395317, 14294.213818239992, 14718.116912985255, 14783.0, 14848.703025939529, 14860.108393496317, 2396.341006223285, 2406.3984003999, 2418.891149898259, 2630.434456591842, 2825.9010934617395, 9876.35803672759, 10379.325343852626, 10539.0, 10594.576216951313, 10657.0, 2023.3525271912995, 2065.1713922979234, 2107.4309936317263, 2151.806337429623, 2153.386284908809, 83372.0, 83633.58183209106, 85136.14863851406, 85569.57215213885, 86319.99999999937, 11376.658700239006, 11566.653000409833, 11568.074554035657, 11611.825822612667, 11860.406979650983, 16264.918675406783, 16452.506424807274, 16472.42346517866, 16493.17534123313, 16509.422170223985, 8758.649654013896, 8802.735917922473, 8832.55837208137, 8965.462072275684, 9037.231835293942, 8562.529060901586, 8614.095519970439, 8680.6527738891, 8728.345374096842, 8777.824443511094, 4933.703977761274, 5010.89978200434, 5041.6470847040355, 5045.293658887758, 5077.568406685473, 2042.0504465423649, 2052.9076191571417, 2062.494688801223, 2070.3892351756267, 2139.2405695978014, 971.145392054987, 996.940183588987, 1007.8337074382791, 1009.7627057641448, 1090.7109615951779, 19890.30383936555, 20278.0, 20519.692204616942, 20737.0, 20807.06368213434, 1058.6347710040025, 1077.4289626497969, 1097.8572785537829, 1099.9780004399868, 1121.9046381057701, 11080.778384432428, 11271.94364028191, 11420.486078126338, 11589.826152607717, 11596.304221746723, 445079.0, 459900.0, 459915.0, 463567.0, 467525.0, 79012.0, 88592.5570372144, 91090.0, 96016.51991739997, 97818.51090744643, 1070.6948519672012, 1098.8681358236902, 1136.9147313951487, 1149.4137989625185, 1153.8326942593444, 18638.906805465886, 18680.813191867906, 18847.24611015599, 18889.244430223185, 19103.52241193981, 38746.61253387543, 39854.40218396668, 44880.551194487634, 44999.32501012422, 45005.0, 57823.0, 58063.0, 59224.703876480344, 59908.70045649744, 60533.0, 9159.542022898962, 9374.343795934219, 9533.142017218484, 9594.568244429158, 9677.129058384498, 13372.866271337161, 14130.434782608581, 14246.002779805729, 14301.92849035748, 14315.427382904567, 12104.878951210727, 12240.326782027074, 12302.384880756106, 12352.0, 12833.679158021125, 12251.0, 12339.0, 12574.245545267313, 12656.367181641066, 12712.046596505485, 6837.453003759787, 9914.504274786375, 12545.184563003375, 12864.742705146033, 13082.934585327013, 7973.9202607973175, 8394.082172068798, 8582.871256931026, 9538.761530961781, 9585.664501742405, 12083.154179207722, 12716.618501444971, 12775.552855650008, 12823.230606163661, 12833.486660533848], "value": 9602.240966509053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.0830909763238, 1607.8311777263386, 1762.162972588021, 1858.49820548452, 1893.1953919584191, 8849.557522123883, 8981.281497480202, 9144.359894807367, 9728.0, 9730.85403718944, 9301.720948371543, 9306.906930930705, 9416.62333506659, 9436.245100391969, 9444.433333999965, 2509.2848538166627, 2520.3825062859623, 2534.480431511545, 2538.746125387456, 2549.235229431163, 2433.634954756783, 2501.524710305045, 2502.3368807265997, 2505.1983365323103, 2509.1970569417795, 2485.2047344849657, 2493.613489909067, 2541.097910241865, 2542.529632018083, 2548.324693956103, 2413.070967677448, 2470.1231062972656, 2477.2568229531157, 2490.96263556045, 2501.6247562865533, 2365.455945132629, 2393.676853624756, 2396.928092157238, 2432.8661923594195, 2512.836665616729, 9355.111264429868, 9539.761505962337, 9551.856722149174, 9551.997040310805, 9583.329166958316, 5692.117721753093, 5810.941890581083, 5826.0, 5830.5044071254, 5856.853578660525, 3494.1439347359806, 3598.24436868258, 3647.6170002149925, 3690.0, 3702.352088384549, 1211.1340391619947, 1226.564569577796, 1237.993810030953, 1238.195173137468, 1241.509603706531, 13848.723025539433, 14025.78961315581, 14139.080959737585, 14169.362378692984, 14183.645408864757, 5072.717277225263, 5117.718525481134, 5176.404713457925, 5176.482351764794, 5235.633505654568, 11603.419829008515, 11728.88271117295, 11733.88266117345, 11753.823692644617, 11776.293422394683, 5716.08542633185, 5796.101604251347, 5817.447342502455, 5818.069108942549, 5883.0, 4756.262779269219, 5209.713465759344, 5345.625806193529, 5356.0, 5390.460953904657, 4452.710573812692, 4485.192665320208, 4529.207388706963, 4557.407537020166, 4611.608013318905, 1342.5703774792169, 1390.958271251864, 1413.6889884225454, 1425.1520345394474, 1434.5696291112624, 915.7390143808982, 1031.0, 1031.8039572481205, 1039.9896001040045, 1043.7390652336917, 6274.905876411857, 6314.400131987546, 6321.873562528724, 6347.55567110307, 6408.423241908157, 471.63919601504875, 472.0134918021352, 479.8968221832323, 481.78801327415823, 482.32233711635206, 4224.852130175429, 4258.1057977825, 4266.957330426718, 4282.0, 4342.413774140514, 11807.763844723057, 12248.938755306166, 12274.263544187199, 12290.385480725929, 12338.3830808461, 12013.699657508632, 12045.51817927273, 12066.155369124077, 12379.6905077372, 12417.565385211474, 9013.549322533847, 9101.499417531966, 9108.225800807006, 9206.355555111079, 9229.676961306322, 6430.903536447051, 6511.218653761579, 6536.607803531803, 6625.635590042594, 6747.460203183831, 11070.723231918944, 11237.831432528683, 11504.309741415207, 11575.42122893835, 11593.768124637292, 11551.711207219887, 11654.76690466169, 11691.941540292244, 11728.41357932083, 11839.822402663794, 7952.801179970547, 8394.328453723809, 8562.143785621389, 8562.357823163413, 8717.476951382938, 9375.671851485165, 9396.389234699722, 9396.530173491436, 9505.049495050716, 9520.23838092937, 8283.08886022549, 8519.787005324917, 8522.019967703793, 8667.523286219319, 8700.695475658322, 8272.545010024507, 8338.124496927736, 8504.319654427507, 8518.488890666333, 8520.74437766868, 7455.142658594331, 7549.1695913448375, 7574.431917606092, 7583.05211848519, 7628.885566716614, 5396.64921780083, 5448.291722076105, 5455.1544510600925, 5564.55483561306, 5572.275604171432, 5421.891562168814, 5490.258815060076, 5565.888682226414, 5635.8591035224445, 5671.744771485211], "value": 4972.410267301999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6287147009759, 341.53039570590437, 345.1199441424368, 352.7548353894045, 353.9964600353996, 5654.321481422225, 5724.8855022899625, 5856.297244330681, 5858.502027327677, 5902.114682797583, 5712.285964254468, 5728.541716662668, 5737.942620573793, 5747.4365893146205, 5751.971240143804, 4498.52765459627, 4501.099780043996, 4513.390692256553, 4515.674427669753, 4529.569690879362, 4436.97781511092, 4485.798139083733, 4490.281554951209, 4502.144592527409, 4539.092181563684, 4387.1445068211715, 4404.889877753066, 4411.09572537629, 4435.8225670973125, 4444.466664000308, 4411.6250118739945, 4463.218936686083, 4466.9106617867465, 4523.705959112647, 4533.773311334453, 3927.842886284574, 4002.2995975704425, 4010.1177740896956, 4027.114034912344, 4046.4941882264716, 5561.610687251894, 5575.442455754433, 5578.693171875545, 5590.86022849428, 5604.859878503029, 5248.317718696545, 5251.264822924793, 5257.342832145981, 5258.843054527998, 5279.234510995884, 5927.261318419702, 6031.698415079229, 6055.303640081403, 6064.272287325505, 6085.513158947318, 4431.689781715281, 4451.399061126739, 4458.4426946631675, 4475.261581839025, 4480.910381792379, 6287.717052732638, 6293.685315734195, 6332.778352757678, 6340.492760579143, 6357.1735674362035, 4149.024979129962, 4360.520342762294, 4365.650747940157, 4369.934450983238, 4389.802458889358, 4399.274119770266, 4410.787033565731, 4416.895776055986, 4419.491758447755, 4439.644828413784, 5074.391073071255, 5079.339685840817, 5098.082345177903, 5117.462666420047, 5119.436861945183, 5920.851978700481, 6022.638641681513, 6022.759089636453, 6023.759049638053, 6034.456898879122, 1497.9925100374646, 1505.728968785607, 1525.3669727063145, 1529.4341093795144, 1533.8159420869567, 930.6361840923977, 930.8364544319601, 939.6335429182624, 957.305953183936, 988.6885631026204, 5145.919356935011, 5198.4801519847715, 5214.7914083437, 5234.345706786652, 5255.474452554714, 5421.241026256248, 5510.889782204334, 5514.222757411186, 5523.287780787969, 5559.583031272671, 4909.656324057353, 5183.45573714762, 5194.545527252375, 5220.712860792617, 5281.920771188358, 2922.2694326418396, 2935.471615109258, 2965.4431423502833, 2986.522156454957, 2988.551717242431, 5650.265465489542, 5696.743646535916, 5724.398938111522, 5729.8567535811935, 5739.741711622987, 5277.208418737144, 5584.0, 5667.914981275284, 5681.318241811009, 5696.629719068247, 5615.691136987423, 5674.886502269931, 5706.686132262766, 5715.571332150105, 5729.942700572941, 5129.076766182123, 5476.151196564539, 5519.69641669712, 5534.225208470737, 5619.325680918316, 5441.401445841034, 5459.918101228405, 5460.798624302806, 5502.477264659851, 5526.778928842801, 5559.916601250903, 5651.463111004448, 5687.971560142173, 5706.2011318414625, 5756.30924289088, 3931.8820435386983, 3950.30869597825, 3960.5445373782386, 4283.892902677458, 4297.72064815786, 6076.696165191811, 6154.507639388748, 6181.598196117238, 6230.283517395376, 6295.685215739103, 6101.176341194059, 6101.359357267423, 6110.816675499742, 6119.724612392364, 6138.386161383826, 6040.818775436744, 6068.7269072892705, 6087.604305720114, 6149.96925015372, 6160.784372546939, 5698.800541981011, 6013.7293821779, 6023.397660234117, 6044.486218671462, 6051.7579296827635, 6113.877722445437, 6117.541184411276, 6142.877142457037, 6172.598781079216, 6189.442950134509, 5799.9130013049, 6014.849628759316, 6028.728707208098, 6048.697565121638, 6051.184644606512], "value": 4449.239949828017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.9435245180387, 757.9956557561233, 817.546261824687, 854.4275335525198, 900.1628485508479, 15072.095674259552, 16031.919840400811, 16128.354865805353, 16165.434209802645, 16189.514314570568, 15417.383304667828, 15452.381904723798, 15588.376464941388, 15618.76571851423, 15683.137427441487, 722.072137303565, 853.9615717292705, 877.5831480046991, 881.5812489067706, 884.2483888694622, 871.7297637732291, 878.1043335797483, 881.7927786970057, 884.8363052835214, 885.2829208341232, 931.7577429868215, 932.1051790281305, 932.7061975477736, 934.1965909318016, 938.2775263047449, 924.5700749151677, 924.7872989212451, 925.7315378540216, 926.3932124458457, 926.7080869526111, 674.865026994603, 675.1290834823072, 679.7179170644176, 679.8266442057293, 681.1281559603666, 15072.246387680681, 15141.394344226217, 15163.166025868573, 15167.317470713733, 15191.468298609607, 15217.695646087017, 15682.529524114294, 15867.04797712141, 15908.363665453484, 16251.51245462638, 12406.627801165889, 12649.810252846215, 12684.112112152154, 12716.554920577735, 12945.223286602833, 4162.500499939996, 4196.349565817303, 4237.7669228192435, 4245.341971994346, 4281.165172791307, 78825.21174788293, 80113.99999999942, 80822.19177808205, 81487.18512814856, 81813.0, 12798.552050678181, 12816.679583010313, 12886.420111094836, 12888.871111288767, 13075.869241307466, 24443.63334549983, 24456.0, 24481.755182448305, 24524.754752452605, 24728.381790455383, 9490.240780737524, 9507.809843803223, 9601.519924003773, 9707.757306067404, 9758.902410975941, 5011.774470148852, 5064.164412871834, 5115.335006449138, 5274.815381461631, 5292.9735351323, 3828.349180639298, 4034.677225821927, 4035.899102522402, 4058.8782336529953, 4068.3897415387337, 667.5327270910285, 667.6061123936901, 675.4562577125363, 676.5636164673758, 680.6086500262369, 625.2902955145942, 727.3017902813252, 743.1194035068353, 745.8843879198732, 771.2441807029143, 10240.180785537139, 10359.63741269052, 10378.325408848552, 10395.636152734769, 10428.895711042793, 617.3178637605381, 737.6311844077961, 761.8590560746279, 762.6682393158883, 772.2470591173673, 4915.0, 5018.89962200754, 5025.170846810309, 5043.646944713835, 5046.091703493406, 102688.48655756674, 122229.0, 123337.0, 124820.37589812174, 128106.0, 62479.6876015617, 100668.49665751624, 101073.4838977416, 104826.0, 107089.76927551113, 91004.5449772747, 91747.54126229326, 92487.0, 92970.0, 94450.52774736083, 8642.0, 8703.0, 8774.986063550232, 8935.731928042169, 8969.416987895765, 40159.19681606293, 44401.0, 54645.18032229599, 56676.86646267134, 57564.71217643885, 75284.62357688177, 79320.0, 81213.59393202997, 81778.0, 83537.16462835294, 11992.520299188283, 12421.254724716546, 12496.0, 12560.811587826007, 12835.294058826854, 13250.138740981805, 13683.657908551968, 13699.863001369858, 13700.383482743102, 14216.147031178163, 12787.0, 13033.283169425773, 13110.672233193865, 13169.144005639602, 13536.255505947267, 12259.203151795105, 12355.0, 12550.686232843887, 12674.112812103065, 12749.745005099661, 12700.237985720887, 12745.642056219629, 12817.807732883828, 12963.481460741465, 13077.803832942704, 10602.575896964343, 10719.517621706886, 10735.302205356627, 10772.192085593768, 10967.890321096687, 11021.0, 11145.777084458428, 11265.774684506428, 11409.885901140882, 11510.884891151316], "value": 7863.057691781063, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 111.0, 112.0, 111.0, 113.0, 113.0, 112.0, 110.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 149.0, 177.0, 127.0, 157.0, 155.0, 123.0, 181.0, 129.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 182.0, 77.0, 76.0, 75.0, 75.0, 164.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 161.0, 84.0, 85.0, 84.0, 148.0, 86.0, 84.0, 140.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 149.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 62.0, 69.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 78.0, 77.0, 80.0, 83.0, 79.0, 78.0, 102.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 126.0, 118.0, 124.0, 133.0, 118.0, 118.0, 134.0, 138.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 156.0, 152.0, 162.0, 159.0, 154.0, 151.0, 154.0, 155.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 65.0, 60.0, 61.0, 61.0, 61.0, 63.0, 61.0], "value": 61.8, "unit": "score"}]}]} 10:53:40 INFO - Return code: 0 10:53:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:53:40 ERROR - # TBPL SUCCESS # 10:53:40 INFO - Running post-action listener: _resource_record_post_action 10:53:40 INFO - ##### 10:53:40 INFO - ##### Finished run-tests step (success) 10:53:40 INFO - ##### 10:53:40 INFO - Running post-run listener: _resource_record_post_run 10:53:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 16384; Write bytes: 514351104; Read time: 388; Write time: 509996 10:53:40 INFO - TinderboxPrint: CPU usage
13.4% 10:53:40 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 388 10:53:40 INFO - TinderboxPrint: I/O write bytes / time
514,351,104 / 509,996 10:53:40 INFO - TinderboxPrint: CPU idle
8,203.2 (86.5%) 10:53:40 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 10:53:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:53:40 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 260308992; Read time: 208; Write time: 299800 10:53:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 253456384; Read time: 180; Write time: 210176 10:53:40 INFO - Running post-run listener: _upload_blobber_files 10:53:40 INFO - Blob upload gear active. 10:53:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:53:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:53:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:41 INFO - (blobuploader) - INFO - Done attempting. 10:53:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:53:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:53:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:42 INFO - (blobuploader) - INFO - Done attempting. 10:53:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:53:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:53:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:47 INFO - (blobuploader) - INFO - Done attempting. 10:53:47 INFO - (blobuploader) - INFO - Iteration through files over. 10:53:47 INFO - Return code: 0 10:53:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:53:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:53:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c01799deaf91a83c8c8b927b176f28426e22dcb4b61f602318e75d1ae1f839a3aca13f3c7d80d3a8980c6f774748d65b92356bfa90110930a5d668844ca5801e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee06ec51870843305c386a8549fe7002a9cd953ffed0c34670fe9332c81ebde319e1a70d5b383cfedd48f316bbc9e9418a35f43ee7a4231c19771b7d999e857", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/628e2c1db2715d7510827f98fe992b63f65432fb476e124ae49708c8f3371cfb80e8c503b5246d9a0b429d28d90260312de051c7e6c058e78f4815100099b5dc"} 10:53:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:53:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:53:47 INFO - Contents: 10:53:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c01799deaf91a83c8c8b927b176f28426e22dcb4b61f602318e75d1ae1f839a3aca13f3c7d80d3a8980c6f774748d65b92356bfa90110930a5d668844ca5801e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee06ec51870843305c386a8549fe7002a9cd953ffed0c34670fe9332c81ebde319e1a70d5b383cfedd48f316bbc9e9418a35f43ee7a4231c19771b7d999e857", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/628e2c1db2715d7510827f98fe992b63f65432fb476e124ae49708c8f3371cfb80e8c503b5246d9a0b429d28d90260312de051c7e6c058e78f4815100099b5dc"} 10:53:47 INFO - Running post-run listener: copy_logs_to_upload_dir 10:53:47 INFO - Copying logs to upload dir... 10:53:47 INFO - mkdir: /builds/slave/test/build/upload/logs 10:53:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.950229 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-27 10:53:47.578726) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 10:53:47.582635) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 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/c01799deaf91a83c8c8b927b176f28426e22dcb4b61f602318e75d1ae1f839a3aca13f3c7d80d3a8980c6f774748d65b92356bfa90110930a5d668844ca5801e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee06ec51870843305c386a8549fe7002a9cd953ffed0c34670fe9332c81ebde319e1a70d5b383cfedd48f316bbc9e9418a35f43ee7a4231c19771b7d999e857", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/628e2c1db2715d7510827f98fe992b63f65432fb476e124ae49708c8f3371cfb80e8c503b5246d9a0b429d28d90260312de051c7e6c058e78f4815100099b5dc"} build_url:https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/OKkLhVPpQFmmfLYG1Q96CQ/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/c01799deaf91a83c8c8b927b176f28426e22dcb4b61f602318e75d1ae1f839a3aca13f3c7d80d3a8980c6f774748d65b92356bfa90110930a5d668844ca5801e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ee06ec51870843305c386a8549fe7002a9cd953ffed0c34670fe9332c81ebde319e1a70d5b383cfedd48f316bbc9e9418a35f43ee7a4231c19771b7d999e857", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/628e2c1db2715d7510827f98fe992b63f65432fb476e124ae49708c8f3371cfb80e8c503b5246d9a0b429d28d90260312de051c7e6c058e78f4815100099b5dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 10:53:47.609540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:53:47.609962) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467048793.916494-1016030883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 10:53:47.692705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 10:53:47.693078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 10:53:47.693537) ========= ========= Total master_lag: 0.32 =========