builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1467109331.98 results: success (0) buildid: 20160628004053 builduid: cdd86cf749d247ecb5164a648207dfd3 revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:11.981216) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:11.981690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:11.981965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:11.997975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:11.998343) ========= 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=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 03:22:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.9M=0s 2016-06-28 03:22:12 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125804 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:12.322759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:12.323050) ========= 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=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017289 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:12.358190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 03:22:12.358648) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20f82876561686c4f8a619a0e1baa9f58261e0f --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 f20f82876561686c4f8a619a0e1baa9f58261e0f --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=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 03:22:13,177 truncating revision to first 12 chars 2016-06-28 03:22:13,177 Setting DEBUG logging. 2016-06-28 03:22:13,177 attempt 1/10 2016-06-28 03:22:13,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f20f82876561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 03:22:14,238 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=1.398836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 03:22:13.776263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:13.776628) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:13.777054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:13.777346) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 03:22:13.789033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 03:22:13.789346) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:14 INFO - MultiFileLogger online at 20160628 03:22:14 in /builds/slave/test 03:22:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:22:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:14 INFO - {'append_to_log': False, 03:22:14 INFO - 'base_work_dir': '/builds/slave/test', 03:22:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:22:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:14 INFO - 'branch': 'Mozilla-Aurora', 03:22:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:14 INFO - 'config_files': ('talos/linux_config.py',), 03:22:14 INFO - 'default_actions': ('clobber', 03:22:14 INFO - 'read-buildbot-config', 03:22:14 INFO - 'download-and-extract', 03:22:14 INFO - 'populate-webroot', 03:22:14 INFO - 'create-virtualenv', 03:22:14 INFO - 'install', 03:22:14 INFO - 'run-tests'), 03:22:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:14 INFO - 'download_minidump_stackwalk': True, 03:22:14 INFO - 'download_symbols': 'ondemand', 03:22:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:14 INFO - 'installer_path': 'installer.exe', 03:22:14 INFO - 'log_level': 'info', 03:22:14 INFO - 'log_name': 'talos', 03:22:14 INFO - 'log_to_console': True, 03:22:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:14 INFO - 'opt_config_files': (), 03:22:14 INFO - 'pip_index': False, 03:22:14 INFO - 'sps_profile': False, 03:22:14 INFO - 'sps_profile_interval': 0, 03:22:14 INFO - 'suite': 'dromaeojs', 03:22:14 INFO - 'system_bits': '32', 03:22:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:14 INFO - 'title': 'talos-linux64-ix-054', 03:22:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:14 INFO - 'use_talos_json': True, 03:22:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:14 INFO - 'work_dir': 'build'} 03:22:14 INFO - ##### 03:22:14 INFO - ##### Running clobber step. 03:22:14 INFO - ##### 03:22:14 INFO - Running pre-action listener: _resource_record_pre_action 03:22:14 INFO - Running main action method: clobber 03:22:14 INFO - rmtree: /builds/slave/test/build 03:22:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:15 INFO - Running post-action listener: _resource_record_post_action 03:22:15 INFO - ##### 03:22:15 INFO - ##### Finished clobber step (success) 03:22:15 INFO - ##### 03:22:15 INFO - ##### 03:22:15 INFO - ##### Running read-buildbot-config step. 03:22:15 INFO - ##### 03:22:15 INFO - Running pre-action listener: _resource_record_pre_action 03:22:15 INFO - Running main action method: read_buildbot_config 03:22:15 INFO - Using buildbot properties: 03:22:15 INFO - { 03:22:15 INFO - "project": "", 03:22:15 INFO - "product": "firefox", 03:22:15 INFO - "script_repo_revision": "production", 03:22:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:22:15 INFO - "repository": "", 03:22:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:22:15 INFO - "buildid": "20160628004053", 03:22:15 INFO - "stage_platform": "linux64-pgo", 03:22:15 INFO - "basedir": "/builds/slave/test", 03:22:15 INFO - "nightly_build": "True", 03:22:15 INFO - "buildnumber": 395, 03:22:15 INFO - "slavename": "talos-linux64-ix-054", 03:22:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:22:15 INFO - "platform": "ubuntu64_hw", 03:22:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:22:15 INFO - "branch": "mozilla-aurora", 03:22:15 INFO - "repo_path": "releases/mozilla-aurora", 03:22:15 INFO - "revision": "f20f82876561686c4f8a619a0e1baa9f58261e0f", 03:22:15 INFO - "pgo_build": "True", 03:22:15 INFO - "builduid": "cdd86cf749d247ecb5164a648207dfd3", 03:22:15 INFO - "slavebuilddir": "test" 03:22:15 INFO - } 03:22:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:22:15 INFO - Running post-action listener: _resource_record_post_action 03:22:15 INFO - ##### 03:22:15 INFO - ##### Finished read-buildbot-config step (success) 03:22:15 INFO - ##### 03:22:15 INFO - ##### 03:22:15 INFO - ##### Running download-and-extract step. 03:22:15 INFO - ##### 03:22:15 INFO - Running pre-action listener: _resource_record_pre_action 03:22:15 INFO - Running main action method: download_and_extract 03:22:15 INFO - mkdir: /builds/slave/test/build/tests 03:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:15 INFO - https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:16 INFO - Downloaded 1361 bytes. 03:22:16 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:22:16 INFO - Using the following test package requirements: 03:22:16 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:16 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:22:16 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:22:16 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'jsshell-linux-x86_64.zip'], 03:22:16 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:22:16 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:16 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:22:16 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:22:16 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:22:16 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:16 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:22:16 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:16 INFO - https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:22:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:22:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:17 INFO - Downloaded 24524434 bytes. 03:22:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:22:19 INFO - Return code: 0 03:22:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:22: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')]} 03:22:19 INFO - https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:27 INFO - Downloaded 24524434 bytes. 03:22:27 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'] 03:22:27 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 03:22:28 INFO - Return code: 0 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:29 INFO - Downloaded 10833369 bytes. 03:22:29 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'] 03:22:29 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 03:22:29 INFO - Return code: 0 03:22: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')]} 03:22:29 INFO - https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WV1NWfaCRXSxrQrjoXZb8w/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 03:22:31 INFO - Downloaded 63599844 bytes. 03:22:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:31 INFO - mkdir: /builds/slave/test/properties 03:22:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:31 INFO - Contents: 03:22:31 INFO - build_url:https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:22:32 INFO - Running post-action listener: _resource_record_post_action 03:22:32 INFO - Running post-action listener: set_extra_try_arguments 03:22:32 INFO - ##### 03:22:32 INFO - ##### Finished download-and-extract step (success) 03:22:32 INFO - ##### 03:22:32 INFO - ##### 03:22:32 INFO - ##### Running populate-webroot step. 03:22:32 INFO - ##### 03:22:32 INFO - Running pre-action listener: _resource_record_pre_action 03:22:32 INFO - Running main action method: populate_webroot 03:22:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:32 INFO - '--tppagecycles', 03:22:32 INFO - '7'], 03:22:32 INFO - 'tests': ['tsvgm']}}, 03:22:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['damp', 'tps']}, 03:22:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'tests': ['damp', 'tps']}, 03:22:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['dromaeo_dom']}, 03:22:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['a11yr', 03:22:32 INFO - 'ts_paint', 03:22:32 INFO - 'tpaint', 03:22:32 INFO - 'sessionrestore', 03:22:32 INFO - 'sessionrestore_no_auto_restore', 03:22:32 INFO - 'tabpaint']}, 03:22:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['tsvgx', 03:22:32 INFO - 'tsvgr_opacity', 03:22:32 INFO - 'tart', 03:22:32 INFO - 'tscrollx', 03:22:32 INFO - 'cart']}, 03:22:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:32 INFO - 'tsvgr_opacity', 03:22:32 INFO - 'tart', 03:22:32 INFO - 'tscrollx', 03:22:32 INFO - 'cart']}, 03:22:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'talos_options': ['--disable-e10s'], 03:22:32 INFO - 'tests': ['tp5o']}, 03:22:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'tests': ['tp5o']}, 03:22:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'talos_options': ['--disable-e10s', 03:22:32 INFO - '--xperf_path', 03:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:32 INFO - 'tests': ['tp5n']}, 03:22:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:32 INFO - 'talos_options': ['--xperf_path', 03:22:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:32 INFO - 'tests': ['tp5n']}}, 03:22:32 INFO - 'talos.zip': {'path': '', 03:22:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:32 INFO - Running post-action listener: _resource_record_post_action 03:22:32 INFO - ##### 03:22:32 INFO - ##### Finished populate-webroot step (success) 03:22:32 INFO - ##### 03:22:32 INFO - ##### 03:22:32 INFO - ##### Running create-virtualenv step. 03:22:32 INFO - ##### 03:22:32 INFO - Running pre-action listener: _resource_record_pre_action 03:22:32 INFO - Running main action method: create_virtualenv 03:22:32 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:32 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 03:22:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:32 INFO - Using real prefix '/usr' 03:22:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:34 INFO - Installing pip.................done. 03:22:34 INFO - Return code: 0 03:22:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:22:34 INFO - Using env: {'DISPLAY': ':0', 03:22:34 INFO - 'HOME': '/home/cltbld', 03:22:34 INFO - 'LANG': 'en_US.UTF-8', 03:22:34 INFO - 'LANGUAGE': 'en_US:en', 03:22:34 INFO - 'LOGNAME': 'cltbld', 03:22:34 INFO - 'MAIL': '/var/mail/cltbld', 03:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:34 INFO - 'MOZ_NO_REMOTE': '1', 03:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:34 INFO - 'NO_EM_RESTART': '1', 03:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:34 INFO - 'PWD': '/builds/slave/test', 03:22:34 INFO - 'SHELL': '/bin/bash', 03:22:34 INFO - 'SHLVL': '1', 03:22:34 INFO - 'TERM': 'linux', 03:22:34 INFO - 'TMOUT': '86400', 03:22:34 INFO - 'USER': 'cltbld', 03:22:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:34 INFO - '_': '/tools/buildbot/bin/python'} 03:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:35 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 03:22:35 INFO - Cleaning up... 03:22:35 INFO - Return code: 0 03:22:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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', '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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:22: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 psutil>=3.1.1 03:22:35 INFO - Using env: {'DISPLAY': ':0', 03:22:35 INFO - 'HOME': '/home/cltbld', 03:22:35 INFO - 'LANG': 'en_US.UTF-8', 03:22:35 INFO - 'LANGUAGE': 'en_US:en', 03:22:35 INFO - 'LOGNAME': 'cltbld', 03:22:35 INFO - 'MAIL': '/var/mail/cltbld', 03:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:35 INFO - 'MOZ_NO_REMOTE': '1', 03:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:35 INFO - 'NO_EM_RESTART': '1', 03:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:35 INFO - 'PWD': '/builds/slave/test', 03:22:35 INFO - 'SHELL': '/bin/bash', 03:22:35 INFO - 'SHLVL': '1', 03:22:35 INFO - 'TERM': 'linux', 03:22:35 INFO - 'TMOUT': '86400', 03:22:35 INFO - 'USER': 'cltbld', 03:22:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:35 INFO - '_': '/tools/buildbot/bin/python'} 03:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:35 INFO - Downloading/unpacking psutil>=3.1.1 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:37 INFO - Installing collected packages: psutil 03:22:37 INFO - Running setup.py install for psutil 03:22:37 INFO - building 'psutil._psutil_linux' extension 03:22:37 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 03:22:37 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 03:22:37 INFO - building 'psutil._psutil_posix' extension 03:22:37 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 03:22:37 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 03:22:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:37 INFO - Successfully installed psutil 03:22:37 INFO - Cleaning up... 03:22:37 INFO - Return code: 0 03:22:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:22: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 mozsystemmonitor==0.3 03:22:37 INFO - Using env: {'DISPLAY': ':0', 03:22:37 INFO - 'HOME': '/home/cltbld', 03:22:37 INFO - 'LANG': 'en_US.UTF-8', 03:22:37 INFO - 'LANGUAGE': 'en_US:en', 03:22:37 INFO - 'LOGNAME': 'cltbld', 03:22:37 INFO - 'MAIL': '/var/mail/cltbld', 03:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:37 INFO - 'MOZ_NO_REMOTE': '1', 03:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:37 INFO - 'NO_EM_RESTART': '1', 03:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:37 INFO - 'PWD': '/builds/slave/test', 03:22:37 INFO - 'SHELL': '/bin/bash', 03:22:37 INFO - 'SHLVL': '1', 03:22:37 INFO - 'TERM': 'linux', 03:22:37 INFO - 'TMOUT': '86400', 03:22:37 INFO - 'USER': 'cltbld', 03:22:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:37 INFO - '_': '/tools/buildbot/bin/python'} 03:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22: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 03:22: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 03:22: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 03:22: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 03:22:38 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 03:22:38 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 03:22:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:39 INFO - Installing collected packages: mozsystemmonitor 03:22:39 INFO - Running setup.py install for mozsystemmonitor 03:22:40 INFO - Successfully installed mozsystemmonitor 03:22:40 INFO - Cleaning up... 03:22:40 INFO - Return code: 0 03:22:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22:40 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')]} 03:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:40 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')]} 03:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:40 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:40 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 03:22:40 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 03:22:40 INFO - Using env: {'DISPLAY': ':0', 03:22:40 INFO - 'HOME': '/home/cltbld', 03:22:40 INFO - 'LANG': 'en_US.UTF-8', 03:22:40 INFO - 'LANGUAGE': 'en_US:en', 03:22:40 INFO - 'LOGNAME': 'cltbld', 03:22:40 INFO - 'MAIL': '/var/mail/cltbld', 03:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:40 INFO - 'MOZ_NO_REMOTE': '1', 03:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:40 INFO - 'NO_EM_RESTART': '1', 03:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:40 INFO - 'PWD': '/builds/slave/test', 03:22:40 INFO - 'SHELL': '/bin/bash', 03:22:40 INFO - 'SHLVL': '1', 03:22:40 INFO - 'TERM': 'linux', 03:22:40 INFO - 'TMOUT': '86400', 03:22:40 INFO - 'USER': 'cltbld', 03:22:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:40 INFO - '_': '/tools/buildbot/bin/python'} 03:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:42 INFO - warning: no files found matching '*.txt' 03:22:42 INFO - no previously-included directories found matching 'build' 03:22:42 INFO - no previously-included directories found matching 'dist' 03:22:42 INFO - no previously-included directories found matching '.git*' 03:22:42 INFO - Installing collected packages: jsonschema, functools32 03:22:42 INFO - Running setup.py install for functools32 03:22:42 INFO - warning: no files found matching '*.txt' 03:22:42 INFO - no previously-included directories found matching 'build' 03:22:42 INFO - no previously-included directories found matching 'dist' 03:22:42 INFO - no previously-included directories found matching '.git*' 03:22:42 INFO - Successfully installed jsonschema functools32 03:22:42 INFO - Cleaning up... 03:22:42 INFO - Return code: 0 03:22:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:42 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:42 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 03:22:42 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 03:22:42 INFO - Using env: {'DISPLAY': ':0', 03:22:42 INFO - 'HOME': '/home/cltbld', 03:22:42 INFO - 'LANG': 'en_US.UTF-8', 03:22:42 INFO - 'LANGUAGE': 'en_US:en', 03:22:42 INFO - 'LOGNAME': 'cltbld', 03:22:42 INFO - 'MAIL': '/var/mail/cltbld', 03:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:42 INFO - 'MOZ_NO_REMOTE': '1', 03:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:42 INFO - 'NO_EM_RESTART': '1', 03:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:42 INFO - 'PWD': '/builds/slave/test', 03:22:42 INFO - 'SHELL': '/bin/bash', 03:22:42 INFO - 'SHLVL': '1', 03:22:42 INFO - 'TERM': 'linux', 03:22:42 INFO - 'TMOUT': '86400', 03:22:42 INFO - 'USER': 'cltbld', 03:22:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:42 INFO - '_': '/tools/buildbot/bin/python'} 03:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:44 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 03:22:44 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 03:22:44 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 03:22:44 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 03:22:44 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 03:22:44 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 03:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:45 INFO - Downloading docopt-0.6.1.tar.gz 03:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:45 INFO - Running setup.py install for blobuploader 03:22:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:45 INFO - Running setup.py install for requests 03:22:45 INFO - Running setup.py install for docopt 03:22:46 INFO - Successfully installed blobuploader requests docopt 03:22:46 INFO - Cleaning up... 03:22:46 INFO - Return code: 0 03:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:46 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:46 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 03:22:46 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 03:22:46 INFO - Using env: {'DISPLAY': ':0', 03:22:46 INFO - 'HOME': '/home/cltbld', 03:22:46 INFO - 'LANG': 'en_US.UTF-8', 03:22:46 INFO - 'LANGUAGE': 'en_US:en', 03:22:46 INFO - 'LOGNAME': 'cltbld', 03:22:46 INFO - 'MAIL': '/var/mail/cltbld', 03:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:46 INFO - 'MOZ_NO_REMOTE': '1', 03:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:46 INFO - 'NO_EM_RESTART': '1', 03:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:46 INFO - 'PWD': '/builds/slave/test', 03:22:46 INFO - 'SHELL': '/bin/bash', 03:22:46 INFO - 'SHLVL': '1', 03:22:46 INFO - 'TERM': 'linux', 03:22:46 INFO - 'TMOUT': '86400', 03:22:46 INFO - 'USER': 'cltbld', 03:22:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:46 INFO - '_': '/tools/buildbot/bin/python'} 03:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:46 INFO - Running setup.py (path:/tmp/pip-dzSI0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:46 INFO - Running setup.py (path:/tmp/pip-VsWxhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:46 INFO - Running setup.py (path:/tmp/pip-ddNSNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:46 INFO - Running setup.py (path:/tmp/pip-8lJPkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:46 INFO - Running setup.py (path:/tmp/pip-JkfIob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:46 INFO - Running setup.py (path:/tmp/pip-Sj1OrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:46 INFO - Running setup.py (path:/tmp/pip-ZJMBUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:46 INFO - Running setup.py (path:/tmp/pip-UQ8IMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:46 INFO - Running setup.py (path:/tmp/pip-OFfIiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:46 INFO - Running setup.py (path:/tmp/pip-_7zVzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:47 INFO - Running setup.py (path:/tmp/pip-NMMlZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:47 INFO - Running setup.py (path:/tmp/pip-6osMnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:47 INFO - Running setup.py (path:/tmp/pip-69lkew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:47 INFO - Running setup.py (path:/tmp/pip-JFx8Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:47 INFO - Running setup.py (path:/tmp/pip-jZq1Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:47 INFO - Running setup.py (path:/tmp/pip-W7FRe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:47 INFO - Running setup.py (path:/tmp/pip-JTIgxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:47 INFO - Running setup.py install for manifestparser 03:22:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:22:47 INFO - Running setup.py install for mozcrash 03:22:47 INFO - Running setup.py install for mozdebug 03:22:47 INFO - Running setup.py install for mozdevice 03:22:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:22:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozfile 03:22:48 INFO - Running setup.py install for mozhttpd 03:22:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozinfo 03:22:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozInstall 03:22:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozleak 03:22:48 INFO - Running setup.py install for mozlog 03:22:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for moznetwork 03:22:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozprocess 03:22:48 INFO - Running setup.py install for mozprofile 03:22:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:22:48 INFO - Running setup.py install for mozrunner 03:22:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:22:49 INFO - Running setup.py install for mozscreenshot 03:22:49 INFO - Running setup.py install for moztest 03:22:49 INFO - Running setup.py install for mozversion 03:22:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:22:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:22:49 INFO - Cleaning up... 03:22:49 INFO - Return code: 0 03:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:49 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:49 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 03:22:49 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 03:22:49 INFO - Using env: {'DISPLAY': ':0', 03:22:49 INFO - 'HOME': '/home/cltbld', 03:22:49 INFO - 'LANG': 'en_US.UTF-8', 03:22:49 INFO - 'LANGUAGE': 'en_US:en', 03:22:49 INFO - 'LOGNAME': 'cltbld', 03:22:49 INFO - 'MAIL': '/var/mail/cltbld', 03:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:49 INFO - 'MOZ_NO_REMOTE': '1', 03:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:49 INFO - 'NO_EM_RESTART': '1', 03:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:49 INFO - 'PWD': '/builds/slave/test', 03:22:49 INFO - 'SHELL': '/bin/bash', 03:22:49 INFO - 'SHLVL': '1', 03:22:49 INFO - 'TERM': 'linux', 03:22:49 INFO - 'TMOUT': '86400', 03:22:49 INFO - 'USER': 'cltbld', 03:22:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:49 INFO - '_': '/tools/buildbot/bin/python'} 03:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:22:49 INFO - Running setup.py (path:/tmp/pip-T1NKQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:22:49 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)) 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:22:49 INFO - Running setup.py (path:/tmp/pip-JN5Ug5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:22:49 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)) 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:22:49 INFO - Running setup.py (path:/tmp/pip-an4JkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:22:49 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)) 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:22:49 INFO - Running setup.py (path:/tmp/pip-tFHABe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:22:49 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)) 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:22:49 INFO - Running setup.py (path:/tmp/pip-wUbkIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:22:49 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)) 03:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:22:49 INFO - Running setup.py (path:/tmp/pip-8j6TsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:22:50 INFO - Running setup.py (path:/tmp/pip-iaXlyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:22:50 INFO - Running setup.py (path:/tmp/pip-XDsHlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:22:50 INFO - Running setup.py (path:/tmp/pip-yTEbR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:22:50 INFO - Running setup.py (path:/tmp/pip-5aEiY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:22:50 INFO - Running setup.py (path:/tmp/pip-NAeUWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:22:50 INFO - Running setup.py (path:/tmp/pip-wmPo84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:22:50 INFO - Running setup.py (path:/tmp/pip-sk_vEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:22:50 INFO - Running setup.py (path:/tmp/pip-ljONhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:50 INFO - Running setup.py (path:/tmp/pip-k92PO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:22:50 INFO - Running setup.py (path:/tmp/pip-hecKAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:22:50 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)) 03:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:22:50 INFO - Running setup.py (path:/tmp/pip-SQIVbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:22:50 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)) 03:22:50 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)) 03:22:50 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)) 03:22:50 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)) 03:22:50 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)) 03:22:50 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)) 03:22:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:52 INFO - Downloading blessings-1.6.tar.gz 03:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:22:52 INFO - Installing collected packages: blessings 03:22:52 INFO - Running setup.py install for blessings 03:22:52 INFO - Successfully installed blessings 03:22:52 INFO - Cleaning up... 03:22:53 INFO - Return code: 0 03:22:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:53 INFO - Reading from file tmpfile_stdout 03:22:53 INFO - Current package versions: 03:22:53 INFO - argparse == 1.2.1 03:22:53 INFO - blessings == 1.6 03:22:53 INFO - blobuploader == 1.2.4 03:22:53 INFO - docopt == 0.6.1 03:22:53 INFO - functools32 == 3.2.3-2 03:22:53 INFO - jsonschema == 2.5.1 03:22:53 INFO - manifestparser == 1.1 03:22:53 INFO - mozInstall == 1.12 03:22:53 INFO - mozcrash == 0.17 03:22:53 INFO - mozdebug == 0.1 03:22:53 INFO - mozdevice == 0.48 03:22:53 INFO - mozfile == 1.2 03:22:53 INFO - mozhttpd == 0.7 03:22:53 INFO - mozinfo == 0.9 03:22:53 INFO - mozleak == 0.1 03:22:53 INFO - mozlog == 3.2 03:22:53 INFO - moznetwork == 0.27 03:22:53 INFO - mozprocess == 0.22 03:22:53 INFO - mozprofile == 0.28 03:22:53 INFO - mozrunner == 6.11 03:22:53 INFO - mozscreenshot == 0.1 03:22:53 INFO - mozsystemmonitor == 0.3 03:22:53 INFO - moztest == 0.7 03:22:53 INFO - mozversion == 1.4 03:22:53 INFO - psutil == 3.1.1 03:22:53 INFO - requests == 1.2.3 03:22:53 INFO - wsgiref == 0.1.2 03:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:22:53 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')]} 03:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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')]} 03:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:53 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 03:22:53 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 03:22:53 INFO - Using env: {'DISPLAY': ':0', 03:22:53 INFO - 'HOME': '/home/cltbld', 03:22:53 INFO - 'LANG': 'en_US.UTF-8', 03:22:53 INFO - 'LANGUAGE': 'en_US:en', 03:22:53 INFO - 'LOGNAME': 'cltbld', 03:22:53 INFO - 'MAIL': '/var/mail/cltbld', 03:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:53 INFO - 'MOZ_NO_REMOTE': '1', 03:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:53 INFO - 'NO_EM_RESTART': '1', 03:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:53 INFO - 'PWD': '/builds/slave/test', 03:22:53 INFO - 'SHELL': '/bin/bash', 03:22:53 INFO - 'SHLVL': '1', 03:22:53 INFO - 'TERM': 'linux', 03:22:53 INFO - 'TMOUT': '86400', 03:22:53 INFO - 'USER': 'cltbld', 03:22:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:53 INFO - '_': '/tools/buildbot/bin/python'} 03:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 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)) 03:22:53 INFO - Cleaning up... 03:22:53 INFO - Return code: 0 03:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:22:53 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')]} 03:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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')]} 03:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:53 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 03:22:53 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 03:22:53 INFO - Using env: {'DISPLAY': ':0', 03:22:53 INFO - 'HOME': '/home/cltbld', 03:22:53 INFO - 'LANG': 'en_US.UTF-8', 03:22:53 INFO - 'LANGUAGE': 'en_US:en', 03:22:53 INFO - 'LOGNAME': 'cltbld', 03:22:53 INFO - 'MAIL': '/var/mail/cltbld', 03:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:53 INFO - 'MOZ_NO_REMOTE': '1', 03:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:53 INFO - 'NO_EM_RESTART': '1', 03:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:53 INFO - 'PWD': '/builds/slave/test', 03:22:53 INFO - 'SHELL': '/bin/bash', 03:22:53 INFO - 'SHLVL': '1', 03:22:53 INFO - 'TERM': 'linux', 03:22:53 INFO - 'TMOUT': '86400', 03:22:53 INFO - 'USER': 'cltbld', 03:22:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:53 INFO - '_': '/tools/buildbot/bin/python'} 03:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:22:53 INFO - Cleaning up... 03:22:53 INFO - Return code: 0 03:22:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:22:53 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')]} 03:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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')]} 03:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:53 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 0x7f43a1c1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2013350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, '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': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', '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 03:22:53 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 03:22:53 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 03:22:53 INFO - Using env: {'DISPLAY': ':0', 03:22:53 INFO - 'HOME': '/home/cltbld', 03:22:53 INFO - 'LANG': 'en_US.UTF-8', 03:22:53 INFO - 'LANGUAGE': 'en_US:en', 03:22:53 INFO - 'LOGNAME': 'cltbld', 03:22:53 INFO - 'MAIL': '/var/mail/cltbld', 03:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:53 INFO - 'MOZ_NO_REMOTE': '1', 03:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:53 INFO - 'NO_EM_RESTART': '1', 03:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:53 INFO - 'PWD': '/builds/slave/test', 03:22:53 INFO - 'SHELL': '/bin/bash', 03:22:53 INFO - 'SHLVL': '1', 03:22:53 INFO - 'TERM': 'linux', 03:22:53 INFO - 'TMOUT': '86400', 03:22:53 INFO - 'USER': 'cltbld', 03:22:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:53 INFO - '_': '/tools/buildbot/bin/python'} 03:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:53 INFO - Downloading/unpacking flake8 03:22:53 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 03:22:53 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 03:22:53 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 03:22:53 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 03:22:53 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 03:22:53 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 03:22:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:55 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 03:22:55 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 03:22:55 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 03:22:55 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 03:22:55 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 03:22:55 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 03:22:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 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 03:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:56 INFO - no previously-included directories found matching 'docs/_build' 03:22:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:56 INFO - Running setup.py install for pep8 03:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:56 INFO - no previously-included directories found matching 'docs/_build' 03:22:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:22:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:56 INFO - Cleaning up... 03:22:56 INFO - Return code: 0 03:22:56 INFO - Running post-action listener: _resource_record_post_action 03:22:56 INFO - Running post-action listener: _start_resource_monitoring 03:22:56 INFO - Starting resource monitoring. 03:22:56 INFO - ##### 03:22:56 INFO - ##### Finished create-virtualenv step (success) 03:22:56 INFO - ##### 03:22:56 INFO - ##### 03:22:56 INFO - ##### Running install step. 03:22:56 INFO - ##### 03:22:56 INFO - Running pre-action listener: _resource_record_pre_action 03:22:56 INFO - Running main action method: install 03:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:22:57 INFO - Reading from file tmpfile_stdout 03:22:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:22:57 INFO - Reading from file tmpfile_stdout 03:22:57 INFO - Output received: 03:22:57 INFO - Usage: mozinstall [options] installer 03:22:57 INFO - Options: 03:22:57 INFO - -h, --help show this help message and exit 03:22:57 INFO - -d DEST, --destination=DEST 03:22:57 INFO - Directory to install application into. [default: 03:22:57 INFO - "/builds/slave/test"] 03:22:57 INFO - --app=APP Application being installed. [default: firefox] 03:22:57 INFO - mkdir: /builds/slave/test/build/application 03:22:57 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'] 03:22:57 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 03:23:12 INFO - Reading from file tmpfile_stdout 03:23:12 INFO - Output received: 03:23:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:12 INFO - Running post-action listener: _resource_record_post_action 03:23:12 INFO - ##### 03:23:12 INFO - ##### Finished install step (success) 03:23:12 INFO - ##### 03:23:12 INFO - ##### 03:23:12 INFO - ##### Running run-tests step. 03:23:12 INFO - ##### 03:23:12 INFO - Running pre-action listener: _resource_record_pre_action 03:23:12 INFO - Running main action method: run_tests 03:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:12 INFO - Python 2.7.3 03:23:12 INFO - Return code: 0 03:23:12 INFO - grabbing minidump binary from tooltool 03:23:12 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')]} 03:23:12 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 0x20a21c0>, '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 0x20a30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:12 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 03:23:12 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 03:23:12 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 03:23:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:13 INFO - Return code: 0 03:23:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:23:13 INFO - Return code: 0 03:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:23:13 INFO - Using env: {'DISPLAY': ':0', 03:23:13 INFO - 'HOME': '/home/cltbld', 03:23:13 INFO - 'LANG': 'en_US.UTF-8', 03:23:13 INFO - 'LANGUAGE': 'en_US:en', 03:23:13 INFO - 'LOGNAME': 'cltbld', 03:23:13 INFO - 'MAIL': '/var/mail/cltbld', 03:23:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:13 INFO - 'MOZ_NO_REMOTE': '1', 03:23:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:13 INFO - 'NO_EM_RESTART': '1', 03:23:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:13 INFO - 'PWD': '/builds/slave/test', 03:23:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:13 INFO - 'SHELL': '/bin/bash', 03:23:13 INFO - 'SHLVL': '1', 03:23:13 INFO - 'TERM': 'linux', 03:23:13 INFO - 'TMOUT': '86400', 03:23:13 INFO - 'USER': 'cltbld', 03:23:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819', 03:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:13 INFO - '_': '/tools/buildbot/bin/python'} 03:23:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:23:14 INFO - mozversion application_buildid: 20160628004053 03:23:14 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 03:23:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:23:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:14 INFO - mozversion application_name: Firefox 03:23:14 INFO - mozversion application_remotingname: firefox-dev 03:23:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:14 INFO - mozversion application_vendor: Mozilla 03:23:14 INFO - mozversion application_version: 49.0a2 03:23:14 INFO - mozversion platform_buildid: 20160628004053 03:23:14 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 03:23:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:14 INFO - mozversion platform_version: 49.0a2 03:23:14 INFO - using testdate: 1467109394 03:23:14 INFO - actual date: 1467109394 03:23:14 INFO - starting webserver on 'localhost:46719' 03:23:14 INFO - SUITE-START | Running 2 tests 03:23:14 INFO - TEST-START | dromaeo_css 03:23:14 INFO - operating with platform_type : linux_ 03:23:14 INFO - Initialising browser for dromaeo_css test... 03:23:14 INFO - TEST-INFO | started process 12088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkk1iGF/profile http://localhost:46719/getInfo.html) 03:23:18 INFO - PROCESS | 12088 | __metrics Screen width/height:1600/1200 03:23:18 INFO - PROCESS | 12088 | colorDepth:24 03:23:18 INFO - PROCESS | 12088 | Browser inner width/height: 1024/697 03:23:18 INFO - PROCESS | 12088 | __metrics 03:23:19 ERROR - PROCESS | 12088 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:23:20 INFO - TEST-INFO | 12088: exit 0 03:23:20 INFO - Browser initialized. 03:23:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:20 INFO - TEST-INFO | started process 12180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkk1iGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:32 INFO - PROCESS | 12180 | RSS: Main: 145895424 03:23:32 INFO - PROCESS | 12180 | 03:24:23 INFO - PROCESS | 12180 | 1467109463574 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] 03:26:31 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46719/tests/dromaeo/cssquery-ext.html) 03:26:32 INFO - PROCESS | 12180 | RSS: Main: 256847872 03:26:32 INFO - PROCESS | 12180 | 03:29:35 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-ext.html (next: http://localhost:46719/tests/dromaeo/cssquery-jquery.html) 03:29:35 INFO - PROCESS | 12180 | RSS: Main: 228483072 03:29:35 INFO - PROCESS | 12180 | 03:32:37 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46719/tests/dromaeo/cssquery-mootools.html) 03:32:38 INFO - PROCESS | 12180 | RSS: Main: 231809024 03:32:38 INFO - PROCESS | 12180 | 03:35:40 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46719/tests/dromaeo/cssquery-prototype.html) 03:35:40 INFO - PROCESS | 12180 | RSS: Main: 225796096 03:35:40 INFO - PROCESS | 12180 | 03:38:43 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46719/tests/dromaeo/cssquery-yui.html) 03:38:44 INFO - PROCESS | 12180 | RSS: Main: 190324736 03:38:44 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | Cycle 1(1): loaded http://localhost:46719/tests/dromaeo/cssquery-yui.html (next: http://localhost:46719/tests/dromaeo/cssquery-dojo.html) 03:41:46 INFO - PROCESS | 12180 | RSS: Main: 261095424 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | __start_tp_report 03:41:46 INFO - PROCESS | 12180 | _x_x_mozilla_page_load 03:41:46 INFO - PROCESS | 12180 | _x_x_mozilla_page_load_details 03:41:46 INFO - PROCESS | 12180 | |i|pagename|runs| 03:41:46 INFO - PROCESS | 12180 | |0;dojo.html;3412.641672624374;3434.879779207728;3443.208062145706;3445.7932524048574;3484.303139372126;5673.574481913853;5752.079667253241;5756.539476841853;5760.308762948447;5769.076947688371;5673.886522269552;5724.685142317181;5728.198052272685;5731.426857314266;5742.569307301948;5031.622628302874;5115.53960143587;5139.203423469359;5194.662346947455;5211.42674305826;5175.094358487268;5258.763355649005;5259.211118332242;5270.367555893298;5275.762590683428;5156.381234251876;5185.222216667511;5198.480151984809;5204.869878253036;5225.947740522584;5291.126964050927;5303.946960530422;5305.416404195574;5309.41596424393;5343.118385466432;5002.7498625068965;5036.571891389236;5047.470015648378;5216.400113986902;5221.947780522184;5528.308961379827;5562.527185189264;5569.387367389584;5599.832005039855;5619.943800561983;6111.991521398963;6123.743997921446;6124.081387791823;6131.14164017038;6132.202813634243;6077.483413909823;6080.908786368208;6093.512518998514;6124;6143.559292432815;5712.57155713319;5733.140028995684;5753.424657534255;5763.942360576424;5812.505936995402;6065.551746271787;6286.05709143623;6289.24529056507;6293.402126797947;6301.023341382093;5909.143174239797;5926.2295901532525;5943.31651860033;5989.790357337472;5995.880082398327;6065.920924786332;6066.787662431793;6067.484263837535;6100.0849872519475;6109.358517355702;5859.150423188614;5960.731767070492;6084.726187321493;6101.450869421773;6101.816945491642;5998.25021872266;6088.695565221721;6091.269047714302;6091.878162436727;6108.1143234230785;4609.700369476041;4617.815287388534;4618.468876079227;4619.584237418649;4621.95378046222;4081.2041651878194;4088.100617864065;4130.607592278729;4143.316352801814;4155.439015732898;5839.708014599253;5855.3266374367495;5861.472467477862;5867.530597552186;5887.234659494238;6146.877062458726;6187.566870319124;6188.0717892315615;6190.071489276645;6197.81406557804;5742.31092268922;5794.710264486759;5839.270091238595;5851.414858514115;5894.705264736832;5310.92033619496;5312.282841816383;5312.521873031368;5314.7608357624;5320.866978325573;6429.421352078241;6430.356964303626;6438.259600146043;6439.484841212692;6441.967790161019;6019.638821670714;6033.245844269466;6039.6678182698615;6048.12302216185;6126.632402055891;6250.718717657625;6251.154247380881;6298.496120310272;6308.810735677937;6311.400416960381;5917.763289468373;5988.431099045583;5989.221401217814;5995.467788928525;5995.670238136944;6085.756569737161;6118.969405152946;6129.754809807558;6148.780122736153;6180.289266734383;6004.579679422399;6008.03871380577;6012.549058820693;6034.728437220423;6080.452759251689;5753.280839895013;5900.0264956281735;5974.970125149346;6027.156198132353;6039.939600604113;5821.039528477923;5853.619514731528;5892.528597712087;5896.056630939029;5909.113632955091;6024.849378765566;6025.939740602538;6084.239470066242;6087.604305720114;6087.756489740361;5672.5745569081655;5859.414058594277;5898.469137777621;5901.527877769854;5903.763849446146 03:41:46 INFO - PROCESS | 12180 | |1;ext.html;602.6564858030921;649.110718315907;659.6767583883897;660.867826434713;662.681912681913;33906;36632;36648.633513664856;36650;36696.082597935034;47328.290075648896;48394.51605483944;48922.51077489224;52043.47956520434;52134.21798673023;9164.358494905358;9280.628774848998;9303.813923721522;9308.674196403128;9331.346805723602;8486.151384861527;9090.13643703847;9181.21959633432;11003;11338.773224535504;10977.341359518414;11288.887111128866;11301.756806751291;11326.490307936121;11448.828267575993;11156.665300041012;11233.943830280878;11237.269577477438;11246.212765106446;11249;8280.461769984931;10700.571977120906;11179.720506987309;11191.552337906474;11578.073754099652;46016.53983460156;46071;46395.768021160016;46469.6059118227;46480.3027954581;3743.2139250757373;3826.1773718650347;4283.014906571506;4349.717268377577;4370.104128653618;35634.109147271265;35722;35726.464103038474;36051.819740901126;37333.813330933444;4734.124187025377;4765.761711914391;4792.520747925215;4806;4849.078675051729;400643;404914;404943;405163;406840.9657951721;69201;69356.30643693499;69737;69748.6512567434;69834;40494.59505404908;41428;41535.7923210382;43740.562594374285;43748.12503749971;20275.391738247876;20400.897995509928;20424.795752042588;20534.897325513277;20557.588848222953;13986.16083035021;15203.695926081416;15349.07905525672;15351.769723454157;15366.462173823862;21875.78124218769;22522.66216006761;22522.66216006761;23198.768012319662;23208.535829283657;8263.669453221804;8316.334693224528;8358.79103022417;8452.408331416866;8486.278666313432;1039.859618951447;1143.6054561176381;1153.9076873850072;1167.733009684502;1194.4266751959108;34968.82515587406;35566.822165889;35574.64425355765;35700;35718.82140589332;1211.3398197982121;1212.0727643352843;1225.7671042501895;1237.1587320622064;1258.79229927061;18346.359111715174;19295.324663636988;19452.22191112368;19879.701804472945;20137.39587812368;683109;692997;693767;700667;702021;67745.3225467739;68899.65550172217;69014;69016.30983690098;69088;1369.9589012329645;1489.5531340597777;1498.9850101499064;1520.148716718641;1520.3310543360885;35099.64900351066;35741;36115.458268125476;36135.63864361323;36261;56839.147412788014;57173;57653.811156996075;57742.42257577371;57750;508699;513467;513941;514750;515596;28565.857170714015;30907.536386953765;31800.5229921556;31905.6809431912;33128;53074;54247.18629220486;54439.455605443436;54482.18276725773;55630.44369556253;44209;44891;45147.774261128485;45212;46151;43686.781566091966;44122;44272.55727442813;45047;45301.773491132335;45413.54586454093;46173.53826461827;47405.52594474011;47433.762831185624;48937.51062489329;39882.40176397414;40191.79904100461;40726.79636601798;41169.38245926254;41715.58284417117;30082.84958575193;30513.847430762704;30668.38663226678;30809.229769255948;30952.53571196479 03:41:46 INFO - PROCESS | 12180 | |2;jquery.html;417.93730940358944;433.5794279548837;434.9021470169212;439.15462734236587;443.1646346636591;19956.401307960765;20192.495187620316;20641.483962900915;21341.57316853662;21396.4650883728;19412.805871941277;19548.609027819435;19813.702794458095;19995.60008799823;20061.09725062372;5436.456354364552;5658.575606829504;5684.488396044355;5700.23046888671;5824.126381042835;5371.650842695212;5666.688332141731;5699.829005129853;5717.828465146032;5731.942680573204;5759.510441612468;5777.855553611152;5777.884442311151;5785.27684039495;5806.216160818299;5774.018416869121;5874.118882167666;5894.557908156884;6039.3960603939695;6046.123312119762;5618.859528511779;5799.420057994209;5801.129830525455;5807.796727114531;5821.301443826768;15030.398784048624;15255.23723813816;15293.464728734552;15294.770578441332;18675.43973680792;2451.6199989001734;2501.974190581853;2509.297396728919;2716.606092116632;2873.209867286492;9998.106041726867;10876.891231087746;10883.619073332475;11264.605738799102;11314.943425282821;1926.3766959297657;1972.914896806765;2084.270505323125;2096.15105882118;2162.7188465499544;56657.43342566563;71082;74332.99999999946;89991.55004225002;90074.54962725144;11567.652970410902;11622.186446948801;11770.117241206945;11814.527418903319;12658;16861.409850655167;16994.575135621708;17011.574710632332;17026.574335641708;17029.063401513034;7997.440179187401;7999.480033797785;8333.208345207195;8369.832603347899;8406.747797566082;8167.673293068329;8246.463979841292;8282.58587070644;8356.958215208884;8480.787980300542;4361.302191649384;4464.977675111669;4466.709663871838;4511.458624965026;4751.097291514601;1820.2761559643554;1978.9307374241832;1982.3854605072474;2040.3062958594148;2124.564464284818;958.166395236135;1032.5405194688292;1056.3292309383444;1061.9734506637396;1128.9830652540218;19817.207311707658;19871.40385788429;20045.599088018156;20170.495737606383;20191.192352306036;1048.66442738323;1055.678018204455;1063.898929601702;1066.6373433032807;1116.3580940958982;11039.448027598588;11304.773904521864;11318.434078296052;11333.206675532798;11408;496053;501904;503947;531353;533227;95343;98847.50576247073;99744;101000.49499752454;101233;983.9324333098525;1001.7695929936156;1067.6156583629886;1087.9120879120878;1109.112709832131;17420.73868891993;17455.476335709947;17603.471895843144;17905.731414029062;17973.281068757104;39967.60032399639;41371.793141034104;41531.169376611695;42393;43002.35496467493;60147;61513.69243153756;61683.6915815418;61782;62263.37736622757;9051.773705657411;9219.539023048956;9295.535223238676;9371.484568348533;9423.434593924387;10015.349002315117;11254;13241.27173005494;13734.93132534331;13798.93100534491;11621.825672615087;11840.407979601157;11993.520259189883;12096.939515302367;12634.810477842655;11952;12042.277463352228;12145.939270303592;12233.571824986082;12479.688007799878;11987.160898737005;12142.635720928387;12342.321172335607;12393.75212495727;12742.299173545543;8788.340874434316;8823.250023748053;8866.955665221632;9177.449353038839;9510.38642170229;9391.765205869908;12226.510939562319;12407;12424.130310878514;12593.496260149492 03:41:46 INFO - PROCESS | 12180 | |3;mootools.html;1389.1526169036892;1578.7631855221719;1614.3784642912478;1850.6576283387574;1953.7655481342242;8855.468671879684;9214.769630759234;9216.907830921697;9438.433693978366;9443.905560944388;9246.583903724331;9443.386179898302;9444.811103777938;9445.244380449565;9451.054894510546;2177.0856240379;2456.3736247256925;2478.2689106713474;2511.196417146514;2527.41869370045;2527.772500474957;2545.287319550529;2545.8854351554132;2557.1433569754063;2557.6419301297833;2465.457599328145;2490.6264060390904;2491.676082109323;2493.7880280176114;2495.4759500504824;2111.366590022995;2436.1473484280536;2511.0583531175807;2512.6859142607173;2527.0776166699206;2379;2393.8922748476184;2400.84394514356;2426.6360045993065;2443.7189723181705;9558.90441095594;9598.904010959941;9627.903720962771;9639.614415423375;9651.469169195692;5758.856028599276;5892.263467066617;5897.999999999957;5900.527957763368;5908.793192238251;3592.604813470516;3650;3671.118931456458;3700.1859590889962;3734.8319325630414;1240.0761432732581;1247.357610830423;1252.7807633664072;1271.9109662323642;1275.222114510148;13692;13731.176129432166;13773.311334433238;13775.655608609864;13816.37826297819;5137.691738495702;5205.24523944026;5263.6841789492755;5294.444083371268;5299.947000529945;11554.653360399201;11563.88436115645;11569.710757230969;11581.247218930743;11590.652280431601;5026.894083301668;5855.326637436664;5929.495992840657;5932.525397968152;5933.732982015819;5234.057869583511;5389.02997460453;5402.081646120169;5492.093804522289;5492.505674489315;4265.338872474771;4319.632831209319;4369.934450983238;4424.358468022118;4575.656825738083;1367.7948307753916;1391.3530208453117;1393.3520912775607;1393.707321462484;1395.0722769358263;994.4629899853998;1038.1383451735041;1054.7363159210197;1077.2082519348273;1077.3535878472853;6276;6381.521385896076;6408.903866442007;6467.159269294962;6541.574797638138;496.6870871351098;498.50896866586385;500.9824656137018;513.0457349330243;515.2348762088296;4288.206681763883;4324.308110702273;4360.65114790816;4405.647548196137;4459.554044595579;11694.356810375511;12025.037996960396;12092.939535302266;12132.454039568063;12138.02895768354;11518.308901465938;11918;11928.821067683992;12022.759544809054;12117.636470905887;9024.36829421934;9030.36787424887;9083.18251357381;9143.77140571491;9151.771205719777;6188.752449901954;6234.781782637586;6272.937270627418;6274.749010039547;6308.684565771785;11005.229633925868;11079.113670906147;11193.608223712132;11208.66374008781;11377.374244416636;11282.43587820622;11385.886141138813;11413.828792567952;11463.254888432226;11486.081113511067;7734.2265773422205;7908.209179082046;8128.861959325581;8625.094365091574;8715.825683486168;9469.526523673927;9542.904570954202;9578.856317155387;9595.13643772064;9616.567254473706;8376.288015518749;8542.658293668432;8554.443961142506;8582.184692454206;8690.78273043179;8385.916140838513;8429.199226073513;8439.324854011542;8455.661773529237;8587.313014958912;7501.737439189602;7598;7598.468107232662;7599.696012159452;7601.277878601524;5375.247465354932;5511.53151982086;5563;5633.971830140823;5700.971495142664;5642.379338272704;5698.1452782083015;5710.229119068873;5734.3692193857805;5792.623479473821 03:41:46 INFO - PROCESS | 12180 | |4;prototype.html;361.3098980946392;364.08069624198913;365.786015181119;366.1012215012145;373.5274877280241;5519.392866784656;5541.9168712469345;5558.333000039996;5585.301837270341;5614.410486898878;5183.481651834824;5510;5526.314474085402;5555.527780138683;5564.443555644433;4331.155424692186;4331.523532411432;4336.609705126546;4338.327559228324;4368.759718215497;4352.825886964518;4353.453229860535;4354.412154359168;4364.934525982113;4381.123775244948;4314.956850431487;4355.433793606827;4365.236083685342;4366.148601022802;4387.62705170061;4133.73130746502;4298.763568003758;4306.8277268909205;4321.336285530062;4324.762138082404;3781;3806.7818298144607;3817.1602247505502;3834.3481608126685;3872.9806350968065;5354.785808567692;5363.81995960888;5402.6758394496455;5410.349843297792;5440.836774896759;4708.952910470885;4927.334809800667;4945.9258111128365;4948.604111671058;4955.355803745526;5770.105633626795;5798.88402231953;5802.274715660543;5814.389489103668;5840.7221183738375;4194.706370554062;4217.578242175789;4223.788810559459;4232.132412855388;4241.936370954438;5725.685087320196;5791;5904.704764761787;6032.487238584726;6033.245844269466;4128.566500517462;4142.5857414258335;4157.355609880473;4171.10321280926;4182.017225951899;4202.642775364128;4215.241256573846;4215.304474761691;4219.599138081939;4247.915041699149;4671.789769460383;4880.219164933594;4927.507249275044;4956;4983.202687569971;5836.88326233473;5848.356680765112;5897.5871688982215;5899.498542623839;5925.970370148121;1503.3911265937313;1530.4184409924158;1536.3316957123686;1543.529223586817;1548.7599422089595;969.1326262994721;971.3783178765595;972.8394814855469;975.7950830325569;976.2970661123979;4993.925091123636;5059.392872855281;5072.721000345016;5074.619403544749;5076.263941728429;5339.893202135935;5432.641839540115;5456.645318054314;5479.328804714601;5492.258545096361;4771.328917976216;5100.795968161232;5115.693058416507;5135.435102138762;5136.512031357015;2844.601755754196;2873.626428564315;2875.611792407998;2878.3811480531785;2884.22126025976;5450.800823818753;5461.563074953994;5493.450654934554;5504.366997795225;5554.333919718558;5114.23831131185;5237.240600112962;5257.474252574789;5297.443768404339;5329.813456529003;5363.490468405495;5389.11381016641;5399.325084364455;5410.945890541044;5442.5849279186905;5205.947940520547;5217.50433708797;5268.446813084571;5323.574114070942;5327.600429967691;4820.783064762024;5223.582113430993;5617.297837770278;5823.621464604787;5833.737481813244;6045.667488288011;6049.909251361145;6060.636361818305;6114.357992410733;6131.356207598138;4325.502567204686;4380.671449641226;4384.495782984997;4390.604845563915;4406.9338959914985;5798.971005144947;5920.970395147997;5941.22764040672;5945.613535120204;5985.306612024519;5725.169850371756;5758.539316854725;5763.567732420001;5830.4461076197695;5855.882882342415;5550.47270509301;5757.683327416865;5801.6519008859605;5830.300363956352;5863.853403664772;5734.627249228787;5750.424957504216;5761.740721667619;5785.595008349375;5807.796727114531;5858.794942177004;5894.882102357843;5925.348211696796;5933.465988061095;5945.732442040032;5543.695096769717;5661.660300381825;5751.827445176651;5764.13537969308;5780.479756821738 03:41:46 INFO - PROCESS | 12180 | |5;yui.html;786.3198333441575;815.3803109636674;815.9510429374238;849.0405841399217;854.5214679779324;15388.384464621402;16944.745828812564;17389.39137130199;18189.545261368472;18196.363127290548;15826.604334891634;15827.841721582781;15885.285162167702;15927.920360398211;15954.202289885488;733.8422239218567;838.8783626374203;862.8317478091775;864.9091845356241;873.0919843362894;881.951492667903;882.2589025218815;886.0342226972599;886.7472770260478;887.4763889305309;910.3672947301628;910.4901255297021;912.6395073945787;913.2237598041678;913.5295322908707;762.3862790453683;893.9016708162097;913.1918252346654;913.2465715784438;917.9495127767971;678.7217240931194;680.2721088435376;680.6834821807884;681.1859827506132;681.6830173969128;16283.837161628351;16348.83651163485;16420.917895410446;16429.096399698014;16432.589185270463;13768.586942391745;13940;13976.720465590632;13982.650433739238;14059;14427.567172984722;14494.710105797825;14579.92710036443;14594;14658.70682586353;4698.506656801055;4727.976360118178;4737.478877323491;4791.904161916742;4802.903941921177;75706.62146689286;76136.61931690361;76268.61865690691;76982;77025.22974770237;11770.352630605228;11931.284122952651;12042.09684273683;12262.141650084586;12277.263364198177;21323.57352852934;21347.359579212647;21364.679529807065;21440.678389824167;21445.249416270668;8620.181082797124;8706.406874161541;8782.297416206817;8803.031666516677;8925.375223734276;5028.522290382408;5082.415522214993;5124.538791508782;5139.229115632685;5233.058049551118;3470.757047006736;3544.8404821783083;3565.0196196046295;3569.3218288525095;3570.6429357064085;662.9602223866583;671.1074271219267;675.0717763075771;677.7322957431787;683.3030309084805;669.648434571844;705.4779463197198;721.7762493626992;724.692005897502;741.669956869188;9174.541272936327;9751.463669498246;9894.554745036347;10090.798184036279;10222.182225421948;632.3486808587163;681.117952251835;708.922018577956;715.4062128433388;787.8700014497543;4659.673822832369;4994.40067191932;5208.659558074232;5612.971935140298;5625.268715067097;69093;69698.3030169702;71570;71817.28182718105;131731;81657;94076;95768;96377.5181124104;97010;83838.58080709679;84338.5783071093;85279;85295;86024;9862.506874656381;10239.641612543823;10399.792004160026;10508.211884108876;10529.842052369373;52884.471155289495;53679.46320536744;54008.18987715266;54661.72669136629;55882.720586396805;47404.762976184895;51197.744011279705;52132.47867521428;67343.66328168327;77405;13804.17174969505;13812.171269723849;13867.861321386657;14026.859731402556;14047.719045618825;14600.269986500845;15173.544793656209;15592.37630494813;15603.921980390025;15672.294746736652;14606.26968651542;14687.207659083117;14720.19038952868;15096.094234345974;15743.370265189264;13131.474741010252;14293.928530357281;14362.210078445785;14445.133292002514;14925.10449373041;14219.146851188962;14476.710465790837;14549.709005819612;14790.482333118289;15568.221588920735;11548.711282217675;11973.580924667594;12219.906331379088;12480.812787808009;12527.937360313505;12535.749285014432;12562.497500099893;12607.810882836948;12933.870661293644;12937.805932911202 03:41:46 INFO - PROCESS | 12180 | __end_tp_report 03:41:46 INFO - PROCESS | 12180 | __start_cc_report 03:41:46 INFO - PROCESS | 12180 | _x_x_mozilla_cycle_collect,950 03:41:46 INFO - PROCESS | 12180 | __end_cc_report 03:41:46 INFO - PROCESS | 12180 | __startTimestamp1467110506802__endTimestamp 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | ------- Summary: start ------- 03:41:46 INFO - PROCESS | 12180 | Number of tests: 6 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#0] dojo.html Cycles:165 Average:5678.67 Median:5896.06 stddev:635.71 (10.8%) stddev-sans-first:612.30 03:41:46 INFO - PROCESS | 12180 | Values: 3412.6 3434.9 3443.2 3445.8 3484.3 5673.6 5752.1 5756.5 5760.3 5769.1 5673.9 5724.7 5728.2 5731.4 5742.6 5031.6 5115.5 5139.2 5194.7 5211.4 5175.1 5258.8 5259.2 5270.4 5275.8 5156.4 5185.2 5198.5 5204.9 5225.9 5291.1 5303.9 5305.4 5309.4 5343.1 5002.7 5036.6 5047.5 5216.4 5221.9 5528.3 5562.5 5569.4 5599.8 5619.9 6112.0 6123.7 6124.1 6131.1 6132.2 6077.5 6080.9 6093.5 6124.0 6143.6 5712.6 5733.1 5753.4 5763.9 5812.5 6065.6 6286.1 6289.2 6293.4 6301.0 5909.1 5926.2 5943.3 5989.8 5995.9 6065.9 6066.8 6067.5 6100.1 6109.4 5859.2 5960.7 6084.7 6101.5 6101.8 5998.3 6088.7 6091.3 6091.9 6108.1 4609.7 4617.8 4618.5 4619.6 4622.0 4081.2 4088.1 4130.6 4143.3 4155.4 5839.7 5855.3 5861.5 5867.5 5887.2 6146.9 6187.6 6188.1 6190.1 6197.8 5742.3 5794.7 5839.3 5851.4 5894.7 5310.9 5312.3 5312.5 5314.8 5320.9 6429.4 6430.4 6438.3 6439.5 6442.0 6019.6 6033.2 6039.7 6048.1 6126.6 6250.7 6251.2 6298.5 6308.8 6311.4 5917.8 5988.4 5989.2 5995.5 5995.7 6085.8 6119.0 6129.8 6148.8 6180.3 6004.6 6008.0 6012.5 6034.7 6080.5 5753.3 5900.0 5975.0 6027.2 6039.9 5821.0 5853.6 5892.5 5896.1 5909.1 6024.8 6025.9 6084.2 6087.6 6087.8 5672.6 5859.4 5898.5 5901.5 5903.8 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#1] ext.html Cycles:180 Average:70418.62 Median:223783.88 stddev:146692.59 (65.6%) stddev-sans-first:147010.44 03:41:46 INFO - PROCESS | 12180 | Values: 602.7 649.1 659.7 660.9 662.7 33906.0 36632.0 36648.6 36650.0 36696.1 47328.3 48394.5 48922.5 52043.5 52134.2 9164.4 9280.6 9303.8 9308.7 9331.3 8486.2 9090.1 9181.2 11003.0 11338.8 10977.3 11288.9 11301.8 11326.5 11448.8 11156.7 11233.9 11237.3 11246.2 11249.0 8280.5 10700.6 11179.7 11191.6 11578.1 46016.5 46071.0 46395.8 46469.6 46480.3 3743.2 3826.2 4283.0 4349.7 4370.1 35634.1 35722.0 35726.5 36051.8 37333.8 4734.1 4765.8 4792.5 4806.0 4849.1 400643.0 404914.0 404943.0 405163.0 406841.0 69201.0 69356.3 69737.0 69748.7 69834.0 40494.6 41428.0 41535.8 43740.6 43748.1 20275.4 20400.9 20424.8 20534.9 20557.6 13986.2 15203.7 15349.1 15351.8 15366.5 21875.8 22522.7 22522.7 23198.8 23208.5 8263.7 8316.3 8358.8 8452.4 8486.3 1039.9 1143.6 1153.9 1167.7 1194.4 34968.8 35566.8 35574.6 35700.0 35718.8 1211.3 1212.1 1225.8 1237.2 1258.8 18346.4 19295.3 19452.2 19879.7 20137.4 683109.0 692997.0 693767.0 700667.0 702021.0 67745.3 68899.7 69014.0 69016.3 69088.0 1370.0 1489.6 1499.0 1520.1 1520.3 35099.6 35741.0 36115.5 36135.6 36261.0 56839.1 57173.0 57653.8 57742.4 57750.0 508699.0 513467.0 513941.0 514750.0 515596.0 28565.9 30907.5 31800.5 31905.7 33128.0 53074.0 54247.2 54439.5 54482.2 55630.4 44209.0 44891.0 45147.8 45212.0 46151.0 43686.8 44122.0 44272.6 45047.0 45301.8 45413.5 46173.5 47405.5 47433.8 48937.5 39882.4 40191.8 40726.8 41169.4 41715.6 30082.8 30513.8 30668.4 30809.2 30952.5 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#2] jquery.html Cycles:180 Average:29897.19 Median:21369.02 stddev:84665.87 (396.2%) stddev-sans-first:84874.45 03:41:46 INFO - PROCESS | 12180 | Values: 417.9 433.6 434.9 439.2 443.2 19956.4 20192.5 20641.5 21341.6 21396.5 19412.8 19548.6 19813.7 19995.6 20061.1 5436.5 5658.6 5684.5 5700.2 5824.1 5371.7 5666.7 5699.8 5717.8 5731.9 5759.5 5777.9 5777.9 5785.3 5806.2 5774.0 5874.1 5894.6 6039.4 6046.1 5618.9 5799.4 5801.1 5807.8 5821.3 15030.4 15255.2 15293.5 15294.8 18675.4 2451.6 2502.0 2509.3 2716.6 2873.2 9998.1 10876.9 10883.6 11264.6 11314.9 1926.4 1972.9 2084.3 2096.2 2162.7 56657.4 71082.0 74333.0 89991.6 90074.5 11567.7 11622.2 11770.1 11814.5 12658.0 16861.4 16994.6 17011.6 17026.6 17029.1 7997.4 7999.5 8333.2 8369.8 8406.7 8167.7 8246.5 8282.6 8357.0 8480.8 4361.3 4465.0 4466.7 4511.5 4751.1 1820.3 1978.9 1982.4 2040.3 2124.6 958.2 1032.5 1056.3 1062.0 1129.0 19817.2 19871.4 20045.6 20170.5 20191.2 1048.7 1055.7 1063.9 1066.6 1116.4 11039.4 11304.8 11318.4 11333.2 11408.0 496053.0 501904.0 503947.0 531353.0 533227.0 95343.0 98847.5 99744.0 101000.5 101233.0 983.9 1001.8 1067.6 1087.9 1109.1 17420.7 17455.5 17603.5 17905.7 17973.3 39967.6 41371.8 41531.2 42393.0 43002.4 60147.0 61513.7 61683.7 61782.0 62263.4 9051.8 9219.5 9295.5 9371.5 9423.4 10015.3 11254.0 13241.3 13734.9 13798.9 11621.8 11840.4 11993.5 12096.9 12634.8 11952.0 12042.3 12145.9 12233.6 12479.7 11987.2 12142.6 12342.3 12393.8 12742.3 8788.3 8823.3 8867.0 9177.4 9510.4 9391.8 12226.5 12407.0 12424.1 12593.5 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#3] mootools.html Cycles:180 Average:6342.52 Median:499.75 stddev:3676.98 (735.8%) stddev-sans-first:3668.45 03:41:46 INFO - PROCESS | 12180 | Values: 1389.2 1578.8 1614.4 1850.7 1953.8 8855.5 9214.8 9216.9 9438.4 9443.9 9246.6 9443.4 9444.8 9445.2 9451.1 2177.1 2456.4 2478.3 2511.2 2527.4 2527.8 2545.3 2545.9 2557.1 2557.6 2465.5 2490.6 2491.7 2493.8 2495.5 2111.4 2436.1 2511.1 2512.7 2527.1 2379.0 2393.9 2400.8 2426.6 2443.7 9558.9 9598.9 9627.9 9639.6 9651.5 5758.9 5892.3 5898.0 5900.5 5908.8 3592.6 3650.0 3671.1 3700.2 3734.8 1240.1 1247.4 1252.8 1271.9 1275.2 13692.0 13731.2 13773.3 13775.7 13816.4 5137.7 5205.2 5263.7 5294.4 5299.9 11554.7 11563.9 11569.7 11581.2 11590.7 5026.9 5855.3 5929.5 5932.5 5933.7 5234.1 5389.0 5402.1 5492.1 5492.5 4265.3 4319.6 4369.9 4424.4 4575.7 1367.8 1391.4 1393.4 1393.7 1395.1 994.5 1038.1 1054.7 1077.2 1077.4 6276.0 6381.5 6408.9 6467.2 6541.6 496.7 498.5 501.0 513.0 515.2 4288.2 4324.3 4360.7 4405.6 4459.6 11694.4 12025.0 12092.9 12132.5 12138.0 11518.3 11918.0 11928.8 12022.8 12117.6 9024.4 9030.4 9083.2 9143.8 9151.8 6188.8 6234.8 6272.9 6274.7 6308.7 11005.2 11079.1 11193.6 11208.7 11377.4 11282.4 11385.9 11413.8 11463.3 11486.1 7734.2 7908.2 8128.9 8625.1 8715.8 9469.5 9542.9 9578.9 9595.1 9616.6 8376.3 8542.7 8554.4 8582.2 8690.8 8385.9 8429.2 8439.3 8455.7 8587.3 7501.7 7598.0 7598.5 7599.7 7601.3 5375.2 5511.5 5563.0 5634.0 5701.0 5642.4 5698.1 5710.2 5734.4 5792.6 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#4] prototype.html Cycles:180 Average:4750.51 Median:5325.59 stddev:1365.82 (25.6%) stddev-sans-first:1329.33 03:41:46 INFO - PROCESS | 12180 | Values: 361.3 364.1 365.8 366.1 373.5 5519.4 5541.9 5558.3 5585.3 5614.4 5183.5 5510.0 5526.3 5555.5 5564.4 4331.2 4331.5 4336.6 4338.3 4368.8 4352.8 4353.5 4354.4 4364.9 4381.1 4315.0 4355.4 4365.2 4366.1 4387.6 4133.7 4298.8 4306.8 4321.3 4324.8 3781.0 3806.8 3817.2 3834.3 3873.0 5354.8 5363.8 5402.7 5410.3 5440.8 4709.0 4927.3 4945.9 4948.6 4955.4 5770.1 5798.9 5802.3 5814.4 5840.7 4194.7 4217.6 4223.8 4232.1 4241.9 5725.7 5791.0 5904.7 6032.5 6033.2 4128.6 4142.6 4157.4 4171.1 4182.0 4202.6 4215.2 4215.3 4219.6 4247.9 4671.8 4880.2 4927.5 4956.0 4983.2 5836.9 5848.4 5897.6 5899.5 5926.0 1503.4 1530.4 1536.3 1543.5 1548.8 969.1 971.4 972.8 975.8 976.3 4993.9 5059.4 5072.7 5074.6 5076.3 5339.9 5432.6 5456.6 5479.3 5492.3 4771.3 5100.8 5115.7 5135.4 5136.5 2844.6 2873.6 2875.6 2878.4 2884.2 5450.8 5461.6 5493.5 5504.4 5554.3 5114.2 5237.2 5257.5 5297.4 5329.8 5363.5 5389.1 5399.3 5410.9 5442.6 5205.9 5217.5 5268.4 5323.6 5327.6 4820.8 5223.6 5617.3 5823.6 5833.7 6045.7 6049.9 6060.6 6114.4 6131.4 4325.5 4380.7 4384.5 4390.6 4406.9 5799.0 5921.0 5941.2 5945.6 5985.3 5725.2 5758.5 5763.6 5830.4 5855.9 5550.5 5757.7 5801.7 5830.3 5863.9 5734.6 5750.4 5761.7 5785.6 5807.8 5858.8 5894.9 5925.3 5933.5 5945.7 5543.7 5661.7 5751.8 5764.1 5780.5 03:41:46 INFO - PROCESS | 12180 | 03:41:46 INFO - PROCESS | 12180 | [#5] yui.html Cycles:180 Average:19848.95 Median:5055.47 stddev:26507.07 (524.3%) stddev-sans-first:26542.78 03:41:46 INFO - PROCESS | 12180 | Values: 786.3 815.4 816.0 849.0 854.5 15388.4 16944.7 17389.4 18189.5 18196.4 15826.6 15827.8 15885.3 15927.9 15954.2 733.8 838.9 862.8 864.9 873.1 882.0 882.3 886.0 886.7 887.5 910.4 910.5 912.6 913.2 913.5 762.4 893.9 913.2 913.2 917.9 678.7 680.3 680.7 681.2 681.7 16283.8 16348.8 16420.9 16429.1 16432.6 13768.6 13940.0 13976.7 13982.7 14059.0 14427.6 14494.7 14579.9 14594.0 14658.7 4698.5 4728.0 4737.5 4791.9 4802.9 75706.6 76136.6 76268.6 76982.0 77025.2 11770.4 11931.3 12042.1 12262.1 12277.3 21323.6 21347.4 21364.7 21440.7 21445.2 8620.2 8706.4 8782.3 8803.0 8925.4 5028.5 5082.4 5124.5 5139.2 5233.1 3470.8 3544.8 3565.0 3569.3 3570.6 663.0 671.1 675.1 677.7 683.3 669.6 705.5 721.8 724.7 741.7 9174.5 9751.5 9894.6 10090.8 10222.2 632.3 681.1 708.9 715.4 787.9 4659.7 4994.4 5208.7 5613.0 5625.3 69093.0 69698.3 71570.0 71817.3 131731.0 81657.0 94076.0 95768.0 96377.5 97010.0 83838.6 84338.6 85279.0 85295.0 86024.0 9862.5 10239.6 10399.8 10508.2 10529.8 52884.5 53679.5 54008.2 54661.7 55882.7 47404.8 51197.7 52132.5 67343.7 77405.0 13804.2 13812.2 13867.9 14026.9 14047.7 14600.3 15173.5 15592.4 15603.9 15672.3 14606.3 14687.2 14720.2 15096.1 15743.4 13131.5 14293.9 14362.2 14445.1 14925.1 14219.1 14476.7 14549.7 14790.5 15568.2 11548.7 11973.6 12219.9 12480.8 12527.9 12535.7 12562.5 12607.8 12933.9 12937.8 03:41:46 INFO - PROCESS | 12180 | -------- Summary: end -------- 03:41:46 INFO - PROCESS | 12180 | 03:41:47 INFO - TEST-INFO | 12180: exit 0 03:41:47 INFO - TEST-OK | dromaeo_css | took 1113341ms 03:41:47 INFO - TEST-START | kraken 03:41:47 INFO - operating with platform_type : linux_ 03:41:47 INFO - Initialising browser for kraken test... 03:41:47 INFO - TEST-INFO | started process 12375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3I4iId/profile http://localhost:46719/getInfo.html) 03:41:51 INFO - PROCESS | 12375 | __metrics Screen width/height:1600/1200 03:41:51 INFO - PROCESS | 12375 | colorDepth:24 03:41:51 INFO - PROCESS | 12375 | Browser inner width/height: 1024/697 03:41:51 INFO - PROCESS | 12375 | __metrics 03:41:52 ERROR - PROCESS | 12375 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:53 INFO - TEST-INFO | 12375: exit 0 03:41:53 INFO - Browser initialized. 03:41:53 INFO - Running cycle 1/1 for kraken test... 03:41:53 INFO - TEST-INFO | started process 12466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3I4iId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:05 INFO - PROCESS | 12466 | RSS: Main: 145481728 03:42:05 INFO - PROCESS | 12466 | 03:42:07 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46719/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:08 INFO - PROCESS | 12466 | RSS: Main: 195346432 03:42:08 INFO - PROCESS | 12466 | 03:42:11 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46719/tests/kraken/driver.html?testName=audio-dft) 03:42:11 INFO - PROCESS | 12466 | RSS: Main: 193822720 03:42:11 INFO - PROCESS | 12466 | 03:42:14 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46719/tests/kraken/driver.html?testName=audio-fft) 03:42:15 INFO - PROCESS | 12466 | RSS: Main: 279744512 03:42:15 INFO - PROCESS | 12466 | 03:42:17 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46719/tests/kraken/driver.html?testName=audio-oscillator) 03:42:17 INFO - PROCESS | 12466 | RSS: Main: 187781120 03:42:17 INFO - PROCESS | 12466 | 03:42:19 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:20 INFO - PROCESS | 12466 | RSS: Main: 188780544 03:42:20 INFO - PROCESS | 12466 | 03:42:23 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46719/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:24 INFO - PROCESS | 12466 | RSS: Main: 223285248 03:42:24 INFO - PROCESS | 12466 | 03:42:27 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46719/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:28 INFO - PROCESS | 12466 | RSS: Main: 224514048 03:42:28 INFO - PROCESS | 12466 | 03:42:30 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46719/tests/kraken/driver.html?testName=json-parse-financial) 03:42:31 INFO - PROCESS | 12466 | RSS: Main: 224366592 03:42:31 INFO - PROCESS | 12466 | 03:42:33 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:33 INFO - PROCESS | 12466 | RSS: Main: 201793536 03:42:33 INFO - PROCESS | 12466 | 03:42:35 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:35 INFO - PROCESS | 12466 | RSS: Main: 202780672 03:42:35 INFO - PROCESS | 12466 | 03:42:38 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:38 INFO - PROCESS | 12466 | RSS: Main: 211402752 03:42:38 INFO - PROCESS | 12466 | 03:42:41 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:41 INFO - PROCESS | 12466 | RSS: Main: 215855104 03:42:41 INFO - PROCESS | 12466 | 03:42:44 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:44 INFO - PROCESS | 12466 | RSS: Main: 214536192 03:42:44 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | Cycle 1(1): loaded http://localhost:46719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46719/tests/kraken/driver.html?testName=ai-astar) 03:42:46 INFO - PROCESS | 12466 | RSS: Main: 256475136 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | __start_tp_report 03:42:46 INFO - PROCESS | 12466 | _x_x_mozilla_page_load 03:42:46 INFO - PROCESS | 12466 | _x_x_mozilla_page_load_details 03:42:46 INFO - PROCESS | 12466 | |i|pagename|runs| 03:42:46 INFO - PROCESS | 12466 | |0;ai-astar;111;102;109;110;111;111;110;110;108;111 03:42:46 INFO - PROCESS | 12466 | |1;audio-beat-detection;151;125;133;169;126;124;149;124;188;130 03:42:46 INFO - PROCESS | 12466 | |2;audio-dft;161;163;161;161;160;161;161;162;162;162 03:42:46 INFO - PROCESS | 12466 | |3;audio-fft;76;74;76;120;75;76;75;74;104;75 03:42:46 INFO - PROCESS | 12466 | |4;audio-oscillator;84;85;117;84;84;84;123;84;83;138 03:42:46 INFO - PROCESS | 12466 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 03:42:46 INFO - PROCESS | 12466 | |6;imaging-darkroom;146;145;146;146;147;146;145;146;145;145 03:42:46 INFO - PROCESS | 12466 | |7;imaging-desaturate;95;95;95;94;95;94;95;94;94;94 03:42:46 INFO - PROCESS | 12466 | |8;json-parse-financial;51;52;51;52;52;53;52;52;52;52 03:42:46 INFO - PROCESS | 12466 | |9;json-stringify-tinderbox;71;60;60;60;60;59;59;60;59;60 03:42:46 INFO - PROCESS | 12466 | |10;stanford-crypto-aes;76;81;80;81;76;77;78;77;101;76 03:42:46 INFO - PROCESS | 12466 | |11;stanford-crypto-ccm;116;118;126;127;123;126;117;120;131;126 03:42:46 INFO - PROCESS | 12466 | |12;stanford-crypto-pbkdf2;154;161;153;153;157;152;155;157;152;153 03:42:46 INFO - PROCESS | 12466 | |13;stanford-crypto-sha256-iterative;64;64;68;60;62;62;61;63;63;60 03:42:46 INFO - PROCESS | 12466 | __end_tp_report 03:42:46 INFO - PROCESS | 12466 | __start_cc_report 03:42:46 INFO - PROCESS | 12466 | _x_x_mozilla_cycle_collect,1590 03:42:46 INFO - PROCESS | 12466 | __end_cc_report 03:42:46 INFO - PROCESS | 12466 | __startTimestamp1467110566887__endTimestamp 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | ------- Summary: start ------- 03:42:46 INFO - PROCESS | 12466 | Number of tests: 14 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:2.75 (2.5%) stddev-sans-first:2.85 03:42:46 INFO - PROCESS | 12466 | Values: 111.0 102.0 109.0 110.0 111.0 111.0 110.0 110.0 108.0 111.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:141.00 stddev:22.09 (15.7%) stddev-sans-first:23.19 03:42:46 INFO - PROCESS | 12466 | Values: 151.0 125.0 133.0 169.0 126.0 124.0 149.0 124.0 188.0 130.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 03:42:46 INFO - PROCESS | 12466 | Values: 161.0 163.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 162.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:16.02 (21.4%) stddev-sans-first:16.81 03:42:46 INFO - PROCESS | 12466 | Values: 76.0 74.0 76.0 120.0 75.0 76.0 75.0 74.0 104.0 75.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:20.92 (24.9%) stddev-sans-first:21.69 03:42:46 INFO - PROCESS | 12466 | Values: 84.0 85.0 117.0 84.0 84.0 84.0 123.0 84.0 83.0 138.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:42:46 INFO - PROCESS | 12466 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:42:46 INFO - PROCESS | 12466 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 145.0 145.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:42:46 INFO - PROCESS | 12466 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 03:42:46 INFO - PROCESS | 12466 | Values: 51.0 52.0 51.0 52.0 52.0 53.0 52.0 52.0 52.0 52.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.00 stddev:3.61 (6.0%) stddev-sans-first:0.50 03:42:46 INFO - PROCESS | 12466 | Values: 71.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 59.0 60.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.50 stddev:7.54 (9.7%) stddev-sans-first:7.84 03:42:46 INFO - PROCESS | 12466 | Values: 76.0 81.0 80.0 81.0 76.0 77.0 78.0 77.0 101.0 76.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:126.00 stddev:5.01 (4.0%) stddev-sans-first:4.63 03:42:46 INFO - PROCESS | 12466 | Values: 116.0 118.0 126.0 127.0 123.0 126.0 117.0 120.0 131.0 126.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:154.50 stddev:2.87 (1.9%) stddev-sans-first:3.03 03:42:46 INFO - PROCESS | 12466 | Values: 154.0 161.0 153.0 153.0 157.0 152.0 155.0 157.0 152.0 153.0 03:42:46 INFO - PROCESS | 12466 | 03:42:46 INFO - PROCESS | 12466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.36 (3.7%) stddev-sans-first:2.46 03:42:46 INFO - PROCESS | 12466 | Values: 64.0 64.0 68.0 60.0 62.0 62.0 61.0 63.0 63.0 60.0 03:42:46 INFO - PROCESS | 12466 | -------- Summary: end -------- 03:42:46 INFO - PROCESS | 12466 | 03:42:47 INFO - TEST-INFO | 12466: exit 0 03:42:47 INFO - TEST-OK | kraken | took 60300ms 03:42:47 INFO - SUITE-END | took 1173s 03:42:48 INFO - Completed test suite (00:19:33) 03:42:48 INFO - javascript benchmark 03:42:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.641672624374, 3434.879779207728, 3443.208062145706, 3445.7932524048574, 3484.303139372126, 5673.574481913853, 5752.079667253241, 5756.539476841853, 5760.308762948447, 5769.076947688371, 5673.886522269552, 5724.685142317181, 5728.198052272685, 5731.426857314266, 5742.569307301948, 5031.622628302874, 5115.53960143587, 5139.203423469359, 5194.662346947455, 5211.42674305826, 5175.094358487268, 5258.763355649005, 5259.211118332242, 5270.367555893298, 5275.762590683428, 5156.381234251876, 5185.222216667511, 5198.480151984809, 5204.869878253036, 5225.947740522584, 5291.126964050927, 5303.946960530422, 5305.416404195574, 5309.41596424393, 5343.118385466432, 5002.7498625068965, 5036.571891389236, 5047.470015648378, 5216.400113986902, 5221.947780522184, 5528.308961379827, 5562.527185189264, 5569.387367389584, 5599.832005039855, 5619.943800561983, 6111.991521398963, 6123.743997921446, 6124.081387791823, 6131.14164017038, 6132.202813634243, 6077.483413909823, 6080.908786368208, 6093.512518998514, 6124.0, 6143.559292432815, 5712.57155713319, 5733.140028995684, 5753.424657534255, 5763.942360576424, 5812.505936995402, 6065.551746271787, 6286.05709143623, 6289.24529056507, 6293.402126797947, 6301.023341382093, 5909.143174239797, 5926.2295901532525, 5943.31651860033, 5989.790357337472, 5995.880082398327, 6065.920924786332, 6066.787662431793, 6067.484263837535, 6100.0849872519475, 6109.358517355702, 5859.150423188614, 5960.731767070492, 6084.726187321493, 6101.450869421773, 6101.816945491642, 5998.25021872266, 6088.695565221721, 6091.269047714302, 6091.878162436727, 6108.1143234230785, 4609.700369476041, 4617.815287388534, 4618.468876079227, 4619.584237418649, 4621.95378046222, 4081.2041651878194, 4088.100617864065, 4130.607592278729, 4143.316352801814, 4155.439015732898, 5839.708014599253, 5855.3266374367495, 5861.472467477862, 5867.530597552186, 5887.234659494238, 6146.877062458726, 6187.566870319124, 6188.0717892315615, 6190.071489276645, 6197.81406557804, 5742.31092268922, 5794.710264486759, 5839.270091238595, 5851.414858514115, 5894.705264736832, 5310.92033619496, 5312.282841816383, 5312.521873031368, 5314.7608357624, 5320.866978325573, 6429.421352078241, 6430.356964303626, 6438.259600146043, 6439.484841212692, 6441.967790161019, 6019.638821670714, 6033.245844269466, 6039.6678182698615, 6048.12302216185, 6126.632402055891, 6250.718717657625, 6251.154247380881, 6298.496120310272, 6308.810735677937, 6311.400416960381, 5917.763289468373, 5988.431099045583, 5989.221401217814, 5995.467788928525, 5995.670238136944, 6085.756569737161, 6118.969405152946, 6129.754809807558, 6148.780122736153, 6180.289266734383, 6004.579679422399, 6008.03871380577, 6012.549058820693, 6034.728437220423, 6080.452759251689, 5753.280839895013, 5900.0264956281735, 5974.970125149346, 6027.156198132353, 6039.939600604113, 5821.039528477923, 5853.619514731528, 5892.528597712087, 5896.056630939029, 5909.113632955091, 6024.849378765566, 6025.939740602538, 6084.239470066242, 6087.604305720114, 6087.756489740361, 5672.5745569081655, 5859.414058594277, 5898.469137777621, 5901.527877769854, 5903.763849446146], "value": 5636.970339290772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6564858030921, 649.110718315907, 659.6767583883897, 660.867826434713, 662.681912681913, 33906.0, 36632.0, 36648.633513664856, 36650.0, 36696.082597935034, 47328.290075648896, 48394.51605483944, 48922.51077489224, 52043.47956520434, 52134.21798673023, 9164.358494905358, 9280.628774848998, 9303.813923721522, 9308.674196403128, 9331.346805723602, 8486.151384861527, 9090.13643703847, 9181.21959633432, 11003.0, 11338.773224535504, 10977.341359518414, 11288.887111128866, 11301.756806751291, 11326.490307936121, 11448.828267575993, 11156.665300041012, 11233.943830280878, 11237.269577477438, 11246.212765106446, 11249.0, 8280.461769984931, 10700.571977120906, 11179.720506987309, 11191.552337906474, 11578.073754099652, 46016.53983460156, 46071.0, 46395.768021160016, 46469.6059118227, 46480.3027954581, 3743.2139250757373, 3826.1773718650347, 4283.014906571506, 4349.717268377577, 4370.104128653618, 35634.109147271265, 35722.0, 35726.464103038474, 36051.819740901126, 37333.813330933444, 4734.124187025377, 4765.761711914391, 4792.520747925215, 4806.0, 4849.078675051729, 400643.0, 404914.0, 404943.0, 405163.0, 406840.9657951721, 69201.0, 69356.30643693499, 69737.0, 69748.6512567434, 69834.0, 40494.59505404908, 41428.0, 41535.7923210382, 43740.562594374285, 43748.12503749971, 20275.391738247876, 20400.897995509928, 20424.795752042588, 20534.897325513277, 20557.588848222953, 13986.16083035021, 15203.695926081416, 15349.07905525672, 15351.769723454157, 15366.462173823862, 21875.78124218769, 22522.66216006761, 22522.66216006761, 23198.768012319662, 23208.535829283657, 8263.669453221804, 8316.334693224528, 8358.79103022417, 8452.408331416866, 8486.278666313432, 1039.859618951447, 1143.6054561176381, 1153.9076873850072, 1167.733009684502, 1194.4266751959108, 34968.82515587406, 35566.822165889, 35574.64425355765, 35700.0, 35718.82140589332, 1211.3398197982121, 1212.0727643352843, 1225.7671042501895, 1237.1587320622064, 1258.79229927061, 18346.359111715174, 19295.324663636988, 19452.22191112368, 19879.701804472945, 20137.39587812368, 683109.0, 692997.0, 693767.0, 700667.0, 702021.0, 67745.3225467739, 68899.65550172217, 69014.0, 69016.30983690098, 69088.0, 1369.9589012329645, 1489.5531340597777, 1498.9850101499064, 1520.148716718641, 1520.3310543360885, 35099.64900351066, 35741.0, 36115.458268125476, 36135.63864361323, 36261.0, 56839.147412788014, 57173.0, 57653.811156996075, 57742.42257577371, 57750.0, 508699.0, 513467.0, 513941.0, 514750.0, 515596.0, 28565.857170714015, 30907.536386953765, 31800.5229921556, 31905.6809431912, 33128.0, 53074.0, 54247.18629220486, 54439.455605443436, 54482.18276725773, 55630.44369556253, 44209.0, 44891.0, 45147.774261128485, 45212.0, 46151.0, 43686.781566091966, 44122.0, 44272.55727442813, 45047.0, 45301.773491132335, 45413.54586454093, 46173.53826461827, 47405.52594474011, 47433.762831185624, 48937.51062489329, 39882.40176397414, 40191.79904100461, 40726.79636601798, 41169.38245926254, 41715.58284417117, 30082.84958575193, 30513.847430762704, 30668.38663226678, 30809.229769255948, 30952.53571196479], "value": 22490.505397427485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.93730940358944, 433.5794279548837, 434.9021470169212, 439.15462734236587, 443.1646346636591, 19956.401307960765, 20192.495187620316, 20641.483962900915, 21341.57316853662, 21396.4650883728, 19412.805871941277, 19548.609027819435, 19813.702794458095, 19995.60008799823, 20061.09725062372, 5436.456354364552, 5658.575606829504, 5684.488396044355, 5700.23046888671, 5824.126381042835, 5371.650842695212, 5666.688332141731, 5699.829005129853, 5717.828465146032, 5731.942680573204, 5759.510441612468, 5777.855553611152, 5777.884442311151, 5785.27684039495, 5806.216160818299, 5774.018416869121, 5874.118882167666, 5894.557908156884, 6039.3960603939695, 6046.123312119762, 5618.859528511779, 5799.420057994209, 5801.129830525455, 5807.796727114531, 5821.301443826768, 15030.398784048624, 15255.23723813816, 15293.464728734552, 15294.770578441332, 18675.43973680792, 2451.6199989001734, 2501.974190581853, 2509.297396728919, 2716.606092116632, 2873.209867286492, 9998.106041726867, 10876.891231087746, 10883.619073332475, 11264.605738799102, 11314.943425282821, 1926.3766959297657, 1972.914896806765, 2084.270505323125, 2096.15105882118, 2162.7188465499544, 56657.43342566563, 71082.0, 74332.99999999946, 89991.55004225002, 90074.54962725144, 11567.652970410902, 11622.186446948801, 11770.117241206945, 11814.527418903319, 12658.0, 16861.409850655167, 16994.575135621708, 17011.574710632332, 17026.574335641708, 17029.063401513034, 7997.440179187401, 7999.480033797785, 8333.208345207195, 8369.832603347899, 8406.747797566082, 8167.673293068329, 8246.463979841292, 8282.58587070644, 8356.958215208884, 8480.787980300542, 4361.302191649384, 4464.977675111669, 4466.709663871838, 4511.458624965026, 4751.097291514601, 1820.2761559643554, 1978.9307374241832, 1982.3854605072474, 2040.3062958594148, 2124.564464284818, 958.166395236135, 1032.5405194688292, 1056.3292309383444, 1061.9734506637396, 1128.9830652540218, 19817.207311707658, 19871.40385788429, 20045.599088018156, 20170.495737606383, 20191.192352306036, 1048.66442738323, 1055.678018204455, 1063.898929601702, 1066.6373433032807, 1116.3580940958982, 11039.448027598588, 11304.773904521864, 11318.434078296052, 11333.206675532798, 11408.0, 496053.0, 501904.0, 503947.0, 531353.0, 533227.0, 95343.0, 98847.50576247073, 99744.0, 101000.49499752454, 101233.0, 983.9324333098525, 1001.7695929936156, 1067.6156583629886, 1087.9120879120878, 1109.112709832131, 17420.73868891993, 17455.476335709947, 17603.471895843144, 17905.731414029062, 17973.281068757104, 39967.60032399639, 41371.793141034104, 41531.169376611695, 42393.0, 43002.35496467493, 60147.0, 61513.69243153756, 61683.6915815418, 61782.0, 62263.37736622757, 9051.773705657411, 9219.539023048956, 9295.535223238676, 9371.484568348533, 9423.434593924387, 10015.349002315117, 11254.0, 13241.27173005494, 13734.93132534331, 13798.93100534491, 11621.825672615087, 11840.407979601157, 11993.520259189883, 12096.939515302367, 12634.810477842655, 11952.0, 12042.277463352228, 12145.939270303592, 12233.571824986082, 12479.688007799878, 11987.160898737005, 12142.635720928387, 12342.321172335607, 12393.75212495727, 12742.299173545543, 8788.340874434316, 8823.250023748053, 8866.955665221632, 9177.449353038839, 9510.38642170229, 9391.765205869908, 12226.510939562319, 12407.0, 12424.130310878514, 12593.496260149492], "value": 9456.313490224775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.1526169036892, 1578.7631855221719, 1614.3784642912478, 1850.6576283387574, 1953.7655481342242, 8855.468671879684, 9214.769630759234, 9216.907830921697, 9438.433693978366, 9443.905560944388, 9246.583903724331, 9443.386179898302, 9444.811103777938, 9445.244380449565, 9451.054894510546, 2177.0856240379, 2456.3736247256925, 2478.2689106713474, 2511.196417146514, 2527.41869370045, 2527.772500474957, 2545.287319550529, 2545.8854351554132, 2557.1433569754063, 2557.6419301297833, 2465.457599328145, 2490.6264060390904, 2491.676082109323, 2493.7880280176114, 2495.4759500504824, 2111.366590022995, 2436.1473484280536, 2511.0583531175807, 2512.6859142607173, 2527.0776166699206, 2379.0, 2393.8922748476184, 2400.84394514356, 2426.6360045993065, 2443.7189723181705, 9558.90441095594, 9598.904010959941, 9627.903720962771, 9639.614415423375, 9651.469169195692, 5758.856028599276, 5892.263467066617, 5897.999999999957, 5900.527957763368, 5908.793192238251, 3592.604813470516, 3650.0, 3671.118931456458, 3700.1859590889962, 3734.8319325630414, 1240.0761432732581, 1247.357610830423, 1252.7807633664072, 1271.9109662323642, 1275.222114510148, 13692.0, 13731.176129432166, 13773.311334433238, 13775.655608609864, 13816.37826297819, 5137.691738495702, 5205.24523944026, 5263.6841789492755, 5294.444083371268, 5299.947000529945, 11554.653360399201, 11563.88436115645, 11569.710757230969, 11581.247218930743, 11590.652280431601, 5026.894083301668, 5855.326637436664, 5929.495992840657, 5932.525397968152, 5933.732982015819, 5234.057869583511, 5389.02997460453, 5402.081646120169, 5492.093804522289, 5492.505674489315, 4265.338872474771, 4319.632831209319, 4369.934450983238, 4424.358468022118, 4575.656825738083, 1367.7948307753916, 1391.3530208453117, 1393.3520912775607, 1393.707321462484, 1395.0722769358263, 994.4629899853998, 1038.1383451735041, 1054.7363159210197, 1077.2082519348273, 1077.3535878472853, 6276.0, 6381.521385896076, 6408.903866442007, 6467.159269294962, 6541.574797638138, 496.6870871351098, 498.50896866586385, 500.9824656137018, 513.0457349330243, 515.2348762088296, 4288.206681763883, 4324.308110702273, 4360.65114790816, 4405.647548196137, 4459.554044595579, 11694.356810375511, 12025.037996960396, 12092.939535302266, 12132.454039568063, 12138.02895768354, 11518.308901465938, 11918.0, 11928.821067683992, 12022.759544809054, 12117.636470905887, 9024.36829421934, 9030.36787424887, 9083.18251357381, 9143.77140571491, 9151.771205719777, 6188.752449901954, 6234.781782637586, 6272.937270627418, 6274.749010039547, 6308.684565771785, 11005.229633925868, 11079.113670906147, 11193.608223712132, 11208.66374008781, 11377.374244416636, 11282.43587820622, 11385.886141138813, 11413.828792567952, 11463.254888432226, 11486.081113511067, 7734.2265773422205, 7908.209179082046, 8128.861959325581, 8625.094365091574, 8715.825683486168, 9469.526523673927, 9542.904570954202, 9578.856317155387, 9595.13643772064, 9616.567254473706, 8376.288015518749, 8542.658293668432, 8554.443961142506, 8582.184692454206, 8690.78273043179, 8385.916140838513, 8429.199226073513, 8439.324854011542, 8455.661773529237, 8587.313014958912, 7501.737439189602, 7598.0, 7598.468107232662, 7599.696012159452, 7601.277878601524, 5375.247465354932, 5511.53151982086, 5563.0, 5633.971830140823, 5700.971495142664, 5642.379338272704, 5698.1452782083015, 5710.229119068873, 5734.3692193857805, 5792.623479473821], "value": 4965.294845043185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.3098980946392, 364.08069624198913, 365.786015181119, 366.1012215012145, 373.5274877280241, 5519.392866784656, 5541.9168712469345, 5558.333000039996, 5585.301837270341, 5614.410486898878, 5183.481651834824, 5510.0, 5526.314474085402, 5555.527780138683, 5564.443555644433, 4331.155424692186, 4331.523532411432, 4336.609705126546, 4338.327559228324, 4368.759718215497, 4352.825886964518, 4353.453229860535, 4354.412154359168, 4364.934525982113, 4381.123775244948, 4314.956850431487, 4355.433793606827, 4365.236083685342, 4366.148601022802, 4387.62705170061, 4133.73130746502, 4298.763568003758, 4306.8277268909205, 4321.336285530062, 4324.762138082404, 3781.0, 3806.7818298144607, 3817.1602247505502, 3834.3481608126685, 3872.9806350968065, 5354.785808567692, 5363.81995960888, 5402.6758394496455, 5410.349843297792, 5440.836774896759, 4708.952910470885, 4927.334809800667, 4945.9258111128365, 4948.604111671058, 4955.355803745526, 5770.105633626795, 5798.88402231953, 5802.274715660543, 5814.389489103668, 5840.7221183738375, 4194.706370554062, 4217.578242175789, 4223.788810559459, 4232.132412855388, 4241.936370954438, 5725.685087320196, 5791.0, 5904.704764761787, 6032.487238584726, 6033.245844269466, 4128.566500517462, 4142.5857414258335, 4157.355609880473, 4171.10321280926, 4182.017225951899, 4202.642775364128, 4215.241256573846, 4215.304474761691, 4219.599138081939, 4247.915041699149, 4671.789769460383, 4880.219164933594, 4927.507249275044, 4956.0, 4983.202687569971, 5836.88326233473, 5848.356680765112, 5897.5871688982215, 5899.498542623839, 5925.970370148121, 1503.3911265937313, 1530.4184409924158, 1536.3316957123686, 1543.529223586817, 1548.7599422089595, 969.1326262994721, 971.3783178765595, 972.8394814855469, 975.7950830325569, 976.2970661123979, 4993.925091123636, 5059.392872855281, 5072.721000345016, 5074.619403544749, 5076.263941728429, 5339.893202135935, 5432.641839540115, 5456.645318054314, 5479.328804714601, 5492.258545096361, 4771.328917976216, 5100.795968161232, 5115.693058416507, 5135.435102138762, 5136.512031357015, 2844.601755754196, 2873.626428564315, 2875.611792407998, 2878.3811480531785, 2884.22126025976, 5450.800823818753, 5461.563074953994, 5493.450654934554, 5504.366997795225, 5554.333919718558, 5114.23831131185, 5237.240600112962, 5257.474252574789, 5297.443768404339, 5329.813456529003, 5363.490468405495, 5389.11381016641, 5399.325084364455, 5410.945890541044, 5442.5849279186905, 5205.947940520547, 5217.50433708797, 5268.446813084571, 5323.574114070942, 5327.600429967691, 4820.783064762024, 5223.582113430993, 5617.297837770278, 5823.621464604787, 5833.737481813244, 6045.667488288011, 6049.909251361145, 6060.636361818305, 6114.357992410733, 6131.356207598138, 4325.502567204686, 4380.671449641226, 4384.495782984997, 4390.604845563915, 4406.9338959914985, 5798.971005144947, 5920.970395147997, 5941.22764040672, 5945.613535120204, 5985.306612024519, 5725.169850371756, 5758.539316854725, 5763.567732420001, 5830.4461076197695, 5855.882882342415, 5550.47270509301, 5757.683327416865, 5801.6519008859605, 5830.300363956352, 5863.853403664772, 5734.627249228787, 5750.424957504216, 5761.740721667619, 5785.595008349375, 5807.796727114531, 5858.794942177004, 5894.882102357843, 5925.348211696796, 5933.465988061095, 5945.732442040032, 5543.695096769717, 5661.660300381825, 5751.827445176651, 5764.13537969308, 5780.479756821738], "value": 4325.428851460978, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.3198333441575, 815.3803109636674, 815.9510429374238, 849.0405841399217, 854.5214679779324, 15388.384464621402, 16944.745828812564, 17389.39137130199, 18189.545261368472, 18196.363127290548, 15826.604334891634, 15827.841721582781, 15885.285162167702, 15927.920360398211, 15954.202289885488, 733.8422239218567, 838.8783626374203, 862.8317478091775, 864.9091845356241, 873.0919843362894, 881.951492667903, 882.2589025218815, 886.0342226972599, 886.7472770260478, 887.4763889305309, 910.3672947301628, 910.4901255297021, 912.6395073945787, 913.2237598041678, 913.5295322908707, 762.3862790453683, 893.9016708162097, 913.1918252346654, 913.2465715784438, 917.9495127767971, 678.7217240931194, 680.2721088435376, 680.6834821807884, 681.1859827506132, 681.6830173969128, 16283.837161628351, 16348.83651163485, 16420.917895410446, 16429.096399698014, 16432.589185270463, 13768.586942391745, 13940.0, 13976.720465590632, 13982.650433739238, 14059.0, 14427.567172984722, 14494.710105797825, 14579.92710036443, 14594.0, 14658.70682586353, 4698.506656801055, 4727.976360118178, 4737.478877323491, 4791.904161916742, 4802.903941921177, 75706.62146689286, 76136.61931690361, 76268.61865690691, 76982.0, 77025.22974770237, 11770.352630605228, 11931.284122952651, 12042.09684273683, 12262.141650084586, 12277.263364198177, 21323.57352852934, 21347.359579212647, 21364.679529807065, 21440.678389824167, 21445.249416270668, 8620.181082797124, 8706.406874161541, 8782.297416206817, 8803.031666516677, 8925.375223734276, 5028.522290382408, 5082.415522214993, 5124.538791508782, 5139.229115632685, 5233.058049551118, 3470.757047006736, 3544.8404821783083, 3565.0196196046295, 3569.3218288525095, 3570.6429357064085, 662.9602223866583, 671.1074271219267, 675.0717763075771, 677.7322957431787, 683.3030309084805, 669.648434571844, 705.4779463197198, 721.7762493626992, 724.692005897502, 741.669956869188, 9174.541272936327, 9751.463669498246, 9894.554745036347, 10090.798184036279, 10222.182225421948, 632.3486808587163, 681.117952251835, 708.922018577956, 715.4062128433388, 787.8700014497543, 4659.673822832369, 4994.40067191932, 5208.659558074232, 5612.971935140298, 5625.268715067097, 69093.0, 69698.3030169702, 71570.0, 71817.28182718105, 131731.0, 81657.0, 94076.0, 95768.0, 96377.5181124104, 97010.0, 83838.58080709679, 84338.5783071093, 85279.0, 85295.0, 86024.0, 9862.506874656381, 10239.641612543823, 10399.792004160026, 10508.211884108876, 10529.842052369373, 52884.471155289495, 53679.46320536744, 54008.18987715266, 54661.72669136629, 55882.720586396805, 47404.762976184895, 51197.744011279705, 52132.47867521428, 67343.66328168327, 77405.0, 13804.17174969505, 13812.171269723849, 13867.861321386657, 14026.859731402556, 14047.719045618825, 14600.269986500845, 15173.544793656209, 15592.37630494813, 15603.921980390025, 15672.294746736652, 14606.26968651542, 14687.207659083117, 14720.19038952868, 15096.094234345974, 15743.370265189264, 13131.474741010252, 14293.928530357281, 14362.210078445785, 14445.133292002514, 14925.10449373041, 14219.146851188962, 14476.710465790837, 14549.709005819612, 14790.482333118289, 15568.221588920735, 11548.711282217675, 11973.580924667594, 12219.906331379088, 12480.812787808009, 12527.937360313505, 12535.749285014432, 12562.497500099893, 12607.810882836948, 12933.870661293644, 12937.805932911202], "value": 7865.630117101074, "unit": "score"}], "name": "dromaeo_css", "value": 7663.3732915333385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 102.0, 109.0, 110.0, 111.0, 111.0, 110.0, 110.0, 108.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 133.0, 169.0, 126.0, 124.0, 149.0, 124.0, 188.0, 130.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 120.0, 75.0, 76.0, 75.0, 74.0, 104.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 84.0, 84.0, 84.0, 123.0, 84.0, 83.0, 138.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 80.0, 81.0, 76.0, 77.0, 78.0, 77.0, 101.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 126.0, 127.0, 123.0, 126.0, 117.0, 120.0, 131.0, 126.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 161.0, 153.0, 153.0, 157.0, 152.0, 155.0, 157.0, 152.0, 153.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 60.0, 62.0, 62.0, 61.0, 63.0, 63.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1482.4, "alertThreshold": 2.0}]} 03:42:48 INFO - Return code: 0 03:42:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:42:48 ERROR - # TBPL SUCCESS # 03:42:48 INFO - Running post-action listener: _resource_record_post_action 03:42:48 INFO - ##### 03:42:48 INFO - ##### Finished run-tests step (success) 03:42:48 INFO - ##### 03:42:48 INFO - Running post-run listener: _resource_record_post_run 03:42:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505077760; Read time: 16; Write time: 392820 03:42:48 INFO - TinderboxPrint: CPU usage
13.1% 03:42:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:42:48 INFO - TinderboxPrint: I/O write bytes / time
505,077,760 / 392,820 03:42:48 INFO - TinderboxPrint: CPU idle
8,256.9 (86.9%) 03:42:48 INFO - TinderboxPrint: CPU user
1,204.1 (12.7%) 03:42:48 INFO - TinderboxPrint: Swap in / out
0 / 0 03:42:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252674048; Read time: 0; Write time: 241608 03:42:48 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252403712; Read time: 16; Write time: 151212 03:42:48 INFO - Running post-run listener: _upload_blobber_files 03:42:48 INFO - Blob upload gear active. 03:42:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:42:48 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 03:42:48 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'] 03:42:48 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 03:42:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:42:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:50 INFO - (blobuploader) - INFO - Done attempting. 03:42:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:53 INFO - (blobuploader) - INFO - Done attempting. 03:42:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:42:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:54 INFO - (blobuploader) - INFO - Done attempting. 03:42:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:54 INFO - Return code: 0 03:42:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d0440ac15f1eb3506ca0bfe46d20ffdb7c8d110fb605cab3940edbefde0bc6496d8a1784a0cf72d1e1434c083ccafeea0f387eb56dcd606d6e92eaca803939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2633d7490065777455fa7b969b46ecff573682c647baaefdecbb8aac8a86d31acf24d7498d653ef4993e302ce8934d66dc2de3a3d595607569a56be0c1e4e23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e8dffc8a35263df7af2207252f26d2ff30624ced94c3baca6878e3cf2ba97953d0021869e313e331711714f49e2869a9eadfb2ceedbbbd6d623296231233a4b"} 03:42:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:54 INFO - Contents: 03:42:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d0440ac15f1eb3506ca0bfe46d20ffdb7c8d110fb605cab3940edbefde0bc6496d8a1784a0cf72d1e1434c083ccafeea0f387eb56dcd606d6e92eaca803939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2633d7490065777455fa7b969b46ecff573682c647baaefdecbb8aac8a86d31acf24d7498d653ef4993e302ce8934d66dc2de3a3d595607569a56be0c1e4e23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e8dffc8a35263df7af2207252f26d2ff30624ced94c3baca6878e3cf2ba97953d0021869e313e331711714f49e2869a9eadfb2ceedbbbd6d623296231233a4b"} 03:42:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:54 INFO - Copying logs to upload dir... 03:42:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.156252 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 03:42:53.959238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:42:53.962692) ========= 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=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d0440ac15f1eb3506ca0bfe46d20ffdb7c8d110fb605cab3940edbefde0bc6496d8a1784a0cf72d1e1434c083ccafeea0f387eb56dcd606d6e92eaca803939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2633d7490065777455fa7b969b46ecff573682c647baaefdecbb8aac8a86d31acf24d7498d653ef4993e302ce8934d66dc2de3a3d595607569a56be0c1e4e23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e8dffc8a35263df7af2207252f26d2ff30624ced94c3baca6878e3cf2ba97953d0021869e313e331711714f49e2869a9eadfb2ceedbbbd6d623296231233a4b"} build_url:https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011898 build_url: 'https://queue.taskcluster.net/v1/task/WV1NWfaCRXSxrQrjoXZb8w/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62d0440ac15f1eb3506ca0bfe46d20ffdb7c8d110fb605cab3940edbefde0bc6496d8a1784a0cf72d1e1434c083ccafeea0f387eb56dcd606d6e92eaca803939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2633d7490065777455fa7b969b46ecff573682c647baaefdecbb8aac8a86d31acf24d7498d653ef4993e302ce8934d66dc2de3a3d595607569a56be0c1e4e23d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e8dffc8a35263df7af2207252f26d2ff30624ced94c3baca6878e3cf2ba97953d0021869e313e331711714f49e2869a9eadfb2ceedbbbd6d623296231233a4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 03:42:53.988136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:42:53.988445) ========= 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=cbe409c6de289db6ac707de3000001d4-1467109302.925328-1125486819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 03:42:54.071109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:42:54.071435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 03:42:54.071720) ========= ========= Total master_lag: 0.34 =========