builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1462798442.31 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.310586) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.311043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.311312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.328693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.329033) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-09 05:54:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 154M=0s 2016-05-09 05:54:02 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.421663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.422003) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:02.470499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 05:54:02.470855) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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 307b5eca8726f6a72a1d69ba76630a6dbf402477 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-09 05:54:02,545 truncating revision to first 12 chars 2016-05-09 05:54:02,546 Setting DEBUG logging. 2016-05-09 05:54:02,546 attempt 1/10 2016-05-09 05:54:02,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:54:03,721 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.417099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 05:54:03.904891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:03.905214) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:03.905602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:03.905872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:03.920476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-09 05:54:03.920873) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:54:04 INFO - MultiFileLogger online at 20160509 05:54:04 in /builds/slave/test 05:54:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:54:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:04 INFO - {'append_to_log': False, 05:54:04 INFO - 'base_work_dir': '/builds/slave/test', 05:54:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:54:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:04 INFO - 'branch': 'Mozilla-Aurora', 05:54:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:04 INFO - 'config_files': ('talos/mac_config.py',), 05:54:04 INFO - 'default_actions': ('clobber', 05:54:04 INFO - 'read-buildbot-config', 05:54:04 INFO - 'download-and-extract', 05:54:04 INFO - 'populate-webroot', 05:54:04 INFO - 'create-virtualenv', 05:54:04 INFO - 'install', 05:54:04 INFO - 'run-tests'), 05:54:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:04 INFO - 'download_minidump_stackwalk': True, 05:54:04 INFO - 'download_symbols': 'ondemand', 05:54:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:04 INFO - 'installer_path': 'installer.exe', 05:54:04 INFO - 'log_level': 'info', 05:54:04 INFO - 'log_name': 'talos', 05:54:04 INFO - 'log_to_console': True, 05:54:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:54:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:54:04 INFO - 'opt_config_files': (), 05:54:04 INFO - 'pip_index': False, 05:54:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:04 INFO - 'cmd': ('bash', 05:54:04 INFO - '-c', 05:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:04 INFO - 'enabled': True, 05:54:04 INFO - 'halt_on_failure': False, 05:54:04 INFO - 'name': 'check_screen_resolution'},), 05:54:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:54:04 INFO - 'cmd': ('bash', 05:54:04 INFO - '-c', 05:54:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:54:04 INFO - 'enabled': True, 05:54:04 INFO - 'halt_on_failure': False, 05:54:04 INFO - 'name': 'check_screen_resolution'},), 05:54:04 INFO - 'run_cmd_checks_enabled': True, 05:54:04 INFO - 'sps_profile': False, 05:54:04 INFO - 'sps_profile_interval': 0, 05:54:04 INFO - 'suite': 'dromaeojs-e10s', 05:54:04 INFO - 'system_bits': '32', 05:54:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:04 INFO - 'title': 't-yosemite-r7-0072', 05:54:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:04 INFO - 'use_talos_json': True, 05:54:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:04 INFO - 'work_dir': 'build'} 05:54:04 INFO - ##### 05:54:04 INFO - ##### Running clobber step. 05:54:04 INFO - ##### 05:54:04 INFO - Running pre-action listener: _resource_record_pre_action 05:54:04 INFO - Running main action method: clobber 05:54:04 INFO - rmtree: /builds/slave/test/build 05:54:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:04 INFO - Running post-action listener: _resource_record_post_action 05:54:04 INFO - ##### 05:54:04 INFO - ##### Running read-buildbot-config step. 05:54:04 INFO - ##### 05:54:04 INFO - Running pre-action listener: _resource_record_pre_action 05:54:04 INFO - Running main action method: read_buildbot_config 05:54:04 INFO - Using buildbot properties: 05:54:04 INFO - { 05:54:04 INFO - "project": "", 05:54:04 INFO - "product": "firefox", 05:54:04 INFO - "script_repo_revision": "production", 05:54:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:54:04 INFO - "repository": "", 05:54:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:54:04 INFO - "buildid": "20160509005049", 05:54:04 INFO - "pgo_build": "False", 05:54:04 INFO - "basedir": "/builds/slave/test", 05:54:04 INFO - "buildnumber": 3, 05:54:04 INFO - "slavename": "t-yosemite-r7-0072", 05:54:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:54:04 INFO - "platform": "yosemite_r7", 05:54:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:54:04 INFO - "branch": "mozilla-aurora", 05:54:04 INFO - "repo_path": "releases/mozilla-aurora", 05:54:04 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 05:54:04 INFO - "stage_platform": "macosx64", 05:54:04 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 05:54:04 INFO - "slavebuilddir": "test" 05:54:04 INFO - } 05:54:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 05:54:04 INFO - Running post-action listener: _resource_record_post_action 05:54:04 INFO - ##### 05:54:04 INFO - ##### Running download-and-extract step. 05:54:04 INFO - ##### 05:54:04 INFO - Running pre-action listener: _resource_record_pre_action 05:54:04 INFO - Running main action method: download_and_extract 05:54:04 INFO - mkdir: /builds/slave/test/build/tests 05:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:04 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 05:54:06 INFO - Downloaded 1199 bytes. 05:54:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 05:54:06 INFO - Using the following test package requirements: 05:54:06 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:06 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 05:54:06 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 05:54:06 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'jsshell-mac.zip'], 05:54:06 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 05:54:06 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 05:54:06 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 05:54:06 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 05:54:06 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 05:54:06 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 05:54:06 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 05:54:06 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:54:06 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')]} 05:54:06 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:07 INFO - Downloaded 18088795 bytes. 05:54:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:54:10 INFO - Return code: 0 05:54:10 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:10 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:54:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 05:54:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:54:12 INFO - Downloaded 18088795 bytes. 05:54:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:54:15 INFO - Return code: 0 05:54: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')]} 05:54:15 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 05:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:54:17 INFO - Downloaded 10840145 bytes. 05:54:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:54:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:54:17 INFO - Return code: 0 05:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:17 INFO - https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 05:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 05:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 05:54:20 INFO - Downloaded 114085322 bytes. 05:54:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:20 INFO - mkdir: /builds/slave/test/properties 05:54:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:20 INFO - Contents: 05:54:20 INFO - build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 05:54:22 INFO - Running post-action listener: _resource_record_post_action 05:54:22 INFO - Running post-action listener: set_extra_try_arguments 05:54:22 INFO - ##### 05:54:22 INFO - ##### Running populate-webroot step. 05:54:22 INFO - ##### 05:54:22 INFO - Running pre-action listener: _resource_record_pre_action 05:54:22 INFO - Running main action method: populate_webroot 05:54:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:22 INFO - '--tppagecycles', 05:54:22 INFO - '7'], 05:54:22 INFO - 'tests': ['tsvgm']}}, 05:54:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['damp', 'tps']}, 05:54:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'tests': ['damp', 'tps']}, 05:54:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['dromaeo_dom']}, 05:54:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['a11yr', 05:54:22 INFO - 'ts_paint', 05:54:22 INFO - 'tpaint', 05:54:22 INFO - 'sessionrestore', 05:54:22 INFO - 'sessionrestore_no_auto_restore', 05:54:22 INFO - 'tabpaint']}, 05:54:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['tsvgx', 05:54:22 INFO - 'tsvgr_opacity', 05:54:22 INFO - 'tart', 05:54:22 INFO - 'tscrollx', 05:54:22 INFO - 'cart']}, 05:54:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:22 INFO - 'tsvgr_opacity', 05:54:22 INFO - 'tart', 05:54:22 INFO - 'tscrollx', 05:54:22 INFO - 'cart']}, 05:54:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'talos_options': ['--disable-e10s'], 05:54:22 INFO - 'tests': ['tp5o']}, 05:54:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'tests': ['tp5o']}, 05:54:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'talos_options': ['--disable-e10s', 05:54:22 INFO - '--xperf_path', 05:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:22 INFO - 'tests': ['tp5n']}, 05:54:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:22 INFO - 'talos_options': ['--xperf_path', 05:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:22 INFO - 'tests': ['tp5n']}}, 05:54:22 INFO - 'talos.zip': {'path': '', 05:54:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:22 INFO - Running post-action listener: _resource_record_post_action 05:54:22 INFO - ##### 05:54:22 INFO - ##### Running create-virtualenv step. 05:54:22 INFO - ##### 05:54:22 INFO - Running pre-action listener: _resource_record_pre_action 05:54:22 INFO - Running main action method: create_virtualenv 05:54:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:22 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 05:54:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:22 INFO - Using real prefix '/tools/python27' 05:54:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:26 INFO - Installing pip.................done. 05:54:26 INFO - Return code: 0 05:54:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 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 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:26 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 05:54:26 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 05:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:26 INFO - 'HOME': '/Users/cltbld', 05:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:26 INFO - 'LOGNAME': 'cltbld', 05:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:26 INFO - 'MOZ_NO_REMOTE': '1', 05:54:26 INFO - 'NO_EM_RESTART': '1', 05:54:26 INFO - 'PAGER': '/bin/cat', 05:54:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:26 INFO - 'PWD': '/builds/slave/test', 05:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:26 INFO - 'SHELL': '/bin/bash', 05:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:26 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:26 INFO - 'USER': 'cltbld', 05:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:26 INFO - 'XPC_FLAGS': '0x0', 05:54:26 INFO - 'XPC_SERVICE_NAME': '0', 05:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:26 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 05:54:26 INFO - Cleaning up... 05:54:26 INFO - Return code: 0 05:54:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:26 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:26 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>=0.7.1'] in /builds/slave/test/build 05:54:26 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>=0.7.1 05:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:26 INFO - 'HOME': '/Users/cltbld', 05:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:26 INFO - 'LOGNAME': 'cltbld', 05:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:26 INFO - 'MOZ_NO_REMOTE': '1', 05:54:26 INFO - 'NO_EM_RESTART': '1', 05:54:26 INFO - 'PAGER': '/bin/cat', 05:54:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:26 INFO - 'PWD': '/builds/slave/test', 05:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:26 INFO - 'SHELL': '/bin/bash', 05:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:26 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:26 INFO - 'USER': 'cltbld', 05:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:26 INFO - 'XPC_FLAGS': '0x0', 05:54:26 INFO - 'XPC_SERVICE_NAME': '0', 05:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:26 INFO - Downloading/unpacking psutil>=0.7.1 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:26 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 05:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:29 INFO - Installing collected packages: psutil 05:54:29 INFO - Running setup.py install for psutil 05:54:29 INFO - building 'psutil._psutil_osx' extension 05:54:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:54:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:54:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:54:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:54:30 INFO - building 'psutil._psutil_posix' extension 05:54:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:54:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:54:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:54:30 INFO - ^ 05:54:30 INFO - 1 warning generated. 05:54:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:54:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:30 INFO - Successfully installed psutil 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:30 INFO - 'HOME': '/Users/cltbld', 05:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PAGER': '/bin/cat', 05:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:30 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - 'XPC_FLAGS': '0x0', 05:54:30 INFO - 'XPC_SERVICE_NAME': '0', 05:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:54:33 INFO - Installing collected packages: mozsystemmonitor 05:54:33 INFO - Running setup.py install for mozsystemmonitor 05:54:33 INFO - Successfully installed mozsystemmonitor 05:54:33 INFO - Cleaning up... 05:54:33 INFO - Return code: 0 05:54:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:33 INFO - 'HOME': '/Users/cltbld', 05:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:33 INFO - 'LOGNAME': 'cltbld', 05:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:33 INFO - 'MOZ_NO_REMOTE': '1', 05:54:33 INFO - 'NO_EM_RESTART': '1', 05:54:33 INFO - 'PAGER': '/bin/cat', 05:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:33 INFO - 'PWD': '/builds/slave/test', 05:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:33 INFO - 'SHELL': '/bin/bash', 05:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:33 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:33 INFO - 'USER': 'cltbld', 05:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:33 INFO - 'XPC_FLAGS': '0x0', 05:54:33 INFO - 'XPC_SERVICE_NAME': '0', 05:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:36 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 05:54:37 INFO - Downloading docopt-0.6.1.tar.gz 05:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:37 INFO - Running setup.py install for blobuploader 05:54:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:37 INFO - Running setup.py install for requests 05:54:38 INFO - Running setup.py install for docopt 05:54:38 INFO - Successfully installed blobuploader requests docopt 05:54:38 INFO - Cleaning up... 05:54:38 INFO - Return code: 0 05:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:38 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')]} 05:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 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')]} 05:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 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 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:38 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 05:54:38 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 05:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:38 INFO - 'HOME': '/Users/cltbld', 05:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:38 INFO - 'LOGNAME': 'cltbld', 05:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:38 INFO - 'MOZ_NO_REMOTE': '1', 05:54:38 INFO - 'NO_EM_RESTART': '1', 05:54:38 INFO - 'PAGER': '/bin/cat', 05:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:38 INFO - 'PWD': '/builds/slave/test', 05:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:38 INFO - 'SHELL': '/bin/bash', 05:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:38 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:38 INFO - 'USER': 'cltbld', 05:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:38 INFO - 'XPC_FLAGS': '0x0', 05:54:38 INFO - 'XPC_SERVICE_NAME': '0', 05:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:38 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MRWHSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:38 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-M1x5cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:38 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-2UK304-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:38 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MzmzPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-VSPKxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7OsLOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-My3lUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rEiOqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Ui70Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-tOBcmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jItJPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4rB4RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ov1HmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:39 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-HZXI_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jPd8NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ymB6fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:40 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ff7MMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:40 INFO - Running setup.py install for manifestparser 05:54:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:40 INFO - Running setup.py install for mozcrash 05:54:40 INFO - Running setup.py install for mozdebug 05:54:40 INFO - Running setup.py install for mozdevice 05:54:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:40 INFO - Running setup.py install for mozfile 05:54:41 INFO - Running setup.py install for mozhttpd 05:54:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Running setup.py install for mozinfo 05:54:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Running setup.py install for mozInstall 05:54:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Running setup.py install for mozleak 05:54:41 INFO - Running setup.py install for mozlog 05:54:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:41 INFO - Running setup.py install for moznetwork 05:54:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozprocess 05:54:42 INFO - Running setup.py install for mozprofile 05:54:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozrunner 05:54:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Running setup.py install for mozscreenshot 05:54:42 INFO - Running setup.py install for moztest 05:54:42 INFO - Running setup.py install for mozversion 05:54:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:42 INFO - Cleaning up... 05:54:42 INFO - Return code: 0 05:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:42 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 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:42 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 05:54:42 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 05:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:42 INFO - 'HOME': '/Users/cltbld', 05:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:42 INFO - 'LOGNAME': 'cltbld', 05:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:42 INFO - 'MOZ_NO_REMOTE': '1', 05:54:42 INFO - 'NO_EM_RESTART': '1', 05:54:42 INFO - 'PAGER': '/bin/cat', 05:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:42 INFO - 'PWD': '/builds/slave/test', 05:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:42 INFO - 'SHELL': '/bin/bash', 05:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:42 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:42 INFO - 'USER': 'cltbld', 05:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:42 INFO - 'XPC_FLAGS': '0x0', 05:54:42 INFO - 'XPC_SERVICE_NAME': '0', 05:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-pzb2CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-JPJIWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-hfNE_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-iyMYOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-_hn3ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-lxe4Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:43 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)) 05:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TdErD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TwY6lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-uW5nIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-VXCGVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-V6r_7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-toY281-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-dFEGAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-RDQRdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nVw8Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-VNYm12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:44 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)) 05:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-dGXWC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:47 INFO - Downloading blessings-1.6.tar.gz 05:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:47 INFO - Installing collected packages: blessings 05:54:47 INFO - Running setup.py install for blessings 05:54:47 INFO - Successfully installed blessings 05:54:47 INFO - Cleaning up... 05:54:47 INFO - Return code: 0 05:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:48 INFO - Reading from file tmpfile_stdout 05:54:48 INFO - Current package versions: 05:54:48 INFO - blessings == 1.6 05:54:48 INFO - blobuploader == 1.2.4 05:54:48 INFO - docopt == 0.6.1 05:54:48 INFO - manifestparser == 1.1 05:54:48 INFO - mozInstall == 1.12 05:54:48 INFO - mozcrash == 0.17 05:54:48 INFO - mozdebug == 0.1 05:54:48 INFO - mozdevice == 0.48 05:54:48 INFO - mozfile == 1.2 05:54:48 INFO - mozhttpd == 0.7 05:54:48 INFO - mozinfo == 0.9 05:54:48 INFO - mozleak == 0.1 05:54:48 INFO - mozlog == 3.1 05:54:48 INFO - moznetwork == 0.27 05:54:48 INFO - mozprocess == 0.22 05:54:48 INFO - mozprofile == 0.28 05:54:48 INFO - mozrunner == 6.11 05:54:48 INFO - mozscreenshot == 0.1 05:54:48 INFO - mozsystemmonitor == 0.0 05:54:48 INFO - moztest == 0.7 05:54:48 INFO - mozversion == 1.4 05:54:48 INFO - psutil == 3.1.1 05:54:48 INFO - requests == 1.2.3 05:54:48 INFO - wsgiref == 0.1.2 05:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:48 INFO - 'HOME': '/Users/cltbld', 05:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PAGER': '/bin/cat', 05:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:48 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - 'XPC_FLAGS': '0x0', 05:54:48 INFO - 'XPC_SERVICE_NAME': '0', 05:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:54:48 INFO - Cleaning up... 05:54:48 INFO - Return code: 0 05:54:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:54:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:48 INFO - 'HOME': '/Users/cltbld', 05:54:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PAGER': '/bin/cat', 05:54:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:48 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - 'XPC_FLAGS': '0x0', 05:54:48 INFO - 'XPC_SERVICE_NAME': '0', 05:54:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:48 INFO - Downloading/unpacking jsonschema 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:51 INFO - Downloading/unpacking functools32 (from jsonschema) 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:51 INFO - warning: no files found matching '*.txt' 05:54:51 INFO - no previously-included directories found matching 'build' 05:54:51 INFO - no previously-included directories found matching 'dist' 05:54:51 INFO - no previously-included directories found matching '.git*' 05:54:51 INFO - Installing collected packages: jsonschema, functools32 05:54:51 INFO - Running setup.py install for functools32 05:54:51 INFO - warning: no files found matching '*.txt' 05:54:51 INFO - no previously-included directories found matching 'build' 05:54:51 INFO - no previously-included directories found matching 'dist' 05:54:51 INFO - no previously-included directories found matching '.git*' 05:54:51 INFO - Successfully installed jsonschema functools32 05:54:51 INFO - Cleaning up... 05:54:51 INFO - Return code: 0 05:54:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:54:51 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')]} 05:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 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')]} 05:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:51 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 0x10cdaaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdba420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61586bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:54:51 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 05:54:51 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 05:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:51 INFO - 'HOME': '/Users/cltbld', 05:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:51 INFO - 'LOGNAME': 'cltbld', 05:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:51 INFO - 'MOZ_NO_REMOTE': '1', 05:54:51 INFO - 'NO_EM_RESTART': '1', 05:54:51 INFO - 'PAGER': '/bin/cat', 05:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:51 INFO - 'PWD': '/builds/slave/test', 05:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:51 INFO - 'SHELL': '/bin/bash', 05:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:54:51 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:51 INFO - 'USER': 'cltbld', 05:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:51 INFO - 'XPC_FLAGS': '0x0', 05:54:51 INFO - 'XPC_SERVICE_NAME': '0', 05:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:52 INFO - Downloading/unpacking flake8 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:54:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:54:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:54 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 05:54:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:54:55 INFO - no previously-included directories found matching 'docs/_build' 05:54:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:54:55 INFO - Running setup.py install for pep8 05:54:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:54:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:54:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:54:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:54:56 INFO - no previously-included directories found matching 'docs/_build' 05:54:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:54:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:54:56 INFO - Cleaning up... 05:54:56 INFO - Return code: 0 05:54:56 INFO - Running post-action listener: _resource_record_post_action 05:54:56 INFO - Running post-action listener: _start_resource_monitoring 05:54:56 INFO - Starting resource monitoring. 05:54:56 INFO - ##### 05:54:56 INFO - ##### Running install step. 05:54:56 INFO - ##### 05:54:56 INFO - Running pre-action listener: _resource_record_pre_action 05:54:56 INFO - Running main action method: install 05:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:56 INFO - Reading from file tmpfile_stdout 05:54:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:56 INFO - Reading from file tmpfile_stdout 05:54:56 INFO - Output received: 05:54:56 INFO - Usage: mozinstall [options] installer 05:54:56 INFO - Options: 05:54:56 INFO - -h, --help show this help message and exit 05:54:56 INFO - -d DEST, --destination=DEST 05:54:56 INFO - Directory to install application into. [default: 05:54:56 INFO - "/builds/slave/test"] 05:54:56 INFO - --app=APP Application being installed. [default: firefox] 05:54:56 INFO - mkdir: /builds/slave/test/build/application 05:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:55:29 INFO - Reading from file tmpfile_stdout 05:55:29 INFO - Output received: 05:55:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:55:29 INFO - Running post-action listener: _resource_record_post_action 05:55:29 INFO - ##### 05:55:29 INFO - ##### Running run-tests step. 05:55:29 INFO - ##### 05:55:29 INFO - Running pre-action listener: _resource_record_pre_action 05:55:29 INFO - Running main action method: run_tests 05:55:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:29 INFO - 2016-05-09 05:55:29.455 screenresolution[1954:12801] starting screenresolution argv=screenresolution get 05:55:29 INFO - 2016-05-09 05:55:29.458 screenresolution[1954:12801] Display 0: 1600x1200x32@60 05:55:29 INFO - 2016-05-09 05:55:29.463 screenresolution[1955:12803] starting screenresolution argv=screenresolution list 05:55:29 INFO - Available Modes on Display 0 05:55:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:29 INFO - Intel Iris: 05:55:29 INFO - Chipset Model: Intel Iris 05:55:29 INFO - Type: GPU 05:55:29 INFO - Bus: Built-In 05:55:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:29 INFO - Vendor: Intel (0x8086) 05:55:29 INFO - Device ID: 0x0a2e 05:55:29 INFO - Revision ID: 0x0009 05:55:29 INFO - Displays: 05:55:29 INFO - Display: 05:55:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:29 INFO - Display Serial Number: 1600x1200 60 05:55:29 INFO - Main Display: Yes 05:55:29 INFO - Mirror: Off 05:55:29 INFO - Online: Yes 05:55:29 INFO - Rotation: Supported 05:55:29 INFO - Return code: 0 05:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:29 INFO - Python 2.7.3 05:55:29 INFO - Return code: 0 05:55:29 INFO - grabbing minidump binary from tooltool 05:55: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')]} 05:55:29 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc49e00>, '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 0x10cab2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc44b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:29 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:55:29 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:55:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:29 INFO - Return code: 0 05:55:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:55:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:55:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:55:30 INFO - Return code: 0 05:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RvsJPFdTV7/Render', 05:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:55:30 INFO - 'HOME': '/Users/cltbld', 05:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:55:30 INFO - 'LOGNAME': 'cltbld', 05:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:30 INFO - 'MOZ_NO_REMOTE': '1', 05:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:30 INFO - 'NO_EM_RESTART': '1', 05:55:30 INFO - 'PAGER': '/bin/cat', 05:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:30 INFO - 'PWD': '/builds/slave/test', 05:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:55:30 INFO - 'SHELL': '/bin/bash', 05:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners', 05:55:30 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:55:30 INFO - 'USER': 'cltbld', 05:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:30 INFO - 'XPC_FLAGS': '0x0', 05:55:30 INFO - 'XPC_SERVICE_NAME': '0', 05:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:55:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:55:31 INFO - mozversion application_buildid: 20160509005049 05:55:31 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:55:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:31 INFO - mozversion application_name: Firefox 05:55:31 INFO - mozversion application_remotingname: firefox-dev 05:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:55:31 INFO - mozversion application_vendor: Mozilla 05:55:31 INFO - mozversion application_version: 48.0a2 05:55:31 INFO - mozversion platform_buildid: 20160509005049 05:55:31 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:55:31 INFO - mozversion platform_version: 48.0a2 05:55:31 INFO - using testdate: 1462798531 05:55:31 INFO - actual date: 1462798531 05:55:31 INFO - starting webserver on 'localhost:49511' 05:55:31 INFO - SUITE-START | Running 2 tests 05:55:31 INFO - TEST-START | dromaeo_css 05:55:31 INFO - operating with platform_type : mac_ 05:55:31 INFO - Initialising browser for dromaeo_css test... 05:55:31 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpXXULqA/profile http://localhost:49511/getInfo.html) 05:55:33 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 05:55:33 INFO - PROCESS | 1973 | colorDepth:24 05:55:33 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 05:55:33 INFO - PROCESS | 1973 | __metrics 05:55:33 ERROR - PROCESS | 1973 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:55:34 INFO - TEST-INFO | 1973: exit 0 05:55:34 INFO - Browser initialized. 05:55:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:34 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpXXULqA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:46 INFO - PROCESS | 1976 | RSS: Main: 220839936 05:55:46 INFO - PROCESS | 1976 | 05:56:36 INFO - PROCESS | 1976 | 1462798596114 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] 05:58:47 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49511/tests/dromaeo/cssquery-ext.html) 05:58:48 INFO - PROCESS | 1976 | RSS: Main: 234487808 05:58:48 INFO - PROCESS | 1976 | 06:01:50 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-ext.html (next: http://localhost:49511/tests/dromaeo/cssquery-jquery.html) 06:01:51 INFO - PROCESS | 1976 | RSS: Main: 245964800 06:01:51 INFO - PROCESS | 1976 | 06:04:53 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49511/tests/dromaeo/cssquery-mootools.html) 06:04:53 INFO - PROCESS | 1976 | RSS: Main: 247848960 06:04:53 INFO - PROCESS | 1976 | 06:07:55 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49511/tests/dromaeo/cssquery-prototype.html) 06:07:56 INFO - PROCESS | 1976 | RSS: Main: 249536512 06:07:56 INFO - PROCESS | 1976 | 06:10:58 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49511/tests/dromaeo/cssquery-yui.html) 06:10:59 INFO - PROCESS | 1976 | RSS: Main: 252518400 06:10:59 INFO - PROCESS | 1976 | 06:14:01 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-yui.html (next: http://localhost:49511/tests/dromaeo/cssquery-dojo.html) 06:14:02 INFO - PROCESS | 1976 | RSS: Main: 253808640 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | __start_tp_report 06:14:02 INFO - PROCESS | 1976 | _x_x_mozilla_page_load 06:14:02 INFO - PROCESS | 1976 | _x_x_mozilla_page_load_details 06:14:02 INFO - PROCESS | 1976 | |i|pagename|runs| 06:14:02 INFO - PROCESS | 1976 | |0;dojo.html;3424.1439640089975;3426.760126791124;3447.172678557144;3494.563179602548;3495.5106285120087;5704;5739.741711622982;5743.770249190038;5767.221425107609;5811.186433899252;5683.602147849652;5710.371859095496;5721.742521586528;5740.885182296352;5785.623934444258;5168.948310516894;5225.790968361261;5280.102382594968;5298.496642818926;5335.7865685372535;4833.830815921444;5312.57499400049;5319.9734001330135;5345.599080068991;5366.865828354303;5262.684238945656;5291.2327712481665;5292.973535132338;5293.126634105387;5314.5748340132695;4710.081534100869;5228.2941802856885;5260.92108618371;5376.731163441851;5413.2692086568595;5213.947860521384;5251.343582052244;5308.70802105884;5312.123499622558;5349.7057661828585;4735.715857048588;5480.698561579112;5631.971840140773;5678.205051292823;5708;5316.229146773696;5972.910406343908;6015.2781666200335;6217.6891155442045;6241.282252540925;6194.4115309045565;6195.628262304276;6208.782692605782;6216.067589861512;6225.844353891143;5728.942710572883;5745.540356771448;5780.161876527922;5785.82642520725;5816.534677225812;6207.596506227081;6229.501639868799;6286.654234017173;6300.432961033437;6301.747930082745;6165.876682466325;6173.629582225081;6201.286852012076;6208.068789681584;6222.751089956441;6145.156453064063;6229.595076320115;6238.781642642486;6249.562530622904;6257.061440783918;6099.237595300588;6197.876042479125;6206.472449841724;6231.688415579293;6246.562740608114;6199.876002479925;6229.501639868799;6232.407921247474;6233.594816336924;6248.218972628421;4159.584041595876;4847.878803029882;4934.432540257916;4944.826931057396;4958.925616115761;3660.762050466711;4434.002349471343;4442.200403927324;4452.755098469551;4478.171538265431;4864.73243971585;5780.913286300709;5830.096335068071;5842.766289348463;5873.559483038789;5064.5441910228255;6108.433136212241;6155;6160.8767824643255;6204.906926396107;5655.4344565543115;5738.340090889601;5830.329512106077;5842.5618078644275;5873;5412.539934105566;5441.211024401439;5445.237666726662;5448.509634132947;5459.235707001023;6261.342559031236;6321.273053598711;6360.173177486897;6441.5490915635455;6475.449586785082;6113.411090322682;6120.203342909657;6144.262688477412;6163.96918015407;6173;6424.646644434601;6426.614403135827;6454.644994525346;6460.3862633049785;6467.320931302145;6024.518038556993;6030.668313242813;6094.421030002142;6100.908486372797;6121.755129794937;6165.907511387422;6167.753289868355;6176.258848938156;6177.62934223948;6203.503719702503;6056.727447264796;6075.726592303446;6075.756969721162;6083.847903802441;6105.633661980295;5118.38579370478;5949.8215053548465;5979.671118088547;6068;6172.567920245539;5968.97015514937;6028.5177185825905;6083.209182806207;6101.60339577926;6120.051392034242;5010.722265822192;6147.907781383372;6174.38256174379;6205.503559715302;6220.688965551795;5751.338596061507;6009.399060093956;6096.29892562361;6118.632882027093;6142.262928448615 06:14:02 INFO - PROCESS | 1976 | |1;ext.html;516.1225915942898;534.9251104845321;542.8859939412728;568.4258898512501;595.6894831370985;38396.42405363922;39529.60470395295;39566.604333956726;39579.60420395802;39650.42272252301;39657.80171099148;40196.59803401965;40222;40279;40304.59695403045;9428.528573571328;9618.663346782863;9665.4200747955;9669.323147379686;9678.56446459911;9574.760630984212;9757.707268781947;9839.45882976436;9848.310618256724;9872.703818885446;9779.364341317827;9795.608175672964;9863.704088877344;9863.901360986405;9884.505774711271;7703.499272547322;8255.876161857577;9121.315901307362;9753.512324383788;9818.410895346302;9605.37565058276;9733.610655573768;9775.804483910353;9780.902190978142;9802.411855288705;39605.80197099025;39631.80184099061;39706.40440393367;40033;40132.79933600342;2748.4503099380004;3119.906402807919;3154.3375891062906;3188.1551388881967;3402.7447941404494;28713.712862871314;28843.42313153746;29073.85463072692;29166.27084322909;29372.559411608843;2747.079728291025;2769.57071653894;2771.362586605092;2809.9578506322423;2812.2969257685577;470841;474232;474505;475245;475860;60095;60214.69892650596;60713;60819.087713684334;60829.69585152046;63247;63488.68255658692;71031.64484177546;75242.62378688072;75335.24664753392;17368.91315543414;17754.467365979042;17897.19462624185;17976.640467190846;18148;13628.863711362957;13691.726165476635;13775.586732398044;13813.447462101605;13834.584962451143;19727.816331020185;19730;19907.701384479245;19914.701279480818;19923.701144482846;8504.404691671647;8631.842039490128;8689.348298877609;8704.521251331238;8712.2575484902;844.0420123160258;899.9280057595377;960.3805545423163;965.6330594374093;1019.5463018956641;25868.611970820453;26107.477850442883;26640.534770587416;26710.798014089414;26796;1026.7022563456662;1051.6792378324685;1056.5932116135343;1073.8013467508536;1096.2928910852615;12357.640659527446;12950.769676880682;13468.730625387438;13642.795358069638;13871.791923121162;632495;640411;647377;649420;652665;59902.70048649816;61751;61834;61877.690611546655;61903.6904815473;1512.455516014234;1515.7953676253785;1525.1459182857636;1532.371727591682;1532.3793863485307;26900.327491812863;27550.311242219104;27841.721582784725;27961.580576290966;27992.160235192976;50837.729056773875;51008.74495627498;51746.22380664218;51863;51952.740236298574;599840;600500;604024;604839;606212;25572.616410754224;25963.22110336693;26017.869910650326;26024.089156879418;42614.57385426106;31140.22149446282;35912.82043589765;37267.06832329105;41819.581804181566;43356.78321608498;31711.04866853998;33686.66313336933;38233.23533529258;38346.84959451221;38360.42459363167;36706.26587468182;36815;36967;37665.62334376621;37890;34159.97520074302;37384.87845364644;38009.23981520409;38471.80764096162;39325.01687457837;29794.553081704224;31046.22384440407;31784.68215317817;32115.839420802746;32309.838450808536;24738.876305618356;25101.497970040862;25252;25419.491610168065;25764 06:14:02 INFO - PROCESS | 1976 | |2;jquery.html;388.8347452332758;390.5411141908258;392.21165457430556;404.7146761533119;407.42959856201315;14644.633884152901;16053.759193612104;19896.20415183393;20578.588428231444;20595.27916522922;11856.466459009343;12389.19470234434;19592.60814783707;19897.502562435948;19904.900475497638;5138.100832354332;5325.600579956499;5328.17413300939;5348.010618035656;5349.251104845324;5325.3077099976945;5360.3299587551555;5386.084365657828;5865.149553314767;5963.344032156459;5878.617889837168;5879.382664820175;5908;5912.556558258148;5926.199963005004;5306.6285360025;5367.436419176009;5375.543078838304;5889.1755154278435;5896.204012458327;4516.841910533149;5220.26916231724;5257.342832145981;5259.237410575445;5261.631685781997;13696.246706431142;16495.587610309838;22341.54779939299;25549.489010219877;25855.482890342275;1912.6079153773444;2047.5597746484427;2058.588282343522;2200.4938864061355;2682.4366882954605;9643.903560964442;9920.079424174734;10294.742631434274;10349.58601655933;10363.585456581728;1741.9564510887203;1774.8136445673276;1816.527702797269;1822.1253798176817;1868.2807119259182;110932.4453377736;116023;116899.4155029228;120633;120765.39617301857;10561.471926403648;11106.389148596905;11770.88229117715;11893.524259029715;12030.218035827644;14923.328450219766;15142.848571514143;15308.464203753038;15397.692046159014;15398;9073.45559266446;9103.726888193365;9113.681021164228;9135.132162444557;9171.220446262008;7414.332710056121;9069.59186836594;9145.131212534798;9173.81652366949;9174.357794954423;3912.471816304819;4268.893277668021;4730.479647238801;4773.904521909542;4775.880602984884;1699.9745003824953;1721.3975108712102;1855.7751883756926;1982.415187519685;2091.623507768586;758.4084414156966;851.0595940794084;869.8782170496136;894.8120894612074;931.8229536388064;18856.34002809895;19131.947742873996;19218.231270749293;19572.608547828964;19734.506637334183;890.123228619809;907.6051917415813;943.429225318686;967.4485543240426;974.35205588283;10141.2394070445;10293.485325733684;10371.688849334532;10395.16838652906;10536.157107431387;530183.3490832521;534509;542890;641984;648988;111808.4409577947;113174;126016.73983260234;129305.35347323203;131630;1026.9383836969805;1061.1298735037196;1063.2344711807486;1067.0556557446716;1068.3269540189785;17660.02869842171;17782.822171778116;17853.553661158574;17978.190981405605;18274.72587911209;41442.37836432516;50049.49950500594;50746.238806418674;52546.73726631342;52567.68580785358;72632;76164.90222941835;77094;77496.2250377489;77576.2242377569;7812.726554570563;7848.529088254723;7966.522008679498;8006.799830004296;8051.919480805117;9998.750031249278;11873.584424545099;12070.698232544257;12301.692457688629;12377;8287.62705678258;9634;9986.800263994824;10008.599656013677;10109;10351.120154786626;10376.481175941324;10504;10529.36823790575;10772.461376931278;6015.699215039318;9349.953250233706;10088.445135517617;10110.39337639744;10181.185505159718;7555.13115991646;7557.470977031555;7704.730334438268;7944.523328600302;8152.899358586752;7742.109657389247;9208.355415121145;10433.478326083818;10529.210309226686;10556 06:14:02 INFO - PROCESS | 1976 | |3;mootools.html;1413.7313910357032;1546.134164867674;1747;1884.189798386694;1934.7291379206904;7058.505904586681;7311.963440182792;7892.605369731505;8603.397762156645;8850.291976641869;8580.957095214531;8594.269487093605;8601;8718.564071796416;8724.432911860724;2468.6297055441646;2474.084588702183;2504.3864253257975;2505.24842547236;2510.79913606911;2090.8954552272403;2437.2079074300837;2485.6271559266074;2498.000799680124;2499.350168956066;2465.3959779853963;2493.127405408111;2508.184839927022;2508.761667641571;2515.8993640254366;2469.777720005199;2483.5777917754026;2487.962680559784;2503.1864643990684;2505.0731229445223;2442.3771938155833;2473.5052989402193;2476.0962248779247;2482.8758562072003;2496.7253602103756;8809.427387219874;8856.380053396264;8875.156860098281;8905.064968178378;8914.420562663407;5451.209574611659;5573.164025396182;5573.944260557424;5581.665100094007;5600.299962504687;3515.5781306243157;3527.400341941876;3596.3886139356373;3623.4202527595457;3659.6889264412557;1037.8962103789636;1054.4411461925192;1054.7046826888484;1058.6453538064757;1060.7825395793843;11827.763444731143;11995.280283183038;12014.63956081319;12034;12039.63881083569;4850.151223535867;4887.902241955141;4972.5027497249985;4989.850304490871;4994.800207991712;10083.49582520871;10190.949045254727;10196.439195844152;10213.693589192337;10231.386116833013;5392.4607539246545;5426.511613954763;5463.453654634584;5495.010898038391;5525.977694126599;4453.398791163151;4891.853244402673;5007.524285192901;5017.598592112622;5028.723420211923;4083.0813067059676;4122.73815793398;4164.250434921743;4190.161967606491;4190.958090419118;1209.7278112424633;1219.6584956212275;1219.939003049844;1220.8657047724744;1311.5928688357442;775.5540564175622;845.9873101903477;903.7198468474662;921.3044151665449;928.7445952363154;5465.234867118606;5529.364123125892;5571.1086226203615;5616;5652.236948012048;902.5712786426395;918.673870775865;948.137195152408;949.2311227905419;986.487026746088;3491.5810102787827;3969.2656858481273;4050;4051.756894586334;4087.4890638670167;10552.314099583657;10682.73293167677;10712.303700259457;10838.458077096113;10883.346999180074;10247.436390998566;10370;10599.311044782218;10619.20355973305;10644.893551064544;8320.209580089882;8321;8325.875111873327;8350.164983501601;8517.424276508742;5836.883262334814;5854.180414742024;5933.970330148494;5964.015937370285;5977.432143946318;9530.571124299562;9590.568424421057;9620.615175392906;9732.367396119229;9787.070228328297;9540.093691099335;9616.567254473706;9795.559199835881;9834.967328430412;9903.900960990299;6790.93209067903;7238.963805180941;7476.738314159196;7494.700211991677;7671.232876712284;6909.585424874524;8110.594470276581;8121.309688676529;8150.470219435718;8165.714200003209;6179.907301390393;6285.528585356025;7135.108111486064;7353.448491363062;7413.9258607415395;7170.103737032871;7187.892181617384;7240;7316.597587132759;7379.520331178456;5850.824475265749;6808.489363297674;6873.518853680194;6921.861562768817;6922.273161317989;4148.958510414857;4671.8364857229835;4712.269598212282;4717.57541821224;4775.140474714584;4763.761811909321;4823.638227133049;4899.951000490092;4934.950650493449;4960.181570040902 06:14:02 INFO - PROCESS | 1976 | |4;prototype.html;255.75575325564088;267.27834845916044;319.8240967467892;328.1926460906171;328.4957590099198;6891.310868913106;6947.722091116356;6974.093367862183;7064.1523017238005;7067.505274630778;4889.559939605435;6873.79378618641;6906.067680863082;6940.236573976858;6964.233934267227;4803.135435621587;4912.582430493412;5034.622403319766;5039.395272567297;5051.469595692454;4990.925136122961;5034.395872495305;5051.469595692454;5053.873653158664;5054.873628159307;4444.622207112399;4700.600448961843;4981.925271120918;4996.875078123039;5015.122353588125;4986.376702912136;4987.900241995158;5014.824481143179;5029.044481548494;5036.420811606676;4312.353147027971;4323.027318853233;4325;4332.935005974913;4344.435223420966;6344.175257216532;6649.168853893263;6687.826456401689;6690.83272918176;6699.732010719566;5897.380775018647;5904.940950590482;5933.406659334075;5934.1098835174635;5940.227770389822;7429.21993190718;7429.739959101459;7477.626118694044;7480.289372509603;7487.251274872524;4700.976495117503;4717.551832575934;4731.101090792738;4733.171694953404;4734.431868175807;7621.695132194705;7868.291853733192;7954.164812694699;7971.6014199290385;7984.36515949741;4697.577218050392;4730.526947305242;4760.143174228672;4760.214564596803;4807.903841923142;4852.247901575191;4862.270659401118;4866.902661946741;4872.098661747588;4888.462269150391;5911.113332999998;5911.704414779244;5921.052631578927;5948.791792287249;5948.821535353946;7487;7488.363489103487;7492.100947886289;7493.85012299751;7527.172011078777;1535.5700403886929;1601.742632033848;1664.4840099569171;1689.7465380192823;1692.5430133863788;900.7703035725848;1041.6979076067855;1043.5408420295046;1063.3832377221192;1063.728749168957;6816.386525212754;6837.692303846339;6839.829004274933;6862.862742745117;6876.793696189123;7456.888146677804;7632.389408847279;7734.883976740353;7737.3036426721865;7780.416468764865;6899.6205208714;6909;6923.238443771181;6924.965375173092;6986.615736134561;3649.908752281161;3773.3208022556205;4105.844431673396;4114.259433302034;4117.464729585135;6591;8141.22658347456;8155.306798922158;8162.428629995962;8231.300339471212;7709.460337776414;8043.678252869937;8066.919330806734;8086.595670216466;8188.713395031265;6559.4752419807255;8173;8188.2630563249595;8189.7715342699075;8202.753917382488;5547.833564993057;7062.622788556182;7586.772396828104;7849.882251766114;7870.763877083697;7374.225706300976;7683.270089341504;7690.6539205737;7710.228977102245;7720.227977202235;8177.877331839908;8180.46826956246;8191.180881911761;8202.38482113832;8219.465734727462;4737.905241895074;4795.448523419851;4797.880052998703;4807.759612019455;4834.734089625104;7778.649960751893;7780.766577002699;7799.805004874924;7801.258880406353;7813.648385822766;7218.602976836324;7462.813429664302;7471.364933980455;7480.887786683095;7521.849563008818;7448.180700123091;7475.775726728207;7483.214262502359;7503.512271702322;7519.736809211651;7314.707411703473;7324;7328.560286382834;7328.706851725871;7367.742129025459;7455.0681164854395;7469.813254668677;7476.439267054884;7477.813054673677;7481.251874812475;7021.824454388681;7210.4231661468;7268.418526517971;7288.198298187302;7319.085114360705 06:14:02 INFO - PROCESS | 1976 | |5;yui.html;669.0566301514862;677.2617846547263;699.9755008574701;729.3982464466816;743.2790193512294;14370.640733981656;14774.77837832432;14954.775678364806;14959;15007.39970401184;14291.49979750709;14358.28208589569;14377.856221437782;14387.928060359709;14414.567562973101;731.1372580355179;887.7691800131947;897.5646811296516;908.3732224764924;925.676013395313;882.386741214856;902.3503077783985;912.9863052054225;915.890093188815;919.5126582911034;935.4667839331584;942.4957647658504;943.9056094390575;953.3564843730488;953.637617705271;925.3892430995578;939.3283802081511;946.5693109635099;948.4593781544522;949.5299826585884;707.1796715809687;707.6744697439184;708.0299989015082;708.5536112249301;708.8263375473042;14395.928020359936;14438.494652687106;14728.82169426454;14877.776833347509;14942.775858362133;12647.367631618383;12724.300163491005;12903.161294515827;12959.805602915869;13070.150440221356;9957.950210248902;10099.596016159345;10127;10215.89784102157;10230.079292863604;3494.8252587370785;3508.3684936711384;3515.6660117288816;3613.8735144270086;3688.8195777351257;81781.59109204475;82436.58781706053;84590;85040;85098;9261.814763704688;9444.291678124167;9555.474448905377;9574.712758617252;9840.901590983998;18016.819831801775;20533.66531175469;20717.27489537889;22537.211197608005;22619.095236190697;7458.552486850806;7465.06686664167;7505.699772009168;7515.323620874147;7596.8480630388185;3293.357795229907;3984.2629113614075;3995.10110225197;4000.19996000801;4039.899002524902;3600.6939410149907;3679.7424180307657;3688.207035487383;3694.852205911787;3698.6116457771545;641.105657607644;642.1844257792577;653.2422390027546;656.0651072222064;664.7573635622963;507.31512458181896;560.6551970538089;562.935262444824;565.6396366738002;572.5276646766351;6260.499160067184;7883.6058197089915;7952.801179970547;8075.394345424117;8262.091169971298;491.84015195061033;510.2601228219097;551.8978988887069;561.2395204497847;569.2969183058918;3719.6652301292474;3769.5853456119803;3781.8865434037025;3851.3645248533676;3854.6145385461227;93726.5313673441;95494.04505954852;95519;98289;98865.50567247118;74749.62625186949;76756.61621691968;76952.61523692346;77193.61403192948;78810;68594;69369.65315173492;69406.65296673484;70644.2935570648;71049;8237.46456480327;8262.049864265446;8494.36292278094;8503.1921967413;8515.40392172542;46215.537844621125;46305.53694463147;46594;47844.80387990189;49013.509864900894;62856;69494.65252673705;69939;70530.64734676499;70711;10500.422476763852;10702.250842440955;10809.13526917829;10815.67552973412;11461.942690286494;11754.353510557;11960.880391195977;11973.221740586834;12171.513139474322;12448.937755311166;10928.836067459153;11014.39420831862;11156.888431115585;11363.54545818191;11485.138614604106;10963.725906852393;11206.551737930391;11225.214235003798;11304.717382065513;11446.484908178985;11076.169287303646;11262.83105753398;11288.49201785938;11339.659810205707;11359.54561817518;8062.83874322522;8472.74581762548;9094.954525227331;9509;9530.761730956781;9365.812683746151;9560.856587151338;9610.375325603813;9628.71113866585;9733.707988760349 06:14:02 INFO - PROCESS | 1976 | __end_tp_report 06:14:02 INFO - PROCESS | 1976 | __start_cc_report 06:14:02 INFO - PROCESS | 1976 | _x_x_mozilla_cycle_collect,418 06:14:02 INFO - PROCESS | 1976 | __end_cc_report 06:14:02 INFO - PROCESS | 1976 | __startTimestamp1462799642046__endTimestamp 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | ------- Summary: start ------- 06:14:02 INFO - PROCESS | 1976 | Number of tests: 6 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#0] dojo.html Cycles:165 Average:5719.91 Median:5972.91 stddev:655.68 (11.0%) stddev-sans-first:632.47 06:14:02 INFO - PROCESS | 1976 | Values: 3424.1 3426.8 3447.2 3494.6 3495.5 5704.0 5739.7 5743.8 5767.2 5811.2 5683.6 5710.4 5721.7 5740.9 5785.6 5168.9 5225.8 5280.1 5298.5 5335.8 4833.8 5312.6 5320.0 5345.6 5366.9 5262.7 5291.2 5293.0 5293.1 5314.6 4710.1 5228.3 5260.9 5376.7 5413.3 5213.9 5251.3 5308.7 5312.1 5349.7 4735.7 5480.7 5632.0 5678.2 5708.0 5316.2 5972.9 6015.3 6217.7 6241.3 6194.4 6195.6 6208.8 6216.1 6225.8 5728.9 5745.5 5780.2 5785.8 5816.5 6207.6 6229.5 6286.7 6300.4 6301.7 6165.9 6173.6 6201.3 6208.1 6222.8 6145.2 6229.6 6238.8 6249.6 6257.1 6099.2 6197.9 6206.5 6231.7 6246.6 6199.9 6229.5 6232.4 6233.6 6248.2 4159.6 4847.9 4934.4 4944.8 4958.9 3660.8 4434.0 4442.2 4452.8 4478.2 4864.7 5780.9 5830.1 5842.8 5873.6 5064.5 6108.4 6155.0 6160.9 6204.9 5655.4 5738.3 5830.3 5842.6 5873.0 5412.5 5441.2 5445.2 5448.5 5459.2 6261.3 6321.3 6360.2 6441.5 6475.4 6113.4 6120.2 6144.3 6164.0 6173.0 6424.6 6426.6 6454.6 6460.4 6467.3 6024.5 6030.7 6094.4 6100.9 6121.8 6165.9 6167.8 6176.3 6177.6 6203.5 6056.7 6075.7 6075.8 6083.8 6105.6 5118.4 5949.8 5979.7 6068.0 6172.6 5969.0 6028.5 6083.2 6101.6 6120.1 5010.7 6147.9 6174.4 6205.5 6220.7 5751.3 6009.4 6096.3 6118.6 6142.3 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#1] ext.html Cycles:180 Average:70360.86 Median:39573.10 stddev:154760.52 (391.1%) stddev-sans-first:155105.82 06:14:02 INFO - PROCESS | 1976 | Values: 516.1 534.9 542.9 568.4 595.7 38396.4 39529.6 39566.6 39579.6 39650.4 39657.8 40196.6 40222.0 40279.0 40304.6 9428.5 9618.7 9665.4 9669.3 9678.6 9574.8 9757.7 9839.5 9848.3 9872.7 9779.4 9795.6 9863.7 9863.9 9884.5 7703.5 8255.9 9121.3 9753.5 9818.4 9605.4 9733.6 9775.8 9780.9 9802.4 39605.8 39631.8 39706.4 40033.0 40132.8 2748.5 3119.9 3154.3 3188.2 3402.7 28713.7 28843.4 29073.9 29166.3 29372.6 2747.1 2769.6 2771.4 2810.0 2812.3 470841.0 474232.0 474505.0 475245.0 475860.0 60095.0 60214.7 60713.0 60819.1 60829.7 63247.0 63488.7 71031.6 75242.6 75335.2 17368.9 17754.5 17897.2 17976.6 18148.0 13628.9 13691.7 13775.6 13813.4 13834.6 19727.8 19730.0 19907.7 19914.7 19923.7 8504.4 8631.8 8689.3 8704.5 8712.3 844.0 899.9 960.4 965.6 1019.5 25868.6 26107.5 26640.5 26710.8 26796.0 1026.7 1051.7 1056.6 1073.8 1096.3 12357.6 12950.8 13468.7 13642.8 13871.8 632495.0 640411.0 647377.0 649420.0 652665.0 59902.7 61751.0 61834.0 61877.7 61903.7 1512.5 1515.8 1525.1 1532.4 1532.4 26900.3 27550.3 27841.7 27961.6 27992.2 50837.7 51008.7 51746.2 51863.0 51952.7 599840.0 600500.0 604024.0 604839.0 606212.0 25572.6 25963.2 26017.9 26024.1 42614.6 31140.2 35912.8 37267.1 41819.6 43356.8 31711.0 33686.7 38233.2 38346.8 38360.4 36706.3 36815.0 36967.0 37665.6 37890.0 34160.0 37384.9 38009.2 38471.8 39325.0 29794.6 31046.2 31784.7 32115.8 32309.8 24738.9 25101.5 25252.0 25419.5 25764.0 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#2] jquery.html Cycles:180 Average:33622.91 Median:389.69 stddev:97261.46 (24958.8%) stddev-sans-first:97502.29 06:14:02 INFO - PROCESS | 1976 | Values: 388.8 390.5 392.2 404.7 407.4 14644.6 16053.8 19896.2 20578.6 20595.3 11856.5 12389.2 19592.6 19897.5 19904.9 5138.1 5325.6 5328.2 5348.0 5349.3 5325.3 5360.3 5386.1 5865.1 5963.3 5878.6 5879.4 5908.0 5912.6 5926.2 5306.6 5367.4 5375.5 5889.2 5896.2 4516.8 5220.3 5257.3 5259.2 5261.6 13696.2 16495.6 22341.5 25549.5 25855.5 1912.6 2047.6 2058.6 2200.5 2682.4 9643.9 9920.1 10294.7 10349.6 10363.6 1742.0 1774.8 1816.5 1822.1 1868.3 110932.4 116023.0 116899.4 120633.0 120765.4 10561.5 11106.4 11770.9 11893.5 12030.2 14923.3 15142.8 15308.5 15397.7 15398.0 9073.5 9103.7 9113.7 9135.1 9171.2 7414.3 9069.6 9145.1 9173.8 9174.4 3912.5 4268.9 4730.5 4773.9 4775.9 1700.0 1721.4 1855.8 1982.4 2091.6 758.4 851.1 869.9 894.8 931.8 18856.3 19131.9 19218.2 19572.6 19734.5 890.1 907.6 943.4 967.4 974.4 10141.2 10293.5 10371.7 10395.2 10536.2 530183.3 534509.0 542890.0 641984.0 648988.0 111808.4 113174.0 126016.7 129305.4 131630.0 1026.9 1061.1 1063.2 1067.1 1068.3 17660.0 17782.8 17853.6 17978.2 18274.7 41442.4 50049.5 50746.2 52546.7 52567.7 72632.0 76164.9 77094.0 77496.2 77576.2 7812.7 7848.5 7966.5 8006.8 8051.9 9998.8 11873.6 12070.7 12301.7 12377.0 8287.6 9634.0 9986.8 10008.6 10109.0 10351.1 10376.5 10504.0 10529.4 10772.5 6015.7 9350.0 10088.4 10110.4 10181.2 7555.1 7557.5 7704.7 7944.5 8152.9 7742.1 9208.4 10433.5 10529.2 10556.0 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#3] mootools.html Cycles:180 Average:5674.34 Median:4992.33 stddev:3141.64 (62.9%) stddev-sans-first:3134.14 06:14:02 INFO - PROCESS | 1976 | Values: 1413.7 1546.1 1747.0 1884.2 1934.7 7058.5 7312.0 7892.6 8603.4 8850.3 8581.0 8594.3 8601.0 8718.6 8724.4 2468.6 2474.1 2504.4 2505.2 2510.8 2090.9 2437.2 2485.6 2498.0 2499.4 2465.4 2493.1 2508.2 2508.8 2515.9 2469.8 2483.6 2488.0 2503.2 2505.1 2442.4 2473.5 2476.1 2482.9 2496.7 8809.4 8856.4 8875.2 8905.1 8914.4 5451.2 5573.2 5573.9 5581.7 5600.3 3515.6 3527.4 3596.4 3623.4 3659.7 1037.9 1054.4 1054.7 1058.6 1060.8 11827.8 11995.3 12014.6 12034.0 12039.6 4850.2 4887.9 4972.5 4989.9 4994.8 10083.5 10190.9 10196.4 10213.7 10231.4 5392.5 5426.5 5463.5 5495.0 5526.0 4453.4 4891.9 5007.5 5017.6 5028.7 4083.1 4122.7 4164.3 4190.2 4191.0 1209.7 1219.7 1219.9 1220.9 1311.6 775.6 846.0 903.7 921.3 928.7 5465.2 5529.4 5571.1 5616.0 5652.2 902.6 918.7 948.1 949.2 986.5 3491.6 3969.3 4050.0 4051.8 4087.5 10552.3 10682.7 10712.3 10838.5 10883.3 10247.4 10370.0 10599.3 10619.2 10644.9 8320.2 8321.0 8325.9 8350.2 8517.4 5836.9 5854.2 5934.0 5964.0 5977.4 9530.6 9590.6 9620.6 9732.4 9787.1 9540.1 9616.6 9795.6 9835.0 9903.9 6790.9 7239.0 7476.7 7494.7 7671.2 6909.6 8110.6 8121.3 8150.5 8165.7 6179.9 6285.5 7135.1 7353.4 7413.9 7170.1 7187.9 7240.0 7316.6 7379.5 5850.8 6808.5 6873.5 6921.9 6922.3 4149.0 4671.8 4712.3 4717.6 4775.1 4763.8 4823.6 4900.0 4935.0 4960.2 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#4] prototype.html Cycles:180 Average:6054.49 Median:6902.84 stddev:1996.04 (28.9%) stddev-sans-first:1953.61 06:14:02 INFO - PROCESS | 1976 | Values: 255.8 267.3 319.8 328.2 328.5 6891.3 6947.7 6974.1 7064.2 7067.5 4889.6 6873.8 6906.1 6940.2 6964.2 4803.1 4912.6 5034.6 5039.4 5051.5 4990.9 5034.4 5051.5 5053.9 5054.9 4444.6 4700.6 4981.9 4996.9 5015.1 4986.4 4987.9 5014.8 5029.0 5036.4 4312.4 4323.0 4325.0 4332.9 4344.4 6344.2 6649.2 6687.8 6690.8 6699.7 5897.4 5904.9 5933.4 5934.1 5940.2 7429.2 7429.7 7477.6 7480.3 7487.3 4701.0 4717.6 4731.1 4733.2 4734.4 7621.7 7868.3 7954.2 7971.6 7984.4 4697.6 4730.5 4760.1 4760.2 4807.9 4852.2 4862.3 4866.9 4872.1 4888.5 5911.1 5911.7 5921.1 5948.8 5948.8 7487.0 7488.4 7492.1 7493.9 7527.2 1535.6 1601.7 1664.5 1689.7 1692.5 900.8 1041.7 1043.5 1063.4 1063.7 6816.4 6837.7 6839.8 6862.9 6876.8 7456.9 7632.4 7734.9 7737.3 7780.4 6899.6 6909.0 6923.2 6925.0 6986.6 3649.9 3773.3 4105.8 4114.3 4117.5 6591.0 8141.2 8155.3 8162.4 8231.3 7709.5 8043.7 8066.9 8086.6 8188.7 6559.5 8173.0 8188.3 8189.8 8202.8 5547.8 7062.6 7586.8 7849.9 7870.8 7374.2 7683.3 7690.7 7710.2 7720.2 8177.9 8180.5 8191.2 8202.4 8219.5 4737.9 4795.4 4797.9 4807.8 4834.7 7778.6 7780.8 7799.8 7801.3 7813.6 7218.6 7462.8 7471.4 7480.9 7521.8 7448.2 7475.8 7483.2 7503.5 7519.7 7314.7 7324.0 7328.6 7328.7 7367.7 7455.1 7469.8 7476.4 7477.8 7481.3 7021.8 7210.4 7268.4 7288.2 7319.1 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - PROCESS | 1976 | [#5] yui.html Cycles:180 Average:18346.29 Median:31748.55 stddev:26130.98 (82.3%) stddev-sans-first:26170.57 06:14:02 INFO - PROCESS | 1976 | Values: 669.1 677.3 700.0 729.4 743.3 14370.6 14774.8 14954.8 14959.0 15007.4 14291.5 14358.3 14377.9 14387.9 14414.6 731.1 887.8 897.6 908.4 925.7 882.4 902.4 913.0 915.9 919.5 935.5 942.5 943.9 953.4 953.6 925.4 939.3 946.6 948.5 949.5 707.2 707.7 708.0 708.6 708.8 14395.9 14438.5 14728.8 14877.8 14942.8 12647.4 12724.3 12903.2 12959.8 13070.2 9958.0 10099.6 10127.0 10215.9 10230.1 3494.8 3508.4 3515.7 3613.9 3688.8 81781.6 82436.6 84590.0 85040.0 85098.0 9261.8 9444.3 9555.5 9574.7 9840.9 18016.8 20533.7 20717.3 22537.2 22619.1 7458.6 7465.1 7505.7 7515.3 7596.8 3293.4 3984.3 3995.1 4000.2 4039.9 3600.7 3679.7 3688.2 3694.9 3698.6 641.1 642.2 653.2 656.1 664.8 507.3 560.7 562.9 565.6 572.5 6260.5 7883.6 7952.8 8075.4 8262.1 491.8 510.3 551.9 561.2 569.3 3719.7 3769.6 3781.9 3851.4 3854.6 93726.5 95494.0 95519.0 98289.0 98865.5 74749.6 76756.6 76952.6 77193.6 78810.0 68594.0 69369.7 69406.7 70644.3 71049.0 8237.5 8262.0 8494.4 8503.2 8515.4 46215.5 46305.5 46594.0 47844.8 49013.5 62856.0 69494.7 69939.0 70530.6 70711.0 10500.4 10702.3 10809.1 10815.7 11461.9 11754.4 11960.9 11973.2 12171.5 12448.9 10928.8 11014.4 11156.9 11363.5 11485.1 10963.7 11206.6 11225.2 11304.7 11446.5 11076.2 11262.8 11288.5 11339.7 11359.5 8062.8 8472.7 9095.0 9509.0 9530.8 9365.8 9560.9 9610.4 9628.7 9733.7 06:14:02 INFO - PROCESS | 1976 | -------- Summary: end -------- 06:14:02 INFO - PROCESS | 1976 | 06:14:02 INFO - TEST-INFO | 1976: exit 0 06:14:02 INFO - TEST-OK | dromaeo_css | took 1111555ms 06:14:02 INFO - TEST-START | kraken 06:14:02 INFO - operating with platform_type : mac_ 06:14:02 INFO - Initialising browser for kraken test... 06:14:02 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpqyoHAD/profile http://localhost:49511/getInfo.html) 06:14:05 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 06:14:05 INFO - PROCESS | 1981 | colorDepth:24 06:14:05 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 06:14:05 INFO - PROCESS | 1981 | __metrics 06:14:05 ERROR - PROCESS | 1981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:14:06 INFO - TEST-INFO | 1981: exit 0 06:14:06 INFO - Browser initialized. 06:14:06 INFO - Running cycle 1/1 for kraken test... 06:14:06 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpqyoHAD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:18 INFO - PROCESS | 1984 | RSS: Main: 220909568 06:14:18 INFO - PROCESS | 1984 | 06:14:20 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:21 INFO - PROCESS | 1984 | RSS: Main: 233062400 06:14:21 INFO - PROCESS | 1984 | 06:14:24 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-dft) 06:14:25 INFO - PROCESS | 1984 | RSS: Main: 241958912 06:14:25 INFO - PROCESS | 1984 | 06:14:28 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-fft) 06:14:29 INFO - PROCESS | 1984 | RSS: Main: 244875264 06:14:29 INFO - PROCESS | 1984 | 06:14:31 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator) 06:14:32 INFO - PROCESS | 1984 | RSS: Main: 246407168 06:14:32 INFO - PROCESS | 1984 | 06:14:34 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:35 INFO - PROCESS | 1984 | RSS: Main: 247119872 06:14:35 INFO - PROCESS | 1984 | 06:14:37 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:38 INFO - PROCESS | 1984 | RSS: Main: 247541760 06:14:38 INFO - PROCESS | 1984 | 06:14:41 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:42 INFO - PROCESS | 1984 | RSS: Main: 247762944 06:14:42 INFO - PROCESS | 1984 | 06:14:44 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial) 06:14:45 INFO - PROCESS | 1984 | RSS: Main: 247984128 06:14:45 INFO - PROCESS | 1984 | 06:14:47 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:47 INFO - PROCESS | 1984 | RSS: Main: 247480320 06:14:47 INFO - PROCESS | 1984 | 06:14:49 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:50 INFO - PROCESS | 1984 | RSS: Main: 247476224 06:14:50 INFO - PROCESS | 1984 | 06:14:52 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:53 INFO - PROCESS | 1984 | RSS: Main: 247873536 06:14:53 INFO - PROCESS | 1984 | 06:14:55 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:56 INFO - PROCESS | 1984 | RSS: Main: 248115200 06:14:56 INFO - PROCESS | 1984 | 06:14:59 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:00 INFO - PROCESS | 1984 | RSS: Main: 248029184 06:15:00 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49511/tests/kraken/driver.html?testName=ai-astar) 06:15:02 INFO - PROCESS | 1984 | RSS: Main: 249450496 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | __start_tp_report 06:15:02 INFO - PROCESS | 1984 | _x_x_mozilla_page_load 06:15:02 INFO - PROCESS | 1984 | _x_x_mozilla_page_load_details 06:15:02 INFO - PROCESS | 1984 | |i|pagename|runs| 06:15:02 INFO - PROCESS | 1984 | |0;ai-astar;114;118;156;168;120;150;115;170;96;163 06:15:02 INFO - PROCESS | 1984 | |1;audio-beat-detection;156;155;200;185;157;129;149;169;177;146 06:15:02 INFO - PROCESS | 1984 | |2;audio-dft;212;261;181;201;172;257;189;274;267;200 06:15:02 INFO - PROCESS | 1984 | |3;audio-fft;71;93;76;151;77;80;80;80;128;56 06:15:02 INFO - PROCESS | 1984 | |4;audio-oscillator;83;96;162;80;79;79;119;81;81;120 06:15:02 INFO - PROCESS | 1984 | |5;imaging-gaussian-blur;92;89;91;88;110;105;92;90;91;87 06:15:02 INFO - PROCESS | 1984 | |6;imaging-darkroom;95;97;96;98;96;95;121;143;148;96 06:15:02 INFO - PROCESS | 1984 | |7;imaging-desaturate;94;90;92;90;91;89;91;92;92;92 06:15:02 INFO - PROCESS | 1984 | |8;json-parse-financial;62;63;65;66;65;65;66;83;64;60 06:15:02 INFO - PROCESS | 1984 | |9;json-stringify-tinderbox;67;67;67;78;71;75;74;72;98;68 06:15:02 INFO - PROCESS | 1984 | |10;stanford-crypto-aes;83;80;83;80;83;80;83;79;84;89 06:15:02 INFO - PROCESS | 1984 | |11;stanford-crypto-ccm;148;151;134;127;129;167;135;146;141;169 06:15:02 INFO - PROCESS | 1984 | |12;stanford-crypto-pbkdf2;174;171;188;158;212;221;192;168;215;165 06:15:02 INFO - PROCESS | 1984 | |13;stanford-crypto-sha256-iterative;84;69;68;70;59;64;80;103;97;98 06:15:02 INFO - PROCESS | 1984 | __end_tp_report 06:15:02 INFO - PROCESS | 1984 | __start_cc_report 06:15:02 INFO - PROCESS | 1984 | _x_x_mozilla_cycle_collect,1084 06:15:02 INFO - PROCESS | 1984 | __end_cc_report 06:15:02 INFO - PROCESS | 1984 | __startTimestamp1462799702331__endTimestamp 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | ------- Summary: start ------- 06:15:02 INFO - PROCESS | 1984 | Number of tests: 14 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#0] ai-astar Cycles:10 Average:137.00 Median:159.50 stddev:27.08 (17.0%) stddev-sans-first:27.41 06:15:02 INFO - PROCESS | 1984 | Values: 114.0 118.0 156.0 168.0 120.0 150.0 115.0 170.0 96.0 163.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#1] audio-beat-detection Cycles:10 Average:162.30 Median:163.00 stddev:20.74 (12.7%) stddev-sans-first:21.87 06:15:02 INFO - PROCESS | 1984 | Values: 156.0 155.0 200.0 185.0 157.0 129.0 149.0 169.0 177.0 146.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#2] audio-dft Cycles:10 Average:221.40 Median:234.50 stddev:39.11 (16.7%) stddev-sans-first:41.33 06:15:02 INFO - PROCESS | 1984 | Values: 212.0 261.0 181.0 201.0 172.0 257.0 189.0 274.0 267.0 200.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#3] audio-fft Cycles:10 Average:89.20 Median:78.50 stddev:28.58 (36.4%) stddev-sans-first:29.54 06:15:02 INFO - PROCESS | 1984 | Values: 71.0 93.0 76.0 151.0 77.0 80.0 80.0 80.0 128.0 56.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:80.50 stddev:27.64 (34.3%) stddev-sans-first:28.77 06:15:02 INFO - PROCESS | 1984 | Values: 83.0 96.0 162.0 80.0 79.0 79.0 119.0 81.0 81.0 120.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:90.50 stddev:7.65 (8.5%) stddev-sans-first:8.09 06:15:02 INFO - PROCESS | 1984 | Values: 92.0 89.0 91.0 88.0 110.0 105.0 92.0 90.0 91.0 87.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:96.00 stddev:21.04 (21.9%) stddev-sans-first:21.74 06:15:02 INFO - PROCESS | 1984 | Values: 95.0 97.0 96.0 98.0 96.0 95.0 121.0 143.0 148.0 96.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:92.00 stddev:1.42 (1.5%) stddev-sans-first:1.12 06:15:02 INFO - PROCESS | 1984 | Values: 94.0 90.0 92.0 90.0 91.0 89.0 91.0 92.0 92.0 92.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:6.30 (9.7%) stddev-sans-first:6.52 06:15:02 INFO - PROCESS | 1984 | Values: 62.0 63.0 65.0 66.0 65.0 65.0 66.0 83.0 64.0 60.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:73.00 stddev:9.36 (12.8%) stddev-sans-first:9.61 06:15:02 INFO - PROCESS | 1984 | Values: 67.0 67.0 67.0 78.0 71.0 75.0 74.0 72.0 98.0 68.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:2.91 (3.5%) stddev-sans-first:3.08 06:15:02 INFO - PROCESS | 1984 | Values: 83.0 80.0 83.0 80.0 83.0 80.0 83.0 79.0 84.0 89.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:147.00 stddev:14.61 (9.9%) stddev-sans-first:15.45 06:15:02 INFO - PROCESS | 1984 | Values: 148.0 151.0 134.0 127.0 129.0 167.0 135.0 146.0 141.0 169.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:190.00 stddev:22.85 (12.0%) stddev-sans-first:23.79 06:15:02 INFO - PROCESS | 1984 | Values: 174.0 171.0 188.0 158.0 212.0 221.0 192.0 168.0 215.0 165.0 06:15:02 INFO - PROCESS | 1984 | 06:15:02 INFO - PROCESS | 1984 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:75.00 stddev:15.68 (20.9%) stddev-sans-first:16.54 06:15:02 INFO - PROCESS | 1984 | Values: 84.0 69.0 68.0 70.0 59.0 64.0 80.0 103.0 97.0 98.0 06:15:02 INFO - PROCESS | 1984 | -------- Summary: end -------- 06:15:02 INFO - PROCESS | 1984 | 06:15:03 INFO - TEST-INFO | 1984: exit 0 06:15:03 INFO - TEST-OK | kraken | took 60439ms 06:15:03 INFO - SUITE-END | took 1171s 06:15:03 INFO - Completed test suite (00:19:32) 06:15:03 INFO - javascript benchmark 06:15:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.1439640089975, 3426.760126791124, 3447.172678557144, 3494.563179602548, 3495.5106285120087, 5704.0, 5739.741711622982, 5743.770249190038, 5767.221425107609, 5811.186433899252, 5683.602147849652, 5710.371859095496, 5721.742521586528, 5740.885182296352, 5785.623934444258, 5168.948310516894, 5225.790968361261, 5280.102382594968, 5298.496642818926, 5335.7865685372535, 4833.830815921444, 5312.57499400049, 5319.9734001330135, 5345.599080068991, 5366.865828354303, 5262.684238945656, 5291.2327712481665, 5292.973535132338, 5293.126634105387, 5314.5748340132695, 4710.081534100869, 5228.2941802856885, 5260.92108618371, 5376.731163441851, 5413.2692086568595, 5213.947860521384, 5251.343582052244, 5308.70802105884, 5312.123499622558, 5349.7057661828585, 4735.715857048588, 5480.698561579112, 5631.971840140773, 5678.205051292823, 5708.0, 5316.229146773696, 5972.910406343908, 6015.2781666200335, 6217.6891155442045, 6241.282252540925, 6194.4115309045565, 6195.628262304276, 6208.782692605782, 6216.067589861512, 6225.844353891143, 5728.942710572883, 5745.540356771448, 5780.161876527922, 5785.82642520725, 5816.534677225812, 6207.596506227081, 6229.501639868799, 6286.654234017173, 6300.432961033437, 6301.747930082745, 6165.876682466325, 6173.629582225081, 6201.286852012076, 6208.068789681584, 6222.751089956441, 6145.156453064063, 6229.595076320115, 6238.781642642486, 6249.562530622904, 6257.061440783918, 6099.237595300588, 6197.876042479125, 6206.472449841724, 6231.688415579293, 6246.562740608114, 6199.876002479925, 6229.501639868799, 6232.407921247474, 6233.594816336924, 6248.218972628421, 4159.584041595876, 4847.878803029882, 4934.432540257916, 4944.826931057396, 4958.925616115761, 3660.762050466711, 4434.002349471343, 4442.200403927324, 4452.755098469551, 4478.171538265431, 4864.73243971585, 5780.913286300709, 5830.096335068071, 5842.766289348463, 5873.559483038789, 5064.5441910228255, 6108.433136212241, 6155.0, 6160.8767824643255, 6204.906926396107, 5655.4344565543115, 5738.340090889601, 5830.329512106077, 5842.5618078644275, 5873.0, 5412.539934105566, 5441.211024401439, 5445.237666726662, 5448.509634132947, 5459.235707001023, 6261.342559031236, 6321.273053598711, 6360.173177486897, 6441.5490915635455, 6475.449586785082, 6113.411090322682, 6120.203342909657, 6144.262688477412, 6163.96918015407, 6173.0, 6424.646644434601, 6426.614403135827, 6454.644994525346, 6460.3862633049785, 6467.320931302145, 6024.518038556993, 6030.668313242813, 6094.421030002142, 6100.908486372797, 6121.755129794937, 6165.907511387422, 6167.753289868355, 6176.258848938156, 6177.62934223948, 6203.503719702503, 6056.727447264796, 6075.726592303446, 6075.756969721162, 6083.847903802441, 6105.633661980295, 5118.38579370478, 5949.8215053548465, 5979.671118088547, 6068.0, 6172.567920245539, 5968.97015514937, 6028.5177185825905, 6083.209182806207, 6101.60339577926, 6120.051392034242, 5010.722265822192, 6147.907781383372, 6174.38256174379, 6205.503559715302, 6220.688965551795, 5751.338596061507, 6009.399060093956, 6096.29892562361, 6118.632882027093, 6142.262928448615], "value": 5679.9594869933835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.1225915942898, 534.9251104845321, 542.8859939412728, 568.4258898512501, 595.6894831370985, 38396.42405363922, 39529.60470395295, 39566.604333956726, 39579.60420395802, 39650.42272252301, 39657.80171099148, 40196.59803401965, 40222.0, 40279.0, 40304.59695403045, 9428.528573571328, 9618.663346782863, 9665.4200747955, 9669.323147379686, 9678.56446459911, 9574.760630984212, 9757.707268781947, 9839.45882976436, 9848.310618256724, 9872.703818885446, 9779.364341317827, 9795.608175672964, 9863.704088877344, 9863.901360986405, 9884.505774711271, 7703.499272547322, 8255.876161857577, 9121.315901307362, 9753.512324383788, 9818.410895346302, 9605.37565058276, 9733.610655573768, 9775.804483910353, 9780.902190978142, 9802.411855288705, 39605.80197099025, 39631.80184099061, 39706.40440393367, 40033.0, 40132.79933600342, 2748.4503099380004, 3119.906402807919, 3154.3375891062906, 3188.1551388881967, 3402.7447941404494, 28713.712862871314, 28843.42313153746, 29073.85463072692, 29166.27084322909, 29372.559411608843, 2747.079728291025, 2769.57071653894, 2771.362586605092, 2809.9578506322423, 2812.2969257685577, 470841.0, 474232.0, 474505.0, 475245.0, 475860.0, 60095.0, 60214.69892650596, 60713.0, 60819.087713684334, 60829.69585152046, 63247.0, 63488.68255658692, 71031.64484177546, 75242.62378688072, 75335.24664753392, 17368.91315543414, 17754.467365979042, 17897.19462624185, 17976.640467190846, 18148.0, 13628.863711362957, 13691.726165476635, 13775.586732398044, 13813.447462101605, 13834.584962451143, 19727.816331020185, 19730.0, 19907.701384479245, 19914.701279480818, 19923.701144482846, 8504.404691671647, 8631.842039490128, 8689.348298877609, 8704.521251331238, 8712.2575484902, 844.0420123160258, 899.9280057595377, 960.3805545423163, 965.6330594374093, 1019.5463018956641, 25868.611970820453, 26107.477850442883, 26640.534770587416, 26710.798014089414, 26796.0, 1026.7022563456662, 1051.6792378324685, 1056.5932116135343, 1073.8013467508536, 1096.2928910852615, 12357.640659527446, 12950.769676880682, 13468.730625387438, 13642.795358069638, 13871.791923121162, 632495.0, 640411.0, 647377.0, 649420.0, 652665.0, 59902.70048649816, 61751.0, 61834.0, 61877.690611546655, 61903.6904815473, 1512.455516014234, 1515.7953676253785, 1525.1459182857636, 1532.371727591682, 1532.3793863485307, 26900.327491812863, 27550.311242219104, 27841.721582784725, 27961.580576290966, 27992.160235192976, 50837.729056773875, 51008.74495627498, 51746.22380664218, 51863.0, 51952.740236298574, 599840.0, 600500.0, 604024.0, 604839.0, 606212.0, 25572.616410754224, 25963.22110336693, 26017.869910650326, 26024.089156879418, 42614.57385426106, 31140.22149446282, 35912.82043589765, 37267.06832329105, 41819.581804181566, 43356.78321608498, 31711.04866853998, 33686.66313336933, 38233.23533529258, 38346.84959451221, 38360.42459363167, 36706.26587468182, 36815.0, 36967.0, 37665.62334376621, 37890.0, 34159.97520074302, 37384.87845364644, 38009.23981520409, 38471.80764096162, 39325.01687457837, 29794.553081704224, 31046.22384440407, 31784.68215317817, 32115.839420802746, 32309.838450808536, 24738.876305618356, 25101.497970040862, 25252.0, 25419.491610168065, 25764.0], "value": 19795.49410666602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8347452332758, 390.5411141908258, 392.21165457430556, 404.7146761533119, 407.42959856201315, 14644.633884152901, 16053.759193612104, 19896.20415183393, 20578.588428231444, 20595.27916522922, 11856.466459009343, 12389.19470234434, 19592.60814783707, 19897.502562435948, 19904.900475497638, 5138.100832354332, 5325.600579956499, 5328.17413300939, 5348.010618035656, 5349.251104845324, 5325.3077099976945, 5360.3299587551555, 5386.084365657828, 5865.149553314767, 5963.344032156459, 5878.617889837168, 5879.382664820175, 5908.0, 5912.556558258148, 5926.199963005004, 5306.6285360025, 5367.436419176009, 5375.543078838304, 5889.1755154278435, 5896.204012458327, 4516.841910533149, 5220.26916231724, 5257.342832145981, 5259.237410575445, 5261.631685781997, 13696.246706431142, 16495.587610309838, 22341.54779939299, 25549.489010219877, 25855.482890342275, 1912.6079153773444, 2047.5597746484427, 2058.588282343522, 2200.4938864061355, 2682.4366882954605, 9643.903560964442, 9920.079424174734, 10294.742631434274, 10349.58601655933, 10363.585456581728, 1741.9564510887203, 1774.8136445673276, 1816.527702797269, 1822.1253798176817, 1868.2807119259182, 110932.4453377736, 116023.0, 116899.4155029228, 120633.0, 120765.39617301857, 10561.471926403648, 11106.389148596905, 11770.88229117715, 11893.524259029715, 12030.218035827644, 14923.328450219766, 15142.848571514143, 15308.464203753038, 15397.692046159014, 15398.0, 9073.45559266446, 9103.726888193365, 9113.681021164228, 9135.132162444557, 9171.220446262008, 7414.332710056121, 9069.59186836594, 9145.131212534798, 9173.81652366949, 9174.357794954423, 3912.471816304819, 4268.893277668021, 4730.479647238801, 4773.904521909542, 4775.880602984884, 1699.9745003824953, 1721.3975108712102, 1855.7751883756926, 1982.415187519685, 2091.623507768586, 758.4084414156966, 851.0595940794084, 869.8782170496136, 894.8120894612074, 931.8229536388064, 18856.34002809895, 19131.947742873996, 19218.231270749293, 19572.608547828964, 19734.506637334183, 890.123228619809, 907.6051917415813, 943.429225318686, 967.4485543240426, 974.35205588283, 10141.2394070445, 10293.485325733684, 10371.688849334532, 10395.16838652906, 10536.157107431387, 530183.3490832521, 534509.0, 542890.0, 641984.0, 648988.0, 111808.4409577947, 113174.0, 126016.73983260234, 129305.35347323203, 131630.0, 1026.9383836969805, 1061.1298735037196, 1063.2344711807486, 1067.0556557446716, 1068.3269540189785, 17660.02869842171, 17782.822171778116, 17853.553661158574, 17978.190981405605, 18274.72587911209, 41442.37836432516, 50049.49950500594, 50746.238806418674, 52546.73726631342, 52567.68580785358, 72632.0, 76164.90222941835, 77094.0, 77496.2250377489, 77576.2242377569, 7812.726554570563, 7848.529088254723, 7966.522008679498, 8006.799830004296, 8051.919480805117, 9998.750031249278, 11873.584424545099, 12070.698232544257, 12301.692457688629, 12377.0, 8287.62705678258, 9634.0, 9986.800263994824, 10008.599656013677, 10109.0, 10351.120154786626, 10376.481175941324, 10504.0, 10529.36823790575, 10772.461376931278, 6015.699215039318, 9349.953250233706, 10088.445135517617, 10110.39337639744, 10181.185505159718, 7555.13115991646, 7557.470977031555, 7704.730334438268, 7944.523328600302, 8152.899358586752, 7742.109657389247, 9208.355415121145, 10433.478326083818, 10529.210309226686, 10556.0], "value": 9122.400844227339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.7313910357032, 1546.134164867674, 1747.0, 1884.189798386694, 1934.7291379206904, 7058.505904586681, 7311.963440182792, 7892.605369731505, 8603.397762156645, 8850.291976641869, 8580.957095214531, 8594.269487093605, 8601.0, 8718.564071796416, 8724.432911860724, 2468.6297055441646, 2474.084588702183, 2504.3864253257975, 2505.24842547236, 2510.79913606911, 2090.8954552272403, 2437.2079074300837, 2485.6271559266074, 2498.000799680124, 2499.350168956066, 2465.3959779853963, 2493.127405408111, 2508.184839927022, 2508.761667641571, 2515.8993640254366, 2469.777720005199, 2483.5777917754026, 2487.962680559784, 2503.1864643990684, 2505.0731229445223, 2442.3771938155833, 2473.5052989402193, 2476.0962248779247, 2482.8758562072003, 2496.7253602103756, 8809.427387219874, 8856.380053396264, 8875.156860098281, 8905.064968178378, 8914.420562663407, 5451.209574611659, 5573.164025396182, 5573.944260557424, 5581.665100094007, 5600.299962504687, 3515.5781306243157, 3527.400341941876, 3596.3886139356373, 3623.4202527595457, 3659.6889264412557, 1037.8962103789636, 1054.4411461925192, 1054.7046826888484, 1058.6453538064757, 1060.7825395793843, 11827.763444731143, 11995.280283183038, 12014.63956081319, 12034.0, 12039.63881083569, 4850.151223535867, 4887.902241955141, 4972.5027497249985, 4989.850304490871, 4994.800207991712, 10083.49582520871, 10190.949045254727, 10196.439195844152, 10213.693589192337, 10231.386116833013, 5392.4607539246545, 5426.511613954763, 5463.453654634584, 5495.010898038391, 5525.977694126599, 4453.398791163151, 4891.853244402673, 5007.524285192901, 5017.598592112622, 5028.723420211923, 4083.0813067059676, 4122.73815793398, 4164.250434921743, 4190.161967606491, 4190.958090419118, 1209.7278112424633, 1219.6584956212275, 1219.939003049844, 1220.8657047724744, 1311.5928688357442, 775.5540564175622, 845.9873101903477, 903.7198468474662, 921.3044151665449, 928.7445952363154, 5465.234867118606, 5529.364123125892, 5571.1086226203615, 5616.0, 5652.236948012048, 902.5712786426395, 918.673870775865, 948.137195152408, 949.2311227905419, 986.487026746088, 3491.5810102787827, 3969.2656858481273, 4050.0, 4051.756894586334, 4087.4890638670167, 10552.314099583657, 10682.73293167677, 10712.303700259457, 10838.458077096113, 10883.346999180074, 10247.436390998566, 10370.0, 10599.311044782218, 10619.20355973305, 10644.893551064544, 8320.209580089882, 8321.0, 8325.875111873327, 8350.164983501601, 8517.424276508742, 5836.883262334814, 5854.180414742024, 5933.970330148494, 5964.015937370285, 5977.432143946318, 9530.571124299562, 9590.568424421057, 9620.615175392906, 9732.367396119229, 9787.070228328297, 9540.093691099335, 9616.567254473706, 9795.559199835881, 9834.967328430412, 9903.900960990299, 6790.93209067903, 7238.963805180941, 7476.738314159196, 7494.700211991677, 7671.232876712284, 6909.585424874524, 8110.594470276581, 8121.309688676529, 8150.470219435718, 8165.714200003209, 6179.907301390393, 6285.528585356025, 7135.108111486064, 7353.448491363062, 7413.9258607415395, 7170.103737032871, 7187.892181617384, 7240.0, 7316.597587132759, 7379.520331178456, 5850.824475265749, 6808.489363297674, 6873.518853680194, 6921.861562768817, 6922.273161317989, 4148.958510414857, 4671.8364857229835, 4712.269598212282, 4717.57541821224, 4775.140474714584, 4763.761811909321, 4823.638227133049, 4899.951000490092, 4934.950650493449, 4960.181570040902], "value": 4591.768361576005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.75575325564088, 267.27834845916044, 319.8240967467892, 328.1926460906171, 328.4957590099198, 6891.310868913106, 6947.722091116356, 6974.093367862183, 7064.1523017238005, 7067.505274630778, 4889.559939605435, 6873.79378618641, 6906.067680863082, 6940.236573976858, 6964.233934267227, 4803.135435621587, 4912.582430493412, 5034.622403319766, 5039.395272567297, 5051.469595692454, 4990.925136122961, 5034.395872495305, 5051.469595692454, 5053.873653158664, 5054.873628159307, 4444.622207112399, 4700.600448961843, 4981.925271120918, 4996.875078123039, 5015.122353588125, 4986.376702912136, 4987.900241995158, 5014.824481143179, 5029.044481548494, 5036.420811606676, 4312.353147027971, 4323.027318853233, 4325.0, 4332.935005974913, 4344.435223420966, 6344.175257216532, 6649.168853893263, 6687.826456401689, 6690.83272918176, 6699.732010719566, 5897.380775018647, 5904.940950590482, 5933.406659334075, 5934.1098835174635, 5940.227770389822, 7429.21993190718, 7429.739959101459, 7477.626118694044, 7480.289372509603, 7487.251274872524, 4700.976495117503, 4717.551832575934, 4731.101090792738, 4733.171694953404, 4734.431868175807, 7621.695132194705, 7868.291853733192, 7954.164812694699, 7971.6014199290385, 7984.36515949741, 4697.577218050392, 4730.526947305242, 4760.143174228672, 4760.214564596803, 4807.903841923142, 4852.247901575191, 4862.270659401118, 4866.902661946741, 4872.098661747588, 4888.462269150391, 5911.113332999998, 5911.704414779244, 5921.052631578927, 5948.791792287249, 5948.821535353946, 7487.0, 7488.363489103487, 7492.100947886289, 7493.85012299751, 7527.172011078777, 1535.5700403886929, 1601.742632033848, 1664.4840099569171, 1689.7465380192823, 1692.5430133863788, 900.7703035725848, 1041.6979076067855, 1043.5408420295046, 1063.3832377221192, 1063.728749168957, 6816.386525212754, 6837.692303846339, 6839.829004274933, 6862.862742745117, 6876.793696189123, 7456.888146677804, 7632.389408847279, 7734.883976740353, 7737.3036426721865, 7780.416468764865, 6899.6205208714, 6909.0, 6923.238443771181, 6924.965375173092, 6986.615736134561, 3649.908752281161, 3773.3208022556205, 4105.844431673396, 4114.259433302034, 4117.464729585135, 6591.0, 8141.22658347456, 8155.306798922158, 8162.428629995962, 8231.300339471212, 7709.460337776414, 8043.678252869937, 8066.919330806734, 8086.595670216466, 8188.713395031265, 6559.4752419807255, 8173.0, 8188.2630563249595, 8189.7715342699075, 8202.753917382488, 5547.833564993057, 7062.622788556182, 7586.772396828104, 7849.882251766114, 7870.763877083697, 7374.225706300976, 7683.270089341504, 7690.6539205737, 7710.228977102245, 7720.227977202235, 8177.877331839908, 8180.46826956246, 8191.180881911761, 8202.38482113832, 8219.465734727462, 4737.905241895074, 4795.448523419851, 4797.880052998703, 4807.759612019455, 4834.734089625104, 7778.649960751893, 7780.766577002699, 7799.805004874924, 7801.258880406353, 7813.648385822766, 7218.602976836324, 7462.813429664302, 7471.364933980455, 7480.887786683095, 7521.849563008818, 7448.180700123091, 7475.775726728207, 7483.214262502359, 7503.512271702322, 7519.736809211651, 7314.707411703473, 7324.0, 7328.560286382834, 7328.706851725871, 7367.742129025459, 7455.0681164854395, 7469.813254668677, 7476.439267054884, 7477.813054673677, 7481.251874812475, 7021.824454388681, 7210.4231661468, 7268.418526517971, 7288.198298187302, 7319.085114360705], "value": 5359.310024099024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.0566301514862, 677.2617846547263, 699.9755008574701, 729.3982464466816, 743.2790193512294, 14370.640733981656, 14774.77837832432, 14954.775678364806, 14959.0, 15007.39970401184, 14291.49979750709, 14358.28208589569, 14377.856221437782, 14387.928060359709, 14414.567562973101, 731.1372580355179, 887.7691800131947, 897.5646811296516, 908.3732224764924, 925.676013395313, 882.386741214856, 902.3503077783985, 912.9863052054225, 915.890093188815, 919.5126582911034, 935.4667839331584, 942.4957647658504, 943.9056094390575, 953.3564843730488, 953.637617705271, 925.3892430995578, 939.3283802081511, 946.5693109635099, 948.4593781544522, 949.5299826585884, 707.1796715809687, 707.6744697439184, 708.0299989015082, 708.5536112249301, 708.8263375473042, 14395.928020359936, 14438.494652687106, 14728.82169426454, 14877.776833347509, 14942.775858362133, 12647.367631618383, 12724.300163491005, 12903.161294515827, 12959.805602915869, 13070.150440221356, 9957.950210248902, 10099.596016159345, 10127.0, 10215.89784102157, 10230.079292863604, 3494.8252587370785, 3508.3684936711384, 3515.6660117288816, 3613.8735144270086, 3688.8195777351257, 81781.59109204475, 82436.58781706053, 84590.0, 85040.0, 85098.0, 9261.814763704688, 9444.291678124167, 9555.474448905377, 9574.712758617252, 9840.901590983998, 18016.819831801775, 20533.66531175469, 20717.27489537889, 22537.211197608005, 22619.095236190697, 7458.552486850806, 7465.06686664167, 7505.699772009168, 7515.323620874147, 7596.8480630388185, 3293.357795229907, 3984.2629113614075, 3995.10110225197, 4000.19996000801, 4039.899002524902, 3600.6939410149907, 3679.7424180307657, 3688.207035487383, 3694.852205911787, 3698.6116457771545, 641.105657607644, 642.1844257792577, 653.2422390027546, 656.0651072222064, 664.7573635622963, 507.31512458181896, 560.6551970538089, 562.935262444824, 565.6396366738002, 572.5276646766351, 6260.499160067184, 7883.6058197089915, 7952.801179970547, 8075.394345424117, 8262.091169971298, 491.84015195061033, 510.2601228219097, 551.8978988887069, 561.2395204497847, 569.2969183058918, 3719.6652301292474, 3769.5853456119803, 3781.8865434037025, 3851.3645248533676, 3854.6145385461227, 93726.5313673441, 95494.04505954852, 95519.0, 98289.0, 98865.50567247118, 74749.62625186949, 76756.61621691968, 76952.61523692346, 77193.61403192948, 78810.0, 68594.0, 69369.65315173492, 69406.65296673484, 70644.2935570648, 71049.0, 8237.46456480327, 8262.049864265446, 8494.36292278094, 8503.1921967413, 8515.40392172542, 46215.537844621125, 46305.53694463147, 46594.0, 47844.80387990189, 49013.509864900894, 62856.0, 69494.65252673705, 69939.0, 70530.64734676499, 70711.0, 10500.422476763852, 10702.250842440955, 10809.13526917829, 10815.67552973412, 11461.942690286494, 11754.353510557, 11960.880391195977, 11973.221740586834, 12171.513139474322, 12448.937755311166, 10928.836067459153, 11014.39420831862, 11156.888431115585, 11363.54545818191, 11485.138614604106, 10963.725906852393, 11206.551737930391, 11225.214235003798, 11304.717382065513, 11446.484908178985, 11076.169287303646, 11262.83105753398, 11288.49201785938, 11339.659810205707, 11359.54561817518, 8062.83874322522, 8472.74581762548, 9094.954525227331, 9509.0, 9530.761730956781, 9365.812683746151, 9560.856587151338, 9610.375325603813, 9628.71113866585, 9733.707988760349], "value": 6839.71134735591, "unit": "score"}], "name": "dromaeo_css", "value": 7462.148357774858, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 156.0, 168.0, 120.0, 150.0, 115.0, 170.0, 96.0, 163.0], "value": 137.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 200.0, 185.0, 157.0, 129.0, 149.0, 169.0, 177.0, 146.0], "value": 162.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 261.0, 181.0, 201.0, 172.0, 257.0, 189.0, 274.0, 267.0, 200.0], "value": 221.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 93.0, 76.0, 151.0, 77.0, 80.0, 80.0, 80.0, 128.0, 56.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 96.0, 162.0, 80.0, 79.0, 79.0, 119.0, 81.0, 81.0, 120.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 91.0, 88.0, 110.0, 105.0, 92.0, 90.0, 91.0, 87.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 98.0, 96.0, 95.0, 121.0, 143.0, 148.0, 96.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 92.0, 90.0, 91.0, 89.0, 91.0, 92.0, 92.0, 92.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 66.0, 65.0, 65.0, 66.0, 83.0, 64.0, 60.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 78.0, 71.0, 75.0, 74.0, 72.0, 98.0, 68.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 83.0, 80.0, 83.0, 80.0, 83.0, 79.0, 84.0, 89.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 134.0, 127.0, 129.0, 167.0, 135.0, 146.0, 141.0, 169.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 188.0, 158.0, 212.0, 221.0, 192.0, 168.0, 215.0, 165.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 68.0, 70.0, 59.0, 64.0, 80.0, 103.0, 97.0, 98.0], "value": 79.2, "unit": "score"}], "name": "kraken", "value": 1633.5000000000005, "alertThreshold": 2.0}]} 06:15:03 INFO - Return code: 0 06:15:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:15:03 ERROR - # TBPL SUCCESS # 06:15:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:03 INFO - 2016-05-09 06:15:03.592 screenresolution[1989:15311] starting screenresolution argv=screenresolution get 06:15:03 INFO - 2016-05-09 06:15:03.595 screenresolution[1989:15311] Display 0: 1600x1200x32@60 06:15:03 INFO - 2016-05-09 06:15:03.601 screenresolution[1990:15314] starting screenresolution argv=screenresolution list 06:15:03 INFO - Available Modes on Display 0 06:15:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:03 INFO - Intel Iris: 06:15:03 INFO - Chipset Model: Intel Iris 06:15:03 INFO - Type: GPU 06:15:03 INFO - Bus: Built-In 06:15:03 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:03 INFO - Vendor: Intel (0x8086) 06:15:03 INFO - Device ID: 0x0a2e 06:15:03 INFO - Revision ID: 0x0009 06:15:03 INFO - Displays: 06:15:03 INFO - Display: 06:15:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:03 INFO - Display Serial Number: 1600x1200 60 06:15:03 INFO - Main Display: Yes 06:15:03 INFO - Mirror: Off 06:15:03 INFO - Online: Yes 06:15:03 INFO - Rotation: Supported 06:15:03 INFO - Return code: 0 06:15:03 INFO - Running post-action listener: _resource_record_post_action 06:15:03 INFO - Running post-run listener: _resource_record_post_run 06:15:04 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 1212416; Write bytes: 653866496; Read time: 15; Write time: 1775 06:15:04 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 352875008; Write bytes: 346531328; Read time: 29104; Write time: 644 06:15:04 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 1212416; Write bytes: 297594880; Read time: 15; Write time: 1102 06:15:04 INFO - Running post-run listener: _upload_blobber_files 06:15:04 INFO - Blob upload gear active. 06:15:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:04 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 06:15:04 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'] 06:15:04 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 06:15:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:15:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:06 INFO - (blobuploader) - INFO - Done attempting. 06:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:06 INFO - (blobuploader) - INFO - Done attempting. 06:15:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:06 INFO - Return code: 0 06:15:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee6e55081636ac54be3ae7cd56eb09db6a1d21b56cbdffe15c59985081c91b8500c2a673c4bb344bb42f1de94cfee1c01da05fe51c18516d122ad0257934316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0510293bc8953c3ba7cc5b6cf19ae99f827e29108409cbc1ed1bb15683fe1dc4ddde7757715327a8211b1248f1ce8d2f4dd9a95483725360b550ffebf841ffb7"} 06:15:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:06 INFO - Contents: 06:15:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee6e55081636ac54be3ae7cd56eb09db6a1d21b56cbdffe15c59985081c91b8500c2a673c4bb344bb42f1de94cfee1c01da05fe51c18516d122ad0257934316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0510293bc8953c3ba7cc5b6cf19ae99f827e29108409cbc1ed1bb15683fe1dc4ddde7757715327a8211b1248f1ce8d2f4dd9a95483725360b550ffebf841ffb7"} 06:15:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:06 INFO - Copying logs to upload dir... 06:15:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.061082 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-09 06:15:07.020889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:07.024027) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee6e55081636ac54be3ae7cd56eb09db6a1d21b56cbdffe15c59985081c91b8500c2a673c4bb344bb42f1de94cfee1c01da05fe51c18516d122ad0257934316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0510293bc8953c3ba7cc5b6cf19ae99f827e29108409cbc1ed1bb15683fe1dc4ddde7757715327a8211b1248f1ce8d2f4dd9a95483725360b550ffebf841ffb7"} build_url:https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/J_hY6fdxQMm_M9plHZylsA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee6e55081636ac54be3ae7cd56eb09db6a1d21b56cbdffe15c59985081c91b8500c2a673c4bb344bb42f1de94cfee1c01da05fe51c18516d122ad0257934316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0510293bc8953c3ba7cc5b6cf19ae99f827e29108409cbc1ed1bb15683fe1dc4ddde7757715327a8211b1248f1ce8d2f4dd9a95483725360b550ffebf841ffb7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:07.055372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:07.056131) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RvsJPFdTV7/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Ez07OY8q7U/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005239 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 06:15:07.108981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:07.109667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 06:15:07.110320) ========= ========= Total master_lag: 0.17 =========