builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0137 starttime: 1461753655.41 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.411161) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.411597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.411869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.431376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.431690) ========= 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.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-04-27 03:40:55-- 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% 60.3M=0s 2016-04-27 03:40:55 (60.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.557194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.557504) ========= 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.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.026203 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:55.605763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 03:40:55.606130) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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 8551b253f4061db31e4be7829c2f70c2610caf42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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-04-27 03:40:55,682 truncating revision to first 12 chars 2016-04-27 03:40:55,682 Setting DEBUG logging. 2016-04-27 03:40:55,682 attempt 1/10 2016-04-27 03:40:55,683 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 03:40:57,116 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 03:40:57.308601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:57.308884) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:57.309256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:57.309519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 03:40:57.328799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-27 03:40:57.329114) ========= /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.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:40:57 INFO - MultiFileLogger online at 20160427 03:40:57 in /builds/slave/test 03:40:57 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 03:40:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:57 INFO - {'append_to_log': False, 03:40:57 INFO - 'base_work_dir': '/builds/slave/test', 03:40:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:57 INFO - 'branch': 'Mozilla-Aurora', 03:40:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:57 INFO - 'config_files': ('talos/mac_config.py',), 03:40:57 INFO - 'default_actions': ('clobber', 03:40:57 INFO - 'read-buildbot-config', 03:40:57 INFO - 'download-and-extract', 03:40:57 INFO - 'populate-webroot', 03:40:57 INFO - 'create-virtualenv', 03:40:57 INFO - 'install', 03:40:57 INFO - 'run-tests'), 03:40:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:57 INFO - 'download_minidump_stackwalk': True, 03:40:57 INFO - 'download_symbols': 'ondemand', 03:40:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:57 INFO - 'installer_path': 'installer.exe', 03:40:57 INFO - 'log_level': 'info', 03:40:57 INFO - 'log_name': 'talos', 03:40:57 INFO - 'log_to_console': True, 03:40:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:40:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:40:57 INFO - 'opt_config_files': (), 03:40:57 INFO - 'pip_index': False, 03:40:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:57 INFO - 'cmd': ('bash', 03:40:57 INFO - '-c', 03:40:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:57 INFO - 'enabled': True, 03:40:57 INFO - 'halt_on_failure': False, 03:40:57 INFO - 'name': 'check_screen_resolution'},), 03:40:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:40:57 INFO - 'cmd': ('bash', 03:40:57 INFO - '-c', 03:40:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:40:57 INFO - 'enabled': True, 03:40:57 INFO - 'halt_on_failure': False, 03:40:57 INFO - 'name': 'check_screen_resolution'},), 03:40:57 INFO - 'run_cmd_checks_enabled': True, 03:40:57 INFO - 'sps_profile': False, 03:40:57 INFO - 'sps_profile_interval': 0, 03:40:57 INFO - 'suite': 'dromaeojs-e10s', 03:40:57 INFO - 'system_bits': '32', 03:40:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:57 INFO - 'title': 't-yosemite-r7-0137', 03:40:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:57 INFO - 'use_talos_json': True, 03:40:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:57 INFO - 'work_dir': 'build'} 03:40:57 INFO - ##### 03:40:57 INFO - ##### Running clobber step. 03:40:57 INFO - ##### 03:40:57 INFO - Running pre-action listener: _resource_record_pre_action 03:40:57 INFO - Running main action method: clobber 03:40:57 INFO - rmtree: /builds/slave/test/build 03:40:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:59 INFO - Running post-action listener: _resource_record_post_action 03:40:59 INFO - ##### 03:40:59 INFO - ##### Running read-buildbot-config step. 03:40:59 INFO - ##### 03:40:59 INFO - Running pre-action listener: _resource_record_pre_action 03:40:59 INFO - Running main action method: read_buildbot_config 03:40:59 INFO - Using buildbot properties: 03:40:59 INFO - { 03:40:59 INFO - "project": "", 03:40:59 INFO - "product": "firefox", 03:40:59 INFO - "script_repo_revision": "production", 03:40:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:40:59 INFO - "repository": "", 03:40:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:40:59 INFO - "buildid": "20160425062348", 03:40:59 INFO - "pgo_build": "False", 03:40:59 INFO - "basedir": "/builds/slave/test", 03:40:59 INFO - "buildnumber": 299, 03:40:59 INFO - "slavename": "t-yosemite-r7-0137", 03:40:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:40:59 INFO - "platform": "yosemite_r7", 03:40:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:40:59 INFO - "branch": "mozilla-aurora", 03:40:59 INFO - "repo_path": "releases/mozilla-aurora", 03:40:59 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 03:40:59 INFO - "stage_platform": "macosx64", 03:40:59 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 03:40:59 INFO - "slavebuilddir": "test" 03:40:59 INFO - } 03:40:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 03:40:59 INFO - Running post-action listener: _resource_record_post_action 03:40:59 INFO - ##### 03:40:59 INFO - ##### Running download-and-extract step. 03:40:59 INFO - ##### 03:40:59 INFO - Running pre-action listener: _resource_record_pre_action 03:40:59 INFO - Running main action method: download_and_extract 03:40:59 INFO - mkdir: /builds/slave/test/build/tests 03:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:59 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:40:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 03:41:00 INFO - Downloaded 1277 bytes. 03:41:00 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 03:41:00 INFO - Using the following test package requirements: 03:41:00 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:41:00 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 03:41:00 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 03:41:00 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'jsshell-mac.zip'], 03:41:00 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 03:41:00 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:41:00 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 03:41:00 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 03:41:00 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 03:41:00 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 03:41:00 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 03:41:00 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 03:41:00 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:00 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:41:01 INFO - Downloaded 17919011 bytes. 03:41:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:41:04 INFO - Return code: 0 03:41:04 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:41: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')]} 03:41:04 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:41:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 03:41:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:41:06 INFO - Downloaded 17919011 bytes. 03:41:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:41:09 INFO - Return code: 0 03:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:09 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:41:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:41:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:41:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 03:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:41:10 INFO - Downloaded 10845194 bytes. 03:41:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:41:11 INFO - Return code: 0 03:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:11 INFO - https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:41:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:41:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:41:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 03:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 03:41:14 INFO - Downloaded 115767664 bytes. 03:41:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:41:14 INFO - mkdir: /builds/slave/test/properties 03:41:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:14 INFO - Contents: 03:41:14 INFO - build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 03:41:15 INFO - Running post-action listener: _resource_record_post_action 03:41:15 INFO - Running post-action listener: set_extra_try_arguments 03:41:15 INFO - ##### 03:41:15 INFO - ##### Running populate-webroot step. 03:41:15 INFO - ##### 03:41:15 INFO - Running pre-action listener: _resource_record_pre_action 03:41:15 INFO - Running main action method: populate_webroot 03:41:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:15 INFO - '--tppagecycles', 03:41:15 INFO - '7'], 03:41:15 INFO - 'tests': ['tsvgm']}}, 03:41:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:41:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:41:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'tests': ['damp', 'tps']}, 03:41:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['damp', 'tps']}, 03:41:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:41:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:15 INFO - 'other': {'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'other_l64': {'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:41:15 INFO - 'ts_paint', 03:41:15 INFO - 'tpaint', 03:41:15 INFO - 'sessionrestore', 03:41:15 INFO - 'sessionrestore_no_auto_restore', 03:41:15 INFO - 'tabpaint']}, 03:41:15 INFO - 'svgr': {'tests': ['tsvgx', 03:41:15 INFO - 'tsvgr_opacity', 03:41:15 INFO - 'tart', 03:41:15 INFO - 'tscrollx', 03:41:15 INFO - 'cart']}, 03:41:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['tsvgx', 03:41:15 INFO - 'tsvgr_opacity', 03:41:15 INFO - 'tart', 03:41:15 INFO - 'tscrollx', 03:41:15 INFO - 'cart']}, 03:41:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'tests': ['tp5o']}, 03:41:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'talos_options': ['--e10s'], 03:41:15 INFO - 'tests': ['tp5o']}, 03:41:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'talos_options': ['--xperf_path', 03:41:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:15 INFO - 'tests': ['tp5n']}, 03:41:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:15 INFO - 'talos_options': ['--e10s', 03:41:15 INFO - '--xperf_path', 03:41:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:15 INFO - 'tests': ['tp5n']}}, 03:41:15 INFO - 'talos.zip': {'path': '', 03:41:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:15 INFO - Running post-action listener: _resource_record_post_action 03:41:15 INFO - ##### 03:41:15 INFO - ##### Running create-virtualenv step. 03:41:15 INFO - ##### 03:41:15 INFO - Running pre-action listener: _resource_record_pre_action 03:41:15 INFO - Running main action method: create_virtualenv 03:41:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:41:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:15 INFO - Using real prefix '/tools/python27' 03:41:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:19 INFO - Installing pip.................done. 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:19 INFO - 'HOME': '/Users/cltbld', 03:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PAGER': '/bin/cat', 03:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:19 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - 'XPC_FLAGS': '0x0', 03:41:19 INFO - 'XPC_SERVICE_NAME': '0', 03:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:19 INFO - 'HOME': '/Users/cltbld', 03:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PAGER': '/bin/cat', 03:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:19 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - 'XPC_FLAGS': '0x0', 03:41:19 INFO - 'XPC_SERVICE_NAME': '0', 03:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Downloading/unpacking psutil>=0.7.1 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:22 INFO - Installing collected packages: psutil 03:41:22 INFO - Running setup.py install for psutil 03:41:22 INFO - building 'psutil._psutil_osx' extension 03:41:22 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 03:41:23 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 03:41:23 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 03:41:23 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 03:41:23 INFO - building 'psutil._psutil_posix' extension 03:41:23 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 03:41:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:41:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:41:23 INFO - ^ 03:41:23 INFO - 1 warning generated. 03:41:23 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 03:41:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:23 INFO - Successfully installed psutil 03:41:23 INFO - Cleaning up... 03:41:23 INFO - Return code: 0 03:41:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:23 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:23 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 03:41:23 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 03:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:23 INFO - 'HOME': '/Users/cltbld', 03:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:23 INFO - 'LOGNAME': 'cltbld', 03:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:23 INFO - 'MOZ_NO_REMOTE': '1', 03:41:23 INFO - 'NO_EM_RESTART': '1', 03:41:23 INFO - 'PAGER': '/bin/cat', 03:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:23 INFO - 'PWD': '/builds/slave/test', 03:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:23 INFO - 'SHELL': '/bin/bash', 03:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:23 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:23 INFO - 'USER': 'cltbld', 03:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:23 INFO - 'XPC_FLAGS': '0x0', 03:41:23 INFO - 'XPC_SERVICE_NAME': '0', 03:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:41:26 INFO - Installing collected packages: mozsystemmonitor 03:41:26 INFO - Running setup.py install for mozsystemmonitor 03:41:26 INFO - Successfully installed mozsystemmonitor 03:41:26 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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', '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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41: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 blobuploader==1.2.4 03:41:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:26 INFO - 'HOME': '/Users/cltbld', 03:41:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:26 INFO - 'LOGNAME': 'cltbld', 03:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:26 INFO - 'MOZ_NO_REMOTE': '1', 03:41:26 INFO - 'NO_EM_RESTART': '1', 03:41:26 INFO - 'PAGER': '/bin/cat', 03:41:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:26 INFO - 'PWD': '/builds/slave/test', 03:41:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:26 INFO - 'SHELL': '/bin/bash', 03:41:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:26 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:26 INFO - 'USER': 'cltbld', 03:41:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:26 INFO - 'XPC_FLAGS': '0x0', 03:41:26 INFO - 'XPC_SERVICE_NAME': '0', 03:41:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:30 INFO - Downloading docopt-0.6.1.tar.gz 03:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:30 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:30 INFO - Running setup.py install for blobuploader 03:41:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:31 INFO - Running setup.py install for requests 03:41:31 INFO - Running setup.py install for docopt 03:41:31 INFO - Successfully installed blobuploader requests docopt 03:41:31 INFO - Cleaning up... 03:41:31 INFO - Return code: 0 03:41:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:31 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:31 INFO - 'HOME': '/Users/cltbld', 03:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:31 INFO - 'LOGNAME': 'cltbld', 03:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:31 INFO - 'MOZ_NO_REMOTE': '1', 03:41:31 INFO - 'NO_EM_RESTART': '1', 03:41:31 INFO - 'PAGER': '/bin/cat', 03:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:31 INFO - 'PWD': '/builds/slave/test', 03:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:31 INFO - 'SHELL': '/bin/bash', 03:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:31 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:31 INFO - 'USER': 'cltbld', 03:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:31 INFO - 'XPC_FLAGS': '0x0', 03:41:31 INFO - 'XPC_SERVICE_NAME': '0', 03:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:31 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-T6kU3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-NQGReW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FDSkPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ZHFRH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-PGtwtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-eNnUvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Nw2ieV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gpFJBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SC5EYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:32 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-60oKeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jZSs3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-GLmvTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IJwwug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-BSSNE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-rSXhIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-CDY3Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:33 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xi8ONd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:33 INFO - Running setup.py install for manifestparser 03:41:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:33 INFO - Running setup.py install for mozcrash 03:41:34 INFO - Running setup.py install for mozdebug 03:41:34 INFO - Running setup.py install for mozdevice 03:41:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Running setup.py install for mozfile 03:41:34 INFO - Running setup.py install for mozhttpd 03:41:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Running setup.py install for mozinfo 03:41:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Running setup.py install for mozInstall 03:41:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:34 INFO - Running setup.py install for mozleak 03:41:35 INFO - Running setup.py install for mozlog 03:41:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Running setup.py install for moznetwork 03:41:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Running setup.py install for mozprocess 03:41:35 INFO - Running setup.py install for mozprofile 03:41:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Running setup.py install for mozrunner 03:41:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:35 INFO - Running setup.py install for mozscreenshot 03:41:35 INFO - Running setup.py install for moztest 03:41:36 INFO - Running setup.py install for mozversion 03:41:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:36 INFO - Cleaning up... 03:41:36 INFO - Return code: 0 03:41:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:36 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:36 INFO - 'HOME': '/Users/cltbld', 03:41:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:36 INFO - 'LOGNAME': 'cltbld', 03:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:36 INFO - 'MOZ_NO_REMOTE': '1', 03:41:36 INFO - 'NO_EM_RESTART': '1', 03:41:36 INFO - 'PAGER': '/bin/cat', 03:41:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:36 INFO - 'PWD': '/builds/slave/test', 03:41:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:36 INFO - 'SHELL': '/bin/bash', 03:41:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:36 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:36 INFO - 'USER': 'cltbld', 03:41:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:36 INFO - 'XPC_FLAGS': '0x0', 03:41:36 INFO - 'XPC_SERVICE_NAME': '0', 03:41:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-jaXZvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-TCWUkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FFhVas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-SUA0Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4GsF7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-uLYrYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-G9fTWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-E76Hl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-HG9Zdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-F3TmTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:37 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)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Y0xOD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-wn9XFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-JbEXCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hgKaoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:38 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-ktQzxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:38 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-iN4WFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:38 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-TKXCM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:40 INFO - Downloading blessings-1.6.tar.gz 03:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:40 INFO - Installing collected packages: blessings 03:41:40 INFO - Running setup.py install for blessings 03:41:41 INFO - Successfully installed blessings 03:41:41 INFO - Cleaning up... 03:41:41 INFO - Return code: 0 03:41:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:41 INFO - Reading from file tmpfile_stdout 03:41:41 INFO - Current package versions: 03:41:41 INFO - blessings == 1.6 03:41:41 INFO - blobuploader == 1.2.4 03:41:41 INFO - docopt == 0.6.1 03:41:41 INFO - manifestparser == 1.1 03:41:41 INFO - mozInstall == 1.12 03:41:41 INFO - mozcrash == 0.17 03:41:41 INFO - mozdebug == 0.1 03:41:41 INFO - mozdevice == 0.48 03:41:41 INFO - mozfile == 1.2 03:41:41 INFO - mozhttpd == 0.7 03:41:41 INFO - mozinfo == 0.9 03:41:41 INFO - mozleak == 0.1 03:41:41 INFO - mozlog == 3.1 03:41:41 INFO - moznetwork == 0.27 03:41:41 INFO - mozprocess == 0.22 03:41:41 INFO - mozprofile == 0.28 03:41:41 INFO - mozrunner == 6.11 03:41:41 INFO - mozscreenshot == 0.1 03:41:41 INFO - mozsystemmonitor == 0.0 03:41:41 INFO - moztest == 0.7 03:41:41 INFO - mozversion == 1.4 03:41:41 INFO - psutil == 3.1.1 03:41:41 INFO - requests == 1.2.3 03:41:41 INFO - wsgiref == 0.1.2 03:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:41 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:41 INFO - 'HOME': '/Users/cltbld', 03:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:41 INFO - 'LOGNAME': 'cltbld', 03:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:41 INFO - 'MOZ_NO_REMOTE': '1', 03:41:41 INFO - 'NO_EM_RESTART': '1', 03:41:41 INFO - 'PAGER': '/bin/cat', 03:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:41 INFO - 'PWD': '/builds/slave/test', 03:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:41 INFO - 'SHELL': '/bin/bash', 03:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:41 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:41 INFO - 'USER': 'cltbld', 03:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:41 INFO - 'XPC_FLAGS': '0x0', 03:41:41 INFO - 'XPC_SERVICE_NAME': '0', 03:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:41 INFO - Cleaning up... 03:41:41 INFO - Return code: 0 03:41:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:41 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:41 INFO - 'HOME': '/Users/cltbld', 03:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:41 INFO - 'LOGNAME': 'cltbld', 03:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:41 INFO - 'MOZ_NO_REMOTE': '1', 03:41:41 INFO - 'NO_EM_RESTART': '1', 03:41:41 INFO - 'PAGER': '/bin/cat', 03:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:41 INFO - 'PWD': '/builds/slave/test', 03:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:41 INFO - 'SHELL': '/bin/bash', 03:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:41 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:41 INFO - 'USER': 'cltbld', 03:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:41 INFO - 'XPC_FLAGS': '0x0', 03:41:41 INFO - 'XPC_SERVICE_NAME': '0', 03:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:41 INFO - Downloading/unpacking jsonschema 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:44 INFO - Downloading/unpacking functools32 (from jsonschema) 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:44 INFO - warning: no files found matching '*.txt' 03:41:44 INFO - no previously-included directories found matching 'build' 03:41:44 INFO - no previously-included directories found matching 'dist' 03:41:44 INFO - no previously-included directories found matching '.git*' 03:41:44 INFO - Installing collected packages: jsonschema, functools32 03:41:44 INFO - Running setup.py install for functools32 03:41:45 INFO - warning: no files found matching '*.txt' 03:41:45 INFO - no previously-included directories found matching 'build' 03:41:45 INFO - no previously-included directories found matching 'dist' 03:41:45 INFO - no previously-included directories found matching '.git*' 03:41:45 INFO - Successfully installed jsonschema functools32 03:41:45 INFO - Cleaning up... 03:41:45 INFO - Return code: 0 03:41:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:45 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 0x102e38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff85b5d1890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, '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.0DVAlsPifd/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.rZvH691seC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 03:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:45 INFO - 'HOME': '/Users/cltbld', 03:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:45 INFO - 'LOGNAME': 'cltbld', 03:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:45 INFO - 'MOZ_NO_REMOTE': '1', 03:41:45 INFO - 'NO_EM_RESTART': '1', 03:41:45 INFO - 'PAGER': '/bin/cat', 03:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:45 INFO - 'PWD': '/builds/slave/test', 03:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:45 INFO - 'SHELL': '/bin/bash', 03:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:41:45 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:45 INFO - 'USER': 'cltbld', 03:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:45 INFO - 'XPC_FLAGS': '0x0', 03:41:45 INFO - 'XPC_SERVICE_NAME': '0', 03:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:45 INFO - Downloading/unpacking flake8 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:41:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41: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 03:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:41:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:49 INFO - no previously-included directories found matching 'docs/_build' 03:41:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:41:49 INFO - Running setup.py install for pep8 03:41:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:41:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:41:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:41:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:41:49 INFO - no previously-included directories found matching 'docs/_build' 03:41:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:41:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:41:49 INFO - Cleaning up... 03:41:49 INFO - Return code: 0 03:41:49 INFO - Running post-action listener: _resource_record_post_action 03:41:49 INFO - Running post-action listener: _start_resource_monitoring 03:41:49 INFO - Starting resource monitoring. 03:41:49 INFO - ##### 03:41:49 INFO - ##### Running install step. 03:41:49 INFO - ##### 03:41:49 INFO - Running pre-action listener: _resource_record_pre_action 03:41:49 INFO - Running main action method: install 03:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:49 INFO - Reading from file tmpfile_stdout 03:41:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:49 INFO - Reading from file tmpfile_stdout 03:41:49 INFO - Output received: 03:41:49 INFO - Usage: mozinstall [options] installer 03:41:49 INFO - Options: 03:41:49 INFO - -h, --help show this help message and exit 03:41:49 INFO - -d DEST, --destination=DEST 03:41:49 INFO - Directory to install application into. [default: 03:41:49 INFO - "/builds/slave/test"] 03:41:49 INFO - --app=APP Application being installed. [default: firefox] 03:41:49 INFO - mkdir: /builds/slave/test/build/application 03:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:42:23 INFO - Reading from file tmpfile_stdout 03:42:23 INFO - Output received: 03:42:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:42:23 INFO - Running post-action listener: _resource_record_post_action 03:42:23 INFO - ##### 03:42:23 INFO - ##### Running run-tests step. 03:42:23 INFO - ##### 03:42:23 INFO - Running pre-action listener: _resource_record_pre_action 03:42:23 INFO - Running main action method: run_tests 03:42:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:23 INFO - 2016-04-27 03:42:23.484 screenresolution[1636:7420] starting screenresolution argv=screenresolution get 03:42:23 INFO - 2016-04-27 03:42:23.487 screenresolution[1636:7420] Display 0: 1600x1200x32@60 03:42:23 INFO - 2016-04-27 03:42:23.492 screenresolution[1637:7422] starting screenresolution argv=screenresolution list 03:42:23 INFO - Available Modes on Display 0 03:42:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:23 INFO - Intel Iris: 03:42:23 INFO - Chipset Model: Intel Iris 03:42:23 INFO - Type: GPU 03:42:23 INFO - Bus: Built-In 03:42:23 INFO - VRAM (Dynamic, Max): 1536 MB 03:42:23 INFO - Vendor: Intel (0x8086) 03:42:23 INFO - Device ID: 0x0a2e 03:42:23 INFO - Revision ID: 0x0009 03:42:23 INFO - Displays: 03:42:23 INFO - Display: 03:42:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:23 INFO - Display Serial Number: 1600x1200 60 03:42:23 INFO - Main Display: Yes 03:42:23 INFO - Mirror: Off 03:42:23 INFO - Online: Yes 03:42:23 INFO - Rotation: Supported 03:42:23 INFO - Return code: 0 03:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:23 INFO - Python 2.7.3 03:42:23 INFO - Return code: 0 03:42:23 INFO - grabbing minidump binary from tooltool 03:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:23 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 0x102cdcd30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:23 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 03:42:23 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 03:42:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:23 INFO - Return code: 0 03:42:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:42:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:42:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:42:25 INFO - Return code: 0 03:42:25 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/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 03:42:25 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/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 03:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0DVAlsPifd/Render', 03:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:42:25 INFO - 'HOME': '/Users/cltbld', 03:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:42:25 INFO - 'LOGNAME': 'cltbld', 03:42:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:25 INFO - 'MOZ_NO_REMOTE': '1', 03:42:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:25 INFO - 'NO_EM_RESTART': '1', 03:42:25 INFO - 'PAGER': '/bin/cat', 03:42:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:25 INFO - 'PWD': '/builds/slave/test', 03:42:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:42:25 INFO - 'SHELL': '/bin/bash', 03:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rZvH691seC/Listeners', 03:42:25 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 03:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:42:25 INFO - 'USER': 'cltbld', 03:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:25 INFO - 'XPC_FLAGS': '0x0', 03:42:25 INFO - 'XPC_SERVICE_NAME': '0', 03:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:42:25 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/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 03:42:25 INFO - mozversion application_buildid: 20160425062348 03:42:25 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:42:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:42:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:25 INFO - mozversion application_name: Firefox 03:42:25 INFO - mozversion application_remotingname: firefox-dev 03:42:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:25 INFO - mozversion application_vendor: Mozilla 03:42:25 INFO - mozversion application_version: 47.0a2 03:42:25 INFO - mozversion platform_buildid: 20160425062348 03:42:25 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 03:42:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:42:25 INFO - mozversion platform_version: 47.0a2 03:42:25 INFO - using testdate: 1461753745 03:42:25 INFO - actual date: 1461753745 03:42:25 INFO - starting webserver on 'localhost:49275' 03:42:25 INFO - SUITE-START | Running 2 tests 03:42:25 INFO - TEST-START | dromaeo_css 03:42:25 INFO - operating with platform_type : mac_ 03:42:25 INFO - Initialising browser for dromaeo_css test... 03:42:25 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmppUSucC/profile http://localhost:49275/getInfo.html) 03:42:27 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 03:42:27 INFO - PROCESS | 1655 | colorDepth:24 03:42:27 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 03:42:27 INFO - PROCESS | 1655 | __metrics 03:42:27 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:42:28 INFO - TEST-INFO | 1655: exit 0 03:42:28 INFO - Browser initialized. 03:42:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmppUSucC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:40 INFO - PROCESS | 1658 | RSS: Main: 217669632 03:42:40 INFO - PROCESS | 1658 | 03:43:30 INFO - PROCESS | 1658 | 1461753810407 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:45:42 INFO - PROCESS | 1658 | RSS: Main: 228450304 03:45:42 INFO - PROCESS | 1658 | 03:48:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:48:45 INFO - PROCESS | 1658 | RSS: Main: 240697344 03:48:45 INFO - PROCESS | 1658 | 03:51:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:51:47 INFO - PROCESS | 1658 | RSS: Main: 241639424 03:51:47 INFO - PROCESS | 1658 | 03:54:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:54:50 INFO - PROCESS | 1658 | RSS: Main: 244133888 03:54:50 INFO - PROCESS | 1658 | 03:57:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:57:53 INFO - PROCESS | 1658 | RSS: Main: 245993472 03:57:53 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:00:55 INFO - PROCESS | 1658 | RSS: Main: 247816192 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | __start_tp_report 04:00:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 04:00:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 04:00:55 INFO - PROCESS | 1658 | |i|pagename|runs| 04:00:55 INFO - PROCESS | 1658 | |0;dojo.html;3482.7562070655054;3520.4015317396033;3534.4874993126014;3573.4461158520407;3610.9097272568183;5889.61717488363;5899.056151015839;5901.4688678018965;5903.321118071429;5921.289445266563;5874.089516125007;5879.11813228016;5939.376365481627;5978.461938425541;5980.940190598093;5184.274201611768;5271.051210782058;5292.708901010443;5309;5346.091164502044;5214.66104703195;5305.522502974732;5328.813491527797;5345.572354211654;5359.169328754049;5314.335708036496;5322.2282768998475;5322.9620224056325;5334;5358.303420555322;5237.711925844077;5295.391030031538;5320.5211530962015;5347.251384806092;5348.465153484659;5159.509846564571;5325.360956685184;5346.198070289449;5373.328333958255;5374.167004114369;5885.234919460486;5897.115432685088;5941.792037278675;5944.167816505693;5969.820905372802;4897.4857639948;5098.209777484496;6194.1018552310115;6199.659018753967;6337.144485494446;6225.626462412224;6244.3755624437645;6281.780137695158;6281.905771413432;6286.434220920093;4958.9504104959215;5472.343318801769;5510.1459273812625;5976.7908123215475;6016.368281330485;6287.49700023997;6337.4613157882095;6358.554901156875;6381.968090159612;6393.328700486475;6251.031090181029;6298.275698294755;6305.211848518935;6306.400891915261;6308.116863639094;6322.683865806691;6339.651319177489;6346.428821406095;6347.333529979285;6354.745810167634;5175.197844334134;6138.541671868701;6220.968895155495;6324.9051264231075;6324.968375158187;6214.4407003369915;6294.874102517924;6302.432781049728;6302.558820882494;6310.716017779119;4891.217405215149;4951.084049450863;4960.553550180501;4966.056449274626;4966.230234313687;4408.074304396113;4410.404595379647;4453.821847126143;4464.866054018385;4498.955010449854;5872.119182122716;5968.46283834457;5968.582199246011;5970.432808883149;5971.641701497924;6150.708351246199;6274.968625156845;6307.684615769193;6318.210223722035;6320.652364119926;5754.88490230193;5886.175935369051;5936.1392598073035;5950.880982380415;6000.339962604197;4545.38637283969;5482.80810171642;5498.010358135494;5511.669299842022;5518.724063796794;6260.40526150015;6448.742050317935;6462.773802917063;6470.579412338183;6491.642959637171;6249.78125765596;6253.593516421418;6280.811575652738;6287.96856015717;6315.179026726496;5080.441151473409;6362.618242905441;6398.200224971879;6409.230892292955;6507.934920650733;6190.380961903774;6227.688615569113;6259.6870156492905;6312.5581209314905;6341.302456729663;5945.3757355477055;6294.4964402846745;6308.022256550242;6313.147725057059;6315.968420158054;6234.906476402767;6241.3134555197985;6242.1261023455845;6254.124422580751;6267.341929097562;6126.264848218064;6160.075988601746;6176.969115154396;6274.278457977391;6297.370262973666;5966.403359663999;6045.758169673164;6103.084537319438;6129.417705317987;6166.81499555014;6204.348543402878;6256.562040657111;6263.906041409291;6271.96864015677;6290.370962903673;6027.397260273938;6080.422359875804;6131.101423540838;6182.938170618416;6204.689765511616 04:00:55 INFO - PROCESS | 1658 | |1;ext.html;594.7442599682138;613.4877377389879;625.4652272307177;668.2949488289854;671.5668393885944;31378.68621313789;39670.404943925794;39934.60065399345;40016.79991600042;40051.79974100133;33919.49120763191;41057.97355066125;41339.75980720576;41717.16565668685;42023.159536809246;9493.620255189802;9588.904110958905;9637.277204209713;9644.951775241114;9735.464549449778;8796.384253102286;9597.904020959806;9756.707298781048;9778.11996920277;9860.260480463958;9742.805143897118;9821.459819709913;9825.017498250189;9831.115199632031;9852.605895764196;9757.853632195487;9777.853332200022;9780.755481112994;9792.020797920222;9811.90188098117;8398.580070996426;9669.226461883032;9713.417194968324;9799.510024498746;9803.509824508817;32533.6746632533;34841.9547413578;41085.589144108475;41585.58414415847;41852.790736046125;3149.008062460318;3284.917877053069;3334.733221342311;3353.0946644406117;3427.8628854845774;28368.290792730346;28648.71351286481;28904.855475722696;29180.708192918013;29532.114036578936;2769.418422131355;2776.9305767355777;2814.451182019507;2830.2782790388524;2889.436559870826;425752;429461;430039;431489;439572;48793.756031219615;70121.64939175373;70251;70737.64631176811;71026.289737103;48395.758021209665;48604;48759;48776.75611621919;48813;16824.90638108519;16933.661326773396;17030.57423564421;17183.3985810496;17188.398406055727;13379.799303010463;13480.730385392237;13560.254186019863;13600.65998350049;13643.908487321189;15751.606209844846;15847.128407937444;16112.113833739022;16257.837421625869;16302.266398012118;6417.39034791694;6475.7085931133215;6495.740170393131;6544.70548825304;6555.639439830855;827.9296259817862;1091.9454027298602;1124.686826022214;1126.6957921361186;1143.5425829668034;27711.030113945915;30092;30817.845910770302;31177.68822311748;31332.530012049836;1047.7642530430592;1197.4910662968205;1240.765438388809;1246.4328730427633;1247.357610830423;13856.515021974183;15786.13176275293;15813.209339532978;15845;15989.440369587008;469935;473719;474103;474791;477469;62807;64079.679601601696;65053.67473162698;65164.34835651678;65306.346936530026;1529.495266562032;1539.5304432148077;1552.2937063636243;1566.295167174776;1568.7960565126689;30446.238844029078;30814;30861.691383085883;30936.845315773277;31171.84414077915;56446.306610801745;56512.15231771609;56726.14910776259;56975.14537282027;57284.56788580319;497682;499402;500599;501842;502727.43181419297;31950.840245798623;35758;36288.81855590705;36313.273734524635;36828.44757328696;49601.75199123981;49882.75058624829;49943;50640;50847.745761270955;38826.80586597049;39159.41260881032;39513;39868.60131398649;40078.39882401708;38695.419568705925;39050.414243785795;39500;39938.60061399465;40024.799876000434;39160;40536.391954120125;40911.7954410226;41972.79013604912;42126.78936605297;30679.693203068575;33084.503732443554;33318;33537;33646.66353336533;25905.222843314732;26305.210843674722;26349.473010540067;26367.972827851605;26571.468570628094 04:00:55 INFO - PROCESS | 1658 | |2;jquery.html;332.72550146129447;352.365741665003;378.42668357438504;389.9727019108662;392.068836513281;20565.38303850885;20721.896390518046;21050;21738.130474780988;21770.673439898394;21012.78987210131;21633.891830540866;22315.55368892625;22568.097276108976;22688.546229075408;5967.433093856077;6014.669193194372;6237.968810155943;6244.781432649858;6248.562600617958;6074.5747797654185;6159.23009623797;6185.938140618581;6186.257649082094;6202.131701561785;5934.5845790794665;6070.693136608083;6073.574849760518;6113.816585502442;6175.197224360827;6039.7282122304605;6065.2418447694035;6076.392360763888;6078.787242446493;6106.206193194901;5243.318368612094;5259.842204733826;5275.314209152824;5312.2297266896085;5315.123004704219;27299.044533441433;27337.589936150973;27446.862765686245;27841.747121379587;27849.443011139665;2211.900464479102;2496.9750302496923;2506.448581312108;2651.893924243028;2708.8645567721537;15109.093454392772;15236.23818809055;15591.37634494619;15688.607784805357;15703.371865125382;1781.358710864088;1804.0799192411832;1816.7093265077656;1818.7726534183228;1835.7062869940746;101140.48289275667;106434;106807;106946;108861.45569272182;11379.601713939972;11580.710482237842;11581.363025033705;11786.292822430682;11789.292642441482;14335.426582936565;14345.6413589659;14482;14489;14543.418263269563;7941.888135660896;9039.548022598843;9097.09029097085;9111.134442227978;9198.908010919806;7228.915662650645;9194.26445884341;9350.812983740423;9362.157405833372;9366.531673416303;4581.198290299184;4646.210144275481;4655.20861453547;4677.345171675968;4690.81236750533;1953.64834329822;1984.176566724793;1985.7319261899459;1986.4537252255457;2009.336918816787;954.8042651256476;1007.8740157480315;1063.728749168957;1073.9194560407843;1089.7166736648528;21107.894460527907;21340.93295335227;21370.893145534174;21625.13392325684;21698;1013.4342440928635;1015.4313584392763;1022.3559157730731;1039.3504059962524;1087.3095584303867;11484.310941343547;11717.941410293064;11729.706757330965;11737.70885202627;11766.294022358687;489695;663577.1853688795;682077;686566;691042;126225;128730;129715.35142324227;131315;131523;1073.1736562846565;1080.378782200238;1084.8915108489089;1089.841972913939;1096.040964156363;19307.03464826781;19311.03444827725;19464.902675487097;19515.414537563895;19585.60828783445;56978.43021569731;57321.14018289646;57403.71298143482;58085.419145808;58339.24982250539;67640;71109;81787;82638;84110.05614803452;8362.852609836791;8414.284785793032;8462.788430289293;8467.49195048299;8545.82908341842;9597.568109434953;10744.946275268887;13641.181529108286;14005.579832605039;14056.297185140498;9263.120003599648;10570.630027948984;10680.83978740335;11873.821892671443;12231.571894983634;10736.194785391282;10832;11749.471273792871;11925.940370298093;12166.026717862373;11843.881561184622;11943;12087.939560302142;12284.754304913673;12367.876321236672;6685.732570697118;8098.109207986999;8415.078719934483;8477.855489508838;8492.447990880573;7455.440841936985;10798.244122911321;12052.939735301617;12206;12208.328541929925 04:00:55 INFO - PROCESS | 1658 | |3;mootools.html;1663.1351697117498;1668.9833101668983;2004.6792513197881;2027.675571908494;2119.480727221831;8362.03836558796;8977.461352318865;9193.678221262257;9410.905890941089;9412.90587094129;6770.458363330934;9036.50299233542;9070.319726020558;9166.954165229181;9644.18024467921;1924.2976313645488;2246.2362796649136;2528.5195812795555;2535.8098142639283;2545.7581529754643;2513.6229565565127;2542.656741339923;2567.4736678980858;2572.3954870605394;2580.6387105805106;2541.8474891506476;2548.719640839506;2571.961420578693;2584.1084825735184;2585.663863697717;2321.93034208974;2364.869932153731;2559.168270312147;2572.266903932389;2576.0211119774553;2464.9753502464923;2485.875706214682;2492.2149522900227;2496.5506208882393;2530.089167899573;9229.6308147674;9267.536623168882;9288.256939444827;9308.627654893797;9362.25101991839;5680.403557626431;5772.740226689809;5820.1269809528485;5850.297964244318;5870.735816888207;3693.4829123922405;3754.4743735877;3769.095417099876;3804.1630841214887;3838.692904567628;956.9425784508157;1064.9840252396143;1080;1101.6254473479055;1120.1430905357408;12298.754024919452;12335.876641233563;12535.99712023036;12578.55975040869;12600.558980435733;5116.948830511722;5133.614978876524;5175.45657705943;5187.455317191716;5228.660137091153;10573.312734672221;10573.682789516326;10601.734956626146;10636.680899573024;10638.255322127377;5756.3380211276235;5791.5656325775735;5807.651540907559;5830.125481177773;5835.766569337179;4641.512641172628;5078.21287700407;5176.637635365563;5218.66078704883;5237.162054071407;4115.794210289474;4119.773412462343;4134.855280065183;4137.710360274812;4146.771927543954;1346.0712108645005;1356.6133651909158;1356.7083077138464;1358.891288696902;1364.8908087352988;1393.7212557488542;1413.9858601413855;1437.037185085995;1442.6537630968492;1454.0984589554544;8424.747257582283;8432.578371081545;8491.19333663301;8503.277221436123;8526.531040792692;462.4658519410087;532.498820256813;540.4460428061269;540.6566830062939;544.3141641531698;6240.438360547572;6289.528285378524;6375.553711240169;6388.744450221939;6392.977123660192;9811.509424528746;10720.839187412195;10849.349039057524;11274;11288.604898828666;9525.714228573153;10704.250702450754;11074.723131921766;11134.554617815196;11184.273022253528;8513.19124683154;8724;8759.562021899006;8811.603477843513;8869.334799890034;8108.635111419882;8173.264406203471;8344.541050242295;8394.370422218235;8467.661293548435;8266.958665206635;9647.372920760408;9860.211183105192;9938.801223975624;10002.599896004369;10151.593936242467;10152.593896244067;10204.897951020395;10220.897791021995;10261.692149235534;7798.33714134305;7827.412944029106;7946.682132714626;7962.960185199037;8007.759767206993;8582.78543036429;8619.741407757778;8636.654533818577;8672.436291641023;8680.045195028415;7274.636268186676;7440.888386674313;7645;7676.53940763556;7961.363090952594;7437.293457121565;7441.776746697607;7462.365698915653;7544.207858175032;7597.886031709419;6614;7893.17121702236;7961.482503637245;8012.359011278967;8043.597820108854;7176.246494118042;7190.928090719026;7247.456440766858;7251.456140789567;7268.41852651776;7429.03422555086;7433.851322973402;7455.0681164854395;7469.626518673936;7497.2877576630135 04:00:55 INFO - PROCESS | 1658 | |4;prototype.html;297.2361032147382;335.2691133329342;337.21765504030645;337.4566947214985;347.806967133241;6785.117934668492;6797.11637487126;6840.65796710165;6871.484638652102;6877.931220687791;6747.773234832506;6758.695858686358;6789.694463749131;6812.080369150163;6815.035459575076;4732.621390288768;4842.1042107210105;4916.459189489154;4935.407751069876;5024.84925452237;4924.507549245065;4936.3829521309835;4955.430125535556;4960.131976904027;4964.131277026506;4872.78072486739;4887.975560122194;4896.387951506062;4896.755162241891;4913.656044076916;4881.951180488203;4903.65674402792;4927.6797008194535;4970.453250142481;5003.724795136266;4273.786310684453;4293.162833247518;4296.785160741982;4313.331433627793;4314.762688052156;5162.896742065138;5865.58940874139;6210.347913469066;6409.903851442232;6529.934700652981;5860.120981852713;5922.200502932092;5935.52515798735;5961.791337303173;5967.522598192134;6102.542309326774;7154.213036565973;7159.534630249069;7168.60572668503;7208.098987626547;4334.804933777988;4453.376527286183;4800.903981920377;4807.687500312469;4816.831410900601;7573.697052117908;7591.24087591242;7602.695892164307;7605.201453847377;7621.199774023703;4723.881902952385;4872.098661747588;4891.437484689306;4904.852854414302;4929.679570827885;4991.201407774739;5013.24801279811;5017.096922553902;5032.094223039888;5034.0938631046765;5118.488151184852;5442.428545002796;5872.324682661549;5878.412158784173;5882.323532793698;5748.5688573357165;6178.5366097542865;7163.176234733072;7172.354488096096;7221.494495385273;1409.6616811965055;1724.043156048405;1740.3038784486307;1745.6246906915073;1746.0920321432784;849.3332733804058;1088.515610553312;1127.4869934179928;1138.3397629375108;1151.6199654114123;5058.215976523645;6565.113709649137;6627.768028118992;6661.4004739573675;6679.76620818269;7431.554106753612;7436.516626419266;7445.664945077485;7455.925440745523;7485.401167906554;5844.714162884159;6270.372962703693;6424.9036264455135;6768.120144381297;6806.93193068063;3955.4462375267485;3983.900402489961;4002.479677641888;4023.155137421116;4029.7582145071387;7865.134835168127;7885.014373203349;7885.29032387088;7896.170902055316;7898.131205567383;7475.289847464483;7825.647845846951;7840.255175758294;7841.451098423056;7862.803429914298;7142.857142857114;7481.251874812475;7835.216478352119;7838.412119091091;7900.525968441797;6102.359252278625;6826.249112597511;7557.6221188939235;7570.697172113054;7577.583232922242;7353.485256032026;7371.336579707852;7386.446016548673;7395.963020184865;7407;7617.581033043236;7780.144184139627;7809.687612495663;7824.882626760717;7908.5650289234645;4413.073254616438;4699.788509517149;4733.502982186821;4742.952570474251;4750.691205071659;6477;7074.504784665024;7488.288612581796;7502.137254215835;7502.287282708134;7213.783586492414;7226.927730722836;7237.240089790706;7239.8552028960175;7283.890741638986;7005.194402643761;7060.43516518667;7214.71141154348;7230.566166030055;7239.601821899846;7153.35619794221;7155.284471552803;7196.8920466194095;7217.170025446931;7242.239564845615;7171.995920571228;7174.605396703231;7192.820179495555;7198.748043818441;7211.459140564374;7056.7530136444975;7176.4258859290085;7181.820454488679;7188.424926005802;7227.385672217921 04:00:55 INFO - PROCESS | 1658 | |5;yui.html;660.2736989311758;699.625700250366;741.2143128284016;766.9693212271509;772.5866661336182;12133.453994570244;15310.770338444932;15492.380304787795;15559.533214003584;15603.453879114233;11601.767964640701;14499.275036248171;14501.92749036256;14543.272836358192;14555.053921495095;761.3300295739741;953.7186529973675;956.603009750956;967.9467629280387;973.9707808765748;956.0439560439561;959.7264779537833;961.024560071528;970.4274478057945;975.7804493988831;1008.2035192198191;1009.9848502272472;1021.0912288063629;1023.161007973462;1025.5385076715509;991.5141580625514;992.503748125937;1018.3838777539556;1019.2610357490834;1020.9489525523694;759.7492827366956;762.3443838299058;769.4882902869585;769.5651956644534;771.5409331447779;15036.548903532912;15061.02103363289;15144.318505667272;15207.239638018165;15333.003354781904;13302.667433314147;13324.933375333158;13336.333183340794;13384.130031548015;13451.394687239097;10032.548535315855;10144.746381340452;10278.897211027943;10310.845337319946;10378.325408848401;3321.8837340693203;3371.8482668279985;3388.644192359816;3437.8796742114155;3592.6407359264126;76593.61703191504;78579.8213026805;79099.6045019777;79116.20883791204;80562;8328;9614.9038509614;9767.658131965489;9932.503374831229;10019.198464122852;22523.774762252167;22689.773102269097;22713.318600442013;22718.772812271996;22722.97746601407;7705.653245603961;7734.458587898793;7771.33943614799;7796.259355361231;7981.281684648409;4231.314503256771;4242.278812601865;4253.532111467736;4276.444062271947;4280.978595107067;3749.9437508437395;3797.1646237827636;3829.368154254517;3833.463315135883;3837.2517359114704;670.6747227594612;683.2723149845498;683.3235097253782;688.1638808847175;706.2831226305304;530.0379810643747;554.6561132098125;612.1338306296541;613.3437222172322;615.230961298377;7850.921490785133;7908.853216283606;8275.08974012858;8583.742487725378;8674.175953284428;537.9704116273564;554.8973439913628;610.2280615022;629.276332217953;633.4140919649305;3224.822634755111;3447.3967055765143;3980.24375368679;4032.717709760347;4092.4884389451317;103603;103871;105340.94659053464;106328;106418;67850.32149678539;79336.80994785082;84409.15590844136;85207;88011.55994219988;65942.67028664827;75758.9999999989;76990.61504692552;77318;78065;8006.239407256301;8095.23095305945;8130.268275855202;8148.918510814816;8238.588070596566;50771.238431424295;51117.48882511127;52695;53047.46952530425;56060.43939560552;53275.467245327054;53786.46213537815;53963.46036539741;57617.42382576121;72545;11373.088776517705;11501.367424791717;11596.536138554364;11767.411629418666;12222.816657749963;12100.45547950362;12142.08934329911;12274.202176858476;12323.260604363766;12844.678883027998;11478.253913495597;11887.76224475523;12007.75984480323;12238.510459581874;12276.32480213561;9534.856977145488;9868;11534.769304613694;11824.93575578202;12221.938890305491;9435.339526233098;11457.885421145682;11681.182317238052;11814.94092529532;11870.58452954177;9596.66411675588;9719.319647624598;9787.902120978699;9964.202863770735;10317;9189.34299791831;10087.445190514592;10096.29325947206;10097.44464054484;10099.293049486465 04:00:55 INFO - PROCESS | 1658 | __end_tp_report 04:00:55 INFO - PROCESS | 1658 | __start_cc_report 04:00:55 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,369 04:00:55 INFO - PROCESS | 1658 | __end_cc_report 04:00:55 INFO - PROCESS | 1658 | __startTimestamp1461754855753__endTimestamp 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | ------- Summary: start ------- 04:00:55 INFO - PROCESS | 1658 | Number of tests: 6 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5814.31 Median:6045.76 stddev:651.78 (10.8%) stddev-sans-first:627.59 04:00:55 INFO - PROCESS | 1658 | Values: 3482.8 3520.4 3534.5 3573.4 3610.9 5889.6 5899.1 5901.5 5903.3 5921.3 5874.1 5879.1 5939.4 5978.5 5980.9 5184.3 5271.1 5292.7 5309.0 5346.1 5214.7 5305.5 5328.8 5345.6 5359.2 5314.3 5322.2 5323.0 5334.0 5358.3 5237.7 5295.4 5320.5 5347.3 5348.5 5159.5 5325.4 5346.2 5373.3 5374.2 5885.2 5897.1 5941.8 5944.2 5969.8 4897.5 5098.2 6194.1 6199.7 6337.1 6225.6 6244.4 6281.8 6281.9 6286.4 4959.0 5472.3 5510.1 5976.8 6016.4 6287.5 6337.5 6358.6 6382.0 6393.3 6251.0 6298.3 6305.2 6306.4 6308.1 6322.7 6339.7 6346.4 6347.3 6354.7 5175.2 6138.5 6221.0 6324.9 6325.0 6214.4 6294.9 6302.4 6302.6 6310.7 4891.2 4951.1 4960.6 4966.1 4966.2 4408.1 4410.4 4453.8 4464.9 4499.0 5872.1 5968.5 5968.6 5970.4 5971.6 6150.7 6275.0 6307.7 6318.2 6320.7 5754.9 5886.2 5936.1 5950.9 6000.3 4545.4 5482.8 5498.0 5511.7 5518.7 6260.4 6448.7 6462.8 6470.6 6491.6 6249.8 6253.6 6280.8 6288.0 6315.2 5080.4 6362.6 6398.2 6409.2 6507.9 6190.4 6227.7 6259.7 6312.6 6341.3 5945.4 6294.5 6308.0 6313.1 6316.0 6234.9 6241.3 6242.1 6254.1 6267.3 6126.3 6160.1 6177.0 6274.3 6297.4 5966.4 6045.8 6103.1 6129.4 6166.8 6204.3 6256.6 6263.9 6272.0 6290.4 6027.4 6080.4 6131.1 6182.9 6204.7 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:62235.58 Median:40038.30 stddev:124514.50 (311.0%) stddev-sans-first:124777.78 04:00:55 INFO - PROCESS | 1658 | Values: 594.7 613.5 625.5 668.3 671.6 31378.7 39670.4 39934.6 40016.8 40051.8 33919.5 41058.0 41339.8 41717.2 42023.2 9493.6 9588.9 9637.3 9645.0 9735.5 8796.4 9597.9 9756.7 9778.1 9860.3 9742.8 9821.5 9825.0 9831.1 9852.6 9757.9 9777.9 9780.8 9792.0 9811.9 8398.6 9669.2 9713.4 9799.5 9803.5 32533.7 34842.0 41085.6 41585.6 41852.8 3149.0 3284.9 3334.7 3353.1 3427.9 28368.3 28648.7 28904.9 29180.7 29532.1 2769.4 2776.9 2814.5 2830.3 2889.4 425752.0 429461.0 430039.0 431489.0 439572.0 48793.8 70121.6 70251.0 70737.6 71026.3 48395.8 48604.0 48759.0 48776.8 48813.0 16824.9 16933.7 17030.6 17183.4 17188.4 13379.8 13480.7 13560.3 13600.7 13643.9 15751.6 15847.1 16112.1 16257.8 16302.3 6417.4 6475.7 6495.7 6544.7 6555.6 827.9 1091.9 1124.7 1126.7 1143.5 27711.0 30092.0 30817.8 31177.7 31332.5 1047.8 1197.5 1240.8 1246.4 1247.4 13856.5 15786.1 15813.2 15845.0 15989.4 469935.0 473719.0 474103.0 474791.0 477469.0 62807.0 64079.7 65053.7 65164.3 65306.3 1529.5 1539.5 1552.3 1566.3 1568.8 30446.2 30814.0 30861.7 30936.8 31171.8 56446.3 56512.2 56726.1 56975.1 57284.6 497682.0 499402.0 500599.0 501842.0 502727.4 31950.8 35758.0 36288.8 36313.3 36828.4 49601.8 49882.8 49943.0 50640.0 50847.7 38826.8 39159.4 39513.0 39868.6 40078.4 38695.4 39050.4 39500.0 39938.6 40024.8 39160.0 40536.4 40911.8 41972.8 42126.8 30679.7 33084.5 33318.0 33537.0 33646.7 25905.2 26305.2 26349.5 26368.0 26571.5 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:36511.39 Median:21718.07 stddev:107367.85 (494.4%) stddev-sans-first:107634.67 04:00:55 INFO - PROCESS | 1658 | Values: 332.7 352.4 378.4 390.0 392.1 20565.4 20721.9 21050.0 21738.1 21770.7 21012.8 21633.9 22315.6 22568.1 22688.5 5967.4 6014.7 6238.0 6244.8 6248.6 6074.6 6159.2 6185.9 6186.3 6202.1 5934.6 6070.7 6073.6 6113.8 6175.2 6039.7 6065.2 6076.4 6078.8 6106.2 5243.3 5259.8 5275.3 5312.2 5315.1 27299.0 27337.6 27446.9 27841.7 27849.4 2211.9 2497.0 2506.4 2651.9 2708.9 15109.1 15236.2 15591.4 15688.6 15703.4 1781.4 1804.1 1816.7 1818.8 1835.7 101140.5 106434.0 106807.0 106946.0 108861.5 11379.6 11580.7 11581.4 11786.3 11789.3 14335.4 14345.6 14482.0 14489.0 14543.4 7941.9 9039.5 9097.1 9111.1 9198.9 7228.9 9194.3 9350.8 9362.2 9366.5 4581.2 4646.2 4655.2 4677.3 4690.8 1953.6 1984.2 1985.7 1986.5 2009.3 954.8 1007.9 1063.7 1073.9 1089.7 21107.9 21340.9 21370.9 21625.1 21698.0 1013.4 1015.4 1022.4 1039.4 1087.3 11484.3 11717.9 11729.7 11737.7 11766.3 489695.0 663577.2 682077.0 686566.0 691042.0 126225.0 128730.0 129715.4 131315.0 131523.0 1073.2 1080.4 1084.9 1089.8 1096.0 19307.0 19311.0 19464.9 19515.4 19585.6 56978.4 57321.1 57403.7 58085.4 58339.2 67640.0 71109.0 81787.0 82638.0 84110.1 8362.9 8414.3 8462.8 8467.5 8545.8 9597.6 10744.9 13641.2 14005.6 14056.3 9263.1 10570.6 10680.8 11873.8 12231.6 10736.2 10832.0 11749.5 11925.9 12166.0 11843.9 11943.0 12087.9 12284.8 12367.9 6685.7 8098.1 8415.1 8477.9 8492.4 7455.4 10798.2 12052.9 12206.0 12208.3 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:6271.52 Median:540.55 stddev:3312.29 (612.8%) stddev-sans-first:3303.47 04:00:55 INFO - PROCESS | 1658 | Values: 1663.1 1669.0 2004.7 2027.7 2119.5 8362.0 8977.5 9193.7 9410.9 9412.9 6770.5 9036.5 9070.3 9167.0 9644.2 1924.3 2246.2 2528.5 2535.8 2545.8 2513.6 2542.7 2567.5 2572.4 2580.6 2541.8 2548.7 2572.0 2584.1 2585.7 2321.9 2364.9 2559.2 2572.3 2576.0 2465.0 2485.9 2492.2 2496.6 2530.1 9229.6 9267.5 9288.3 9308.6 9362.3 5680.4 5772.7 5820.1 5850.3 5870.7 3693.5 3754.5 3769.1 3804.2 3838.7 956.9 1065.0 1080.0 1101.6 1120.1 12298.8 12335.9 12536.0 12578.6 12600.6 5116.9 5133.6 5175.5 5187.5 5228.7 10573.3 10573.7 10601.7 10636.7 10638.3 5756.3 5791.6 5807.7 5830.1 5835.8 4641.5 5078.2 5176.6 5218.7 5237.2 4115.8 4119.8 4134.9 4137.7 4146.8 1346.1 1356.6 1356.7 1358.9 1364.9 1393.7 1414.0 1437.0 1442.7 1454.1 8424.7 8432.6 8491.2 8503.3 8526.5 462.5 532.5 540.4 540.7 544.3 6240.4 6289.5 6375.6 6388.7 6393.0 9811.5 10720.8 10849.3 11274.0 11288.6 9525.7 10704.3 11074.7 11134.6 11184.3 8513.2 8724.0 8759.6 8811.6 8869.3 8108.6 8173.3 8344.5 8394.4 8467.7 8267.0 9647.4 9860.2 9938.8 10002.6 10151.6 10152.6 10204.9 10220.9 10261.7 7798.3 7827.4 7946.7 7963.0 8007.8 8582.8 8619.7 8636.7 8672.4 8680.0 7274.6 7440.9 7645.0 7676.5 7961.4 7437.3 7441.8 7462.4 7544.2 7597.9 6614.0 7893.2 7961.5 8012.4 8043.6 7176.2 7190.9 7247.5 7251.5 7268.4 7429.0 7433.9 7455.1 7469.6 7497.3 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5879.04 Median:6670.58 stddev:1878.50 (28.2%) stddev-sans-first:1836.46 04:00:55 INFO - PROCESS | 1658 | Values: 297.2 335.3 337.2 337.5 347.8 6785.1 6797.1 6840.7 6871.5 6877.9 6747.8 6758.7 6789.7 6812.1 6815.0 4732.6 4842.1 4916.5 4935.4 5024.8 4924.5 4936.4 4955.4 4960.1 4964.1 4872.8 4888.0 4896.4 4896.8 4913.7 4882.0 4903.7 4927.7 4970.5 5003.7 4273.8 4293.2 4296.8 4313.3 4314.8 5162.9 5865.6 6210.3 6409.9 6529.9 5860.1 5922.2 5935.5 5961.8 5967.5 6102.5 7154.2 7159.5 7168.6 7208.1 4334.8 4453.4 4800.9 4807.7 4816.8 7573.7 7591.2 7602.7 7605.2 7621.2 4723.9 4872.1 4891.4 4904.9 4929.7 4991.2 5013.2 5017.1 5032.1 5034.1 5118.5 5442.4 5872.3 5878.4 5882.3 5748.6 6178.5 7163.2 7172.4 7221.5 1409.7 1724.0 1740.3 1745.6 1746.1 849.3 1088.5 1127.5 1138.3 1151.6 5058.2 6565.1 6627.8 6661.4 6679.8 7431.6 7436.5 7445.7 7455.9 7485.4 5844.7 6270.4 6424.9 6768.1 6806.9 3955.4 3983.9 4002.5 4023.2 4029.8 7865.1 7885.0 7885.3 7896.2 7898.1 7475.3 7825.6 7840.3 7841.5 7862.8 7142.9 7481.3 7835.2 7838.4 7900.5 6102.4 6826.2 7557.6 7570.7 7577.6 7353.5 7371.3 7386.4 7396.0 7407.0 7617.6 7780.1 7809.7 7824.9 7908.6 4413.1 4699.8 4733.5 4743.0 4750.7 6477.0 7074.5 7488.3 7502.1 7502.3 7213.8 7226.9 7237.2 7239.9 7283.9 7005.2 7060.4 7214.7 7230.6 7239.6 7153.4 7155.3 7196.9 7217.2 7242.2 7172.0 7174.6 7192.8 7198.7 7211.5 7056.8 7176.4 7181.8 7188.4 7227.4 04:00:55 INFO - PROCESS | 1658 | 04:00:55 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18753.12 Median:27526.11 stddev:26806.72 (97.4%) stddev-sans-first:26847.49 04:00:55 INFO - PROCESS | 1658 | Values: 660.3 699.6 741.2 767.0 772.6 12133.5 15310.8 15492.4 15559.5 15603.5 11601.8 14499.3 14501.9 14543.3 14555.1 761.3 953.7 956.6 967.9 974.0 956.0 959.7 961.0 970.4 975.8 1008.2 1010.0 1021.1 1023.2 1025.5 991.5 992.5 1018.4 1019.3 1020.9 759.7 762.3 769.5 769.6 771.5 15036.5 15061.0 15144.3 15207.2 15333.0 13302.7 13324.9 13336.3 13384.1 13451.4 10032.5 10144.7 10278.9 10310.8 10378.3 3321.9 3371.8 3388.6 3437.9 3592.6 76593.6 78579.8 79099.6 79116.2 80562.0 8328.0 9614.9 9767.7 9932.5 10019.2 22523.8 22689.8 22713.3 22718.8 22723.0 7705.7 7734.5 7771.3 7796.3 7981.3 4231.3 4242.3 4253.5 4276.4 4281.0 3749.9 3797.2 3829.4 3833.5 3837.3 670.7 683.3 683.3 688.2 706.3 530.0 554.7 612.1 613.3 615.2 7850.9 7908.9 8275.1 8583.7 8674.2 538.0 554.9 610.2 629.3 633.4 3224.8 3447.4 3980.2 4032.7 4092.5 103603.0 103871.0 105340.9 106328.0 106418.0 67850.3 79336.8 84409.2 85207.0 88011.6 65942.7 75759.0 76990.6 77318.0 78065.0 8006.2 8095.2 8130.3 8148.9 8238.6 50771.2 51117.5 52695.0 53047.5 56060.4 53275.5 53786.5 53963.5 57617.4 72545.0 11373.1 11501.4 11596.5 11767.4 12222.8 12100.5 12142.1 12274.2 12323.3 12844.7 11478.3 11887.8 12007.8 12238.5 12276.3 9534.9 9868.0 11534.8 11824.9 12221.9 9435.3 11457.9 11681.2 11814.9 11870.6 9596.7 9719.3 9787.9 9964.2 10317.0 9189.3 10087.4 10096.3 10097.4 10099.3 04:00:55 INFO - PROCESS | 1658 | -------- Summary: end -------- 04:00:55 INFO - PROCESS | 1658 | 04:00:56 INFO - TEST-INFO | 1658: exit 0 04:00:56 INFO - TEST-OK | dromaeo_css | took 1111031ms 04:00:56 INFO - TEST-START | kraken 04:00:56 INFO - operating with platform_type : mac_ 04:00:56 INFO - Initialising browser for kraken test... 04:00:56 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp6Waoxo/profile http://localhost:49275/getInfo.html) 04:00:58 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 04:00:58 INFO - PROCESS | 1673 | colorDepth:24 04:00:58 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 04:00:58 INFO - PROCESS | 1673 | __metrics 04:00:58 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:00:59 INFO - TEST-INFO | 1673: exit 0 04:00:59 INFO - Browser initialized. 04:00:59 INFO - Running cycle 1/1 for kraken test... 04:00:59 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp6Waoxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:11 INFO - PROCESS | 1676 | RSS: Main: 218116096 04:01:11 INFO - PROCESS | 1676 | 04:01:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:14 INFO - PROCESS | 1676 | RSS: Main: 229953536 04:01:14 INFO - PROCESS | 1676 | 04:01:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:01:17 INFO - PROCESS | 1676 | RSS: Main: 238915584 04:01:17 INFO - PROCESS | 1676 | 04:01:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:01:21 INFO - PROCESS | 1676 | RSS: Main: 242376704 04:01:21 INFO - PROCESS | 1676 | 04:01:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:01:24 INFO - PROCESS | 1676 | RSS: Main: 244035584 04:01:24 INFO - PROCESS | 1676 | 04:01:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:27 INFO - PROCESS | 1676 | RSS: Main: 244617216 04:01:27 INFO - PROCESS | 1676 | 04:01:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:30 INFO - PROCESS | 1676 | RSS: Main: 244592640 04:01:30 INFO - PROCESS | 1676 | 04:01:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:33 INFO - PROCESS | 1676 | RSS: Main: 245219328 04:01:33 INFO - PROCESS | 1676 | 04:01:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:01:37 INFO - PROCESS | 1676 | RSS: Main: 244649984 04:01:37 INFO - PROCESS | 1676 | 04:01:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:39 INFO - PROCESS | 1676 | RSS: Main: 244547584 04:01:39 INFO - PROCESS | 1676 | 04:01:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:42 INFO - PROCESS | 1676 | RSS: Main: 244613120 04:01:42 INFO - PROCESS | 1676 | 04:01:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:45 INFO - PROCESS | 1676 | RSS: Main: 244887552 04:01:45 INFO - PROCESS | 1676 | 04:01:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:48 INFO - PROCESS | 1676 | RSS: Main: 244899840 04:01:48 INFO - PROCESS | 1676 | 04:01:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:51 INFO - PROCESS | 1676 | RSS: Main: 245092352 04:01:51 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:01:53 INFO - PROCESS | 1676 | RSS: Main: 246771712 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | __start_tp_report 04:01:53 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 04:01:53 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 04:01:53 INFO - PROCESS | 1676 | |i|pagename|runs| 04:01:53 INFO - PROCESS | 1676 | |0;ai-astar;116;112;118;114;116;130;116;115;116;116 04:01:53 INFO - PROCESS | 1676 | |1;audio-beat-detection;178;119;141;153;120;139;117;154;150;121 04:01:53 INFO - PROCESS | 1676 | |2;audio-dft;187;280;257;200;195;196;195;197;200;202 04:01:53 INFO - PROCESS | 1676 | |3;audio-fft;63;73;71;117;51;72;84;86;108;84 04:01:53 INFO - PROCESS | 1676 | |4;audio-oscillator;84;85;114;78;81;79;115;79;81;113 04:01:53 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;92;91;92;89;93;89;92;88;116;82 04:01:53 INFO - PROCESS | 1676 | |6;imaging-darkroom;96;100;97;95;95;110;97;96;96;96 04:01:53 INFO - PROCESS | 1676 | |7;imaging-desaturate;151;148;92;122;146;144;102;147;151;88 04:01:53 INFO - PROCESS | 1676 | |8;json-parse-financial;54;60;57;59;59;60;58;68;55;54 04:01:53 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;67;64;75;63;104;66;83;62;84;67 04:01:53 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;88;108;113;108;102;83;86;81;83;85 04:01:53 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;120;119;126;125;124;146;135;127;124;115 04:01:53 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;129;136;137;138;174;165;136;135;138;127 04:01:53 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;65;68;85;102;95;74;65;81;95 04:01:53 INFO - PROCESS | 1676 | __end_tp_report 04:01:53 INFO - PROCESS | 1676 | __start_cc_report 04:01:53 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,952 04:01:53 INFO - PROCESS | 1676 | __end_cc_report 04:01:53 INFO - PROCESS | 1676 | __startTimestamp1461754913461__endTimestamp 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | ------- Summary: start ------- 04:01:53 INFO - PROCESS | 1676 | Number of tests: 14 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.00 stddev:4.86 (4.2%) stddev-sans-first:5.15 04:01:53 INFO - PROCESS | 1676 | Values: 116.0 112.0 118.0 114.0 116.0 130.0 116.0 115.0 116.0 116.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:145.50 stddev:20.10 (13.8%) stddev-sans-first:15.66 04:01:53 INFO - PROCESS | 1676 | Values: 178.0 119.0 141.0 153.0 120.0 139.0 117.0 154.0 150.0 121.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:210.90 Median:200.00 stddev:31.11 (15.6%) stddev-sans-first:31.77 04:01:53 INFO - PROCESS | 1676 | Values: 187.0 280.0 257.0 200.0 195.0 196.0 195.0 197.0 200.0 202.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:80.90 Median:72.50 stddev:19.82 (27.3%) stddev-sans-first:19.94 04:01:53 INFO - PROCESS | 1676 | Values: 63.0 73.0 71.0 117.0 51.0 72.0 84.0 86.0 108.0 84.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:80.00 stddev:16.09 (20.1%) stddev-sans-first:16.87 04:01:53 INFO - PROCESS | 1676 | Values: 84.0 85.0 114.0 78.0 81.0 79.0 115.0 79.0 81.0 113.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:91.50 stddev:8.88 (9.7%) stddev-sans-first:9.42 04:01:53 INFO - PROCESS | 1676 | Values: 92.0 91.0 92.0 89.0 93.0 89.0 92.0 88.0 116.0 82.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:96.00 stddev:4.52 (4.7%) stddev-sans-first:4.74 04:01:53 INFO - PROCESS | 1676 | Values: 96.0 100.0 97.0 95.0 95.0 110.0 97.0 96.0 96.0 96.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:129.10 Median:149.50 stddev:25.81 (17.3%) stddev-sans-first:26.13 04:01:53 INFO - PROCESS | 1676 | Values: 151.0 148.0 92.0 122.0 146.0 144.0 102.0 147.0 151.0 88.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:4.09 (6.9%) stddev-sans-first:4.01 04:01:53 INFO - PROCESS | 1676 | Values: 54.0 60.0 57.0 59.0 59.0 60.0 58.0 68.0 55.0 54.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:67.00 stddev:13.36 (19.9%) stddev-sans-first:13.96 04:01:53 INFO - PROCESS | 1676 | Values: 67.0 64.0 75.0 63.0 104.0 66.0 83.0 62.0 84.0 67.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:83.00 stddev:12.51 (15.1%) stddev-sans-first:13.10 04:01:53 INFO - PROCESS | 1676 | Values: 88.0 108.0 113.0 108.0 102.0 83.0 86.0 81.0 83.0 85.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.50 stddev:8.80 (7.0%) stddev-sans-first:9.05 04:01:53 INFO - PROCESS | 1676 | Values: 120.0 119.0 126.0 125.0 124.0 146.0 135.0 127.0 124.0 115.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:137.50 stddev:15.36 (11.2%) stddev-sans-first:15.61 04:01:53 INFO - PROCESS | 1676 | Values: 129.0 136.0 137.0 138.0 174.0 165.0 136.0 135.0 138.0 127.0 04:01:53 INFO - PROCESS | 1676 | 04:01:53 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:77.50 stddev:13.98 (18.0%) stddev-sans-first:14.05 04:01:53 INFO - PROCESS | 1676 | Values: 67.0 65.0 68.0 85.0 102.0 95.0 74.0 65.0 81.0 95.0 04:01:53 INFO - PROCESS | 1676 | -------- Summary: end -------- 04:01:53 INFO - PROCESS | 1676 | 04:01:54 INFO - TEST-INFO | 1676: exit 0 04:01:54 INFO - TEST-OK | kraken | took 58090ms 04:01:54 INFO - SUITE-END | took 1169s 04:01:54 INFO - Completed test suite (00:19:29) 04:01:54 INFO - javascript benchmark 04:01:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3482.7562070655054, 3520.4015317396033, 3534.4874993126014, 3573.4461158520407, 3610.9097272568183, 5889.61717488363, 5899.056151015839, 5901.4688678018965, 5903.321118071429, 5921.289445266563, 5874.089516125007, 5879.11813228016, 5939.376365481627, 5978.461938425541, 5980.940190598093, 5184.274201611768, 5271.051210782058, 5292.708901010443, 5309.0, 5346.091164502044, 5214.66104703195, 5305.522502974732, 5328.813491527797, 5345.572354211654, 5359.169328754049, 5314.335708036496, 5322.2282768998475, 5322.9620224056325, 5334.0, 5358.303420555322, 5237.711925844077, 5295.391030031538, 5320.5211530962015, 5347.251384806092, 5348.465153484659, 5159.509846564571, 5325.360956685184, 5346.198070289449, 5373.328333958255, 5374.167004114369, 5885.234919460486, 5897.115432685088, 5941.792037278675, 5944.167816505693, 5969.820905372802, 4897.4857639948, 5098.209777484496, 6194.1018552310115, 6199.659018753967, 6337.144485494446, 6225.626462412224, 6244.3755624437645, 6281.780137695158, 6281.905771413432, 6286.434220920093, 4958.9504104959215, 5472.343318801769, 5510.1459273812625, 5976.7908123215475, 6016.368281330485, 6287.49700023997, 6337.4613157882095, 6358.554901156875, 6381.968090159612, 6393.328700486475, 6251.031090181029, 6298.275698294755, 6305.211848518935, 6306.400891915261, 6308.116863639094, 6322.683865806691, 6339.651319177489, 6346.428821406095, 6347.333529979285, 6354.745810167634, 5175.197844334134, 6138.541671868701, 6220.968895155495, 6324.9051264231075, 6324.968375158187, 6214.4407003369915, 6294.874102517924, 6302.432781049728, 6302.558820882494, 6310.716017779119, 4891.217405215149, 4951.084049450863, 4960.553550180501, 4966.056449274626, 4966.230234313687, 4408.074304396113, 4410.404595379647, 4453.821847126143, 4464.866054018385, 4498.955010449854, 5872.119182122716, 5968.46283834457, 5968.582199246011, 5970.432808883149, 5971.641701497924, 6150.708351246199, 6274.968625156845, 6307.684615769193, 6318.210223722035, 6320.652364119926, 5754.88490230193, 5886.175935369051, 5936.1392598073035, 5950.880982380415, 6000.339962604197, 4545.38637283969, 5482.80810171642, 5498.010358135494, 5511.669299842022, 5518.724063796794, 6260.40526150015, 6448.742050317935, 6462.773802917063, 6470.579412338183, 6491.642959637171, 6249.78125765596, 6253.593516421418, 6280.811575652738, 6287.96856015717, 6315.179026726496, 5080.441151473409, 6362.618242905441, 6398.200224971879, 6409.230892292955, 6507.934920650733, 6190.380961903774, 6227.688615569113, 6259.6870156492905, 6312.5581209314905, 6341.302456729663, 5945.3757355477055, 6294.4964402846745, 6308.022256550242, 6313.147725057059, 6315.968420158054, 6234.906476402767, 6241.3134555197985, 6242.1261023455845, 6254.124422580751, 6267.341929097562, 6126.264848218064, 6160.075988601746, 6176.969115154396, 6274.278457977391, 6297.370262973666, 5966.403359663999, 6045.758169673164, 6103.084537319438, 6129.417705317987, 6166.81499555014, 6204.348543402878, 6256.562040657111, 6263.906041409291, 6271.96864015677, 6290.370962903673, 6027.397260273938, 6080.422359875804, 6131.101423540838, 6182.938170618416, 6204.689765511616], "unit": "score", "name": "dojo.html", "value": 5775.407302421657}, {"lowerIsBetter": false, "replicates": [594.7442599682138, 613.4877377389879, 625.4652272307177, 668.2949488289854, 671.5668393885944, 31378.68621313789, 39670.404943925794, 39934.60065399345, 40016.79991600042, 40051.79974100133, 33919.49120763191, 41057.97355066125, 41339.75980720576, 41717.16565668685, 42023.159536809246, 9493.620255189802, 9588.904110958905, 9637.277204209713, 9644.951775241114, 9735.464549449778, 8796.384253102286, 9597.904020959806, 9756.707298781048, 9778.11996920277, 9860.260480463958, 9742.805143897118, 9821.459819709913, 9825.017498250189, 9831.115199632031, 9852.605895764196, 9757.853632195487, 9777.853332200022, 9780.755481112994, 9792.020797920222, 9811.90188098117, 8398.580070996426, 9669.226461883032, 9713.417194968324, 9799.510024498746, 9803.509824508817, 32533.6746632533, 34841.9547413578, 41085.589144108475, 41585.58414415847, 41852.790736046125, 3149.008062460318, 3284.917877053069, 3334.733221342311, 3353.0946644406117, 3427.8628854845774, 28368.290792730346, 28648.71351286481, 28904.855475722696, 29180.708192918013, 29532.114036578936, 2769.418422131355, 2776.9305767355777, 2814.451182019507, 2830.2782790388524, 2889.436559870826, 425752.0, 429461.0, 430039.0, 431489.0, 439572.0, 48793.756031219615, 70121.64939175373, 70251.0, 70737.64631176811, 71026.289737103, 48395.758021209665, 48604.0, 48759.0, 48776.75611621919, 48813.0, 16824.90638108519, 16933.661326773396, 17030.57423564421, 17183.3985810496, 17188.398406055727, 13379.799303010463, 13480.730385392237, 13560.254186019863, 13600.65998350049, 13643.908487321189, 15751.606209844846, 15847.128407937444, 16112.113833739022, 16257.837421625869, 16302.266398012118, 6417.39034791694, 6475.7085931133215, 6495.740170393131, 6544.70548825304, 6555.639439830855, 827.9296259817862, 1091.9454027298602, 1124.686826022214, 1126.6957921361186, 1143.5425829668034, 27711.030113945915, 30092.0, 30817.845910770302, 31177.68822311748, 31332.530012049836, 1047.7642530430592, 1197.4910662968205, 1240.765438388809, 1246.4328730427633, 1247.357610830423, 13856.515021974183, 15786.13176275293, 15813.209339532978, 15845.0, 15989.440369587008, 469935.0, 473719.0, 474103.0, 474791.0, 477469.0, 62807.0, 64079.679601601696, 65053.67473162698, 65164.34835651678, 65306.346936530026, 1529.495266562032, 1539.5304432148077, 1552.2937063636243, 1566.295167174776, 1568.7960565126689, 30446.238844029078, 30814.0, 30861.691383085883, 30936.845315773277, 31171.84414077915, 56446.306610801745, 56512.15231771609, 56726.14910776259, 56975.14537282027, 57284.56788580319, 497682.0, 499402.0, 500599.0, 501842.0, 502727.43181419297, 31950.840245798623, 35758.0, 36288.81855590705, 36313.273734524635, 36828.44757328696, 49601.75199123981, 49882.75058624829, 49943.0, 50640.0, 50847.745761270955, 38826.80586597049, 39159.41260881032, 39513.0, 39868.60131398649, 40078.39882401708, 38695.419568705925, 39050.414243785795, 39500.0, 39938.60061399465, 40024.799876000434, 39160.0, 40536.391954120125, 40911.7954410226, 41972.79013604912, 42126.78936605297, 30679.693203068575, 33084.503732443554, 33318.0, 33537.0, 33646.66353336533, 25905.222843314732, 26305.210843674722, 26349.473010540067, 26367.972827851605, 26571.468570628094], "unit": "score", "name": "ext.html", "value": 19995.526365161928}, {"lowerIsBetter": false, "replicates": [332.72550146129447, 352.365741665003, 378.42668357438504, 389.9727019108662, 392.068836513281, 20565.38303850885, 20721.896390518046, 21050.0, 21738.130474780988, 21770.673439898394, 21012.78987210131, 21633.891830540866, 22315.55368892625, 22568.097276108976, 22688.546229075408, 5967.433093856077, 6014.669193194372, 6237.968810155943, 6244.781432649858, 6248.562600617958, 6074.5747797654185, 6159.23009623797, 6185.938140618581, 6186.257649082094, 6202.131701561785, 5934.5845790794665, 6070.693136608083, 6073.574849760518, 6113.816585502442, 6175.197224360827, 6039.7282122304605, 6065.2418447694035, 6076.392360763888, 6078.787242446493, 6106.206193194901, 5243.318368612094, 5259.842204733826, 5275.314209152824, 5312.2297266896085, 5315.123004704219, 27299.044533441433, 27337.589936150973, 27446.862765686245, 27841.747121379587, 27849.443011139665, 2211.900464479102, 2496.9750302496923, 2506.448581312108, 2651.893924243028, 2708.8645567721537, 15109.093454392772, 15236.23818809055, 15591.37634494619, 15688.607784805357, 15703.371865125382, 1781.358710864088, 1804.0799192411832, 1816.7093265077656, 1818.7726534183228, 1835.7062869940746, 101140.48289275667, 106434.0, 106807.0, 106946.0, 108861.45569272182, 11379.601713939972, 11580.710482237842, 11581.363025033705, 11786.292822430682, 11789.292642441482, 14335.426582936565, 14345.6413589659, 14482.0, 14489.0, 14543.418263269563, 7941.888135660896, 9039.548022598843, 9097.09029097085, 9111.134442227978, 9198.908010919806, 7228.915662650645, 9194.26445884341, 9350.812983740423, 9362.157405833372, 9366.531673416303, 4581.198290299184, 4646.210144275481, 4655.20861453547, 4677.345171675968, 4690.81236750533, 1953.64834329822, 1984.176566724793, 1985.7319261899459, 1986.4537252255457, 2009.336918816787, 954.8042651256476, 1007.8740157480315, 1063.728749168957, 1073.9194560407843, 1089.7166736648528, 21107.894460527907, 21340.93295335227, 21370.893145534174, 21625.13392325684, 21698.0, 1013.4342440928635, 1015.4313584392763, 1022.3559157730731, 1039.3504059962524, 1087.3095584303867, 11484.310941343547, 11717.941410293064, 11729.706757330965, 11737.70885202627, 11766.294022358687, 489695.0, 663577.1853688795, 682077.0, 686566.0, 691042.0, 126225.0, 128730.0, 129715.35142324227, 131315.0, 131523.0, 1073.1736562846565, 1080.378782200238, 1084.8915108489089, 1089.841972913939, 1096.040964156363, 19307.03464826781, 19311.03444827725, 19464.902675487097, 19515.414537563895, 19585.60828783445, 56978.43021569731, 57321.14018289646, 57403.71298143482, 58085.419145808, 58339.24982250539, 67640.0, 71109.0, 81787.0, 82638.0, 84110.05614803452, 8362.852609836791, 8414.284785793032, 8462.788430289293, 8467.49195048299, 8545.82908341842, 9597.568109434953, 10744.946275268887, 13641.181529108286, 14005.579832605039, 14056.297185140498, 9263.120003599648, 10570.630027948984, 10680.83978740335, 11873.821892671443, 12231.571894983634, 10736.194785391282, 10832.0, 11749.471273792871, 11925.940370298093, 12166.026717862373, 11843.881561184622, 11943.0, 12087.939560302142, 12284.754304913673, 12367.876321236672, 6685.732570697118, 8098.109207986999, 8415.078719934483, 8477.855489508838, 8492.447990880573, 7455.440841936985, 10798.244122911321, 12052.939735301617, 12206.0, 12208.328541929925], "unit": "score", "name": "jquery.html", "value": 9985.712003944}, {"lowerIsBetter": false, "replicates": [1663.1351697117498, 1668.9833101668983, 2004.6792513197881, 2027.675571908494, 2119.480727221831, 8362.03836558796, 8977.461352318865, 9193.678221262257, 9410.905890941089, 9412.90587094129, 6770.458363330934, 9036.50299233542, 9070.319726020558, 9166.954165229181, 9644.18024467921, 1924.2976313645488, 2246.2362796649136, 2528.5195812795555, 2535.8098142639283, 2545.7581529754643, 2513.6229565565127, 2542.656741339923, 2567.4736678980858, 2572.3954870605394, 2580.6387105805106, 2541.8474891506476, 2548.719640839506, 2571.961420578693, 2584.1084825735184, 2585.663863697717, 2321.93034208974, 2364.869932153731, 2559.168270312147, 2572.266903932389, 2576.0211119774553, 2464.9753502464923, 2485.875706214682, 2492.2149522900227, 2496.5506208882393, 2530.089167899573, 9229.6308147674, 9267.536623168882, 9288.256939444827, 9308.627654893797, 9362.25101991839, 5680.403557626431, 5772.740226689809, 5820.1269809528485, 5850.297964244318, 5870.735816888207, 3693.4829123922405, 3754.4743735877, 3769.095417099876, 3804.1630841214887, 3838.692904567628, 956.9425784508157, 1064.9840252396143, 1080.0, 1101.6254473479055, 1120.1430905357408, 12298.754024919452, 12335.876641233563, 12535.99712023036, 12578.55975040869, 12600.558980435733, 5116.948830511722, 5133.614978876524, 5175.45657705943, 5187.455317191716, 5228.660137091153, 10573.312734672221, 10573.682789516326, 10601.734956626146, 10636.680899573024, 10638.255322127377, 5756.3380211276235, 5791.5656325775735, 5807.651540907559, 5830.125481177773, 5835.766569337179, 4641.512641172628, 5078.21287700407, 5176.637635365563, 5218.66078704883, 5237.162054071407, 4115.794210289474, 4119.773412462343, 4134.855280065183, 4137.710360274812, 4146.771927543954, 1346.0712108645005, 1356.6133651909158, 1356.7083077138464, 1358.891288696902, 1364.8908087352988, 1393.7212557488542, 1413.9858601413855, 1437.037185085995, 1442.6537630968492, 1454.0984589554544, 8424.747257582283, 8432.578371081545, 8491.19333663301, 8503.277221436123, 8526.531040792692, 462.4658519410087, 532.498820256813, 540.4460428061269, 540.6566830062939, 544.3141641531698, 6240.438360547572, 6289.528285378524, 6375.553711240169, 6388.744450221939, 6392.977123660192, 9811.509424528746, 10720.839187412195, 10849.349039057524, 11274.0, 11288.604898828666, 9525.714228573153, 10704.250702450754, 11074.723131921766, 11134.554617815196, 11184.273022253528, 8513.19124683154, 8724.0, 8759.562021899006, 8811.603477843513, 8869.334799890034, 8108.635111419882, 8173.264406203471, 8344.541050242295, 8394.370422218235, 8467.661293548435, 8266.958665206635, 9647.372920760408, 9860.211183105192, 9938.801223975624, 10002.599896004369, 10151.593936242467, 10152.593896244067, 10204.897951020395, 10220.897791021995, 10261.692149235534, 7798.33714134305, 7827.412944029106, 7946.682132714626, 7962.960185199037, 8007.759767206993, 8582.78543036429, 8619.741407757778, 8636.654533818577, 8672.436291641023, 8680.045195028415, 7274.636268186676, 7440.888386674313, 7645.0, 7676.53940763556, 7961.363090952594, 7437.293457121565, 7441.776746697607, 7462.365698915653, 7544.207858175032, 7597.886031709419, 6614.0, 7893.17121702236, 7961.482503637245, 8012.359011278967, 8043.597820108854, 7176.246494118042, 7190.928090719026, 7247.456440766858, 7251.456140789567, 7268.41852651776, 7429.03422555086, 7433.851322973402, 7455.0681164854395, 7469.626518673936, 7497.2877576630135], "unit": "score", "name": "mootools.html", "value": 5034.519472834915}, {"lowerIsBetter": false, "replicates": [297.2361032147382, 335.2691133329342, 337.21765504030645, 337.4566947214985, 347.806967133241, 6785.117934668492, 6797.11637487126, 6840.65796710165, 6871.484638652102, 6877.931220687791, 6747.773234832506, 6758.695858686358, 6789.694463749131, 6812.080369150163, 6815.035459575076, 4732.621390288768, 4842.1042107210105, 4916.459189489154, 4935.407751069876, 5024.84925452237, 4924.507549245065, 4936.3829521309835, 4955.430125535556, 4960.131976904027, 4964.131277026506, 4872.78072486739, 4887.975560122194, 4896.387951506062, 4896.755162241891, 4913.656044076916, 4881.951180488203, 4903.65674402792, 4927.6797008194535, 4970.453250142481, 5003.724795136266, 4273.786310684453, 4293.162833247518, 4296.785160741982, 4313.331433627793, 4314.762688052156, 5162.896742065138, 5865.58940874139, 6210.347913469066, 6409.903851442232, 6529.934700652981, 5860.120981852713, 5922.200502932092, 5935.52515798735, 5961.791337303173, 5967.522598192134, 6102.542309326774, 7154.213036565973, 7159.534630249069, 7168.60572668503, 7208.098987626547, 4334.804933777988, 4453.376527286183, 4800.903981920377, 4807.687500312469, 4816.831410900601, 7573.697052117908, 7591.24087591242, 7602.695892164307, 7605.201453847377, 7621.199774023703, 4723.881902952385, 4872.098661747588, 4891.437484689306, 4904.852854414302, 4929.679570827885, 4991.201407774739, 5013.24801279811, 5017.096922553902, 5032.094223039888, 5034.0938631046765, 5118.488151184852, 5442.428545002796, 5872.324682661549, 5878.412158784173, 5882.323532793698, 5748.5688573357165, 6178.5366097542865, 7163.176234733072, 7172.354488096096, 7221.494495385273, 1409.6616811965055, 1724.043156048405, 1740.3038784486307, 1745.6246906915073, 1746.0920321432784, 849.3332733804058, 1088.515610553312, 1127.4869934179928, 1138.3397629375108, 1151.6199654114123, 5058.215976523645, 6565.113709649137, 6627.768028118992, 6661.4004739573675, 6679.76620818269, 7431.554106753612, 7436.516626419266, 7445.664945077485, 7455.925440745523, 7485.401167906554, 5844.714162884159, 6270.372962703693, 6424.9036264455135, 6768.120144381297, 6806.93193068063, 3955.4462375267485, 3983.900402489961, 4002.479677641888, 4023.155137421116, 4029.7582145071387, 7865.134835168127, 7885.014373203349, 7885.29032387088, 7896.170902055316, 7898.131205567383, 7475.289847464483, 7825.647845846951, 7840.255175758294, 7841.451098423056, 7862.803429914298, 7142.857142857114, 7481.251874812475, 7835.216478352119, 7838.412119091091, 7900.525968441797, 6102.359252278625, 6826.249112597511, 7557.6221188939235, 7570.697172113054, 7577.583232922242, 7353.485256032026, 7371.336579707852, 7386.446016548673, 7395.963020184865, 7407.0, 7617.581033043236, 7780.144184139627, 7809.687612495663, 7824.882626760717, 7908.5650289234645, 4413.073254616438, 4699.788509517149, 4733.502982186821, 4742.952570474251, 4750.691205071659, 6477.0, 7074.504784665024, 7488.288612581796, 7502.137254215835, 7502.287282708134, 7213.783586492414, 7226.927730722836, 7237.240089790706, 7239.8552028960175, 7283.890741638986, 7005.194402643761, 7060.43516518667, 7214.71141154348, 7230.566166030055, 7239.601821899846, 7153.35619794221, 7155.284471552803, 7196.8920466194095, 7217.170025446931, 7242.239564845615, 7171.995920571228, 7174.605396703231, 7192.820179495555, 7198.748043818441, 7211.459140564374, 7056.7530136444975, 7176.4258859290085, 7181.820454488679, 7188.424926005802, 7227.385672217921], "unit": "score", "name": "prototype.html", "value": 5249.645636127047}, {"lowerIsBetter": false, "replicates": [660.2736989311758, 699.625700250366, 741.2143128284016, 766.9693212271509, 772.5866661336182, 12133.453994570244, 15310.770338444932, 15492.380304787795, 15559.533214003584, 15603.453879114233, 11601.767964640701, 14499.275036248171, 14501.92749036256, 14543.272836358192, 14555.053921495095, 761.3300295739741, 953.7186529973675, 956.603009750956, 967.9467629280387, 973.9707808765748, 956.0439560439561, 959.7264779537833, 961.024560071528, 970.4274478057945, 975.7804493988831, 1008.2035192198191, 1009.9848502272472, 1021.0912288063629, 1023.161007973462, 1025.5385076715509, 991.5141580625514, 992.503748125937, 1018.3838777539556, 1019.2610357490834, 1020.9489525523694, 759.7492827366956, 762.3443838299058, 769.4882902869585, 769.5651956644534, 771.5409331447779, 15036.548903532912, 15061.02103363289, 15144.318505667272, 15207.239638018165, 15333.003354781904, 13302.667433314147, 13324.933375333158, 13336.333183340794, 13384.130031548015, 13451.394687239097, 10032.548535315855, 10144.746381340452, 10278.897211027943, 10310.845337319946, 10378.325408848401, 3321.8837340693203, 3371.8482668279985, 3388.644192359816, 3437.8796742114155, 3592.6407359264126, 76593.61703191504, 78579.8213026805, 79099.6045019777, 79116.20883791204, 80562.0, 8328.0, 9614.9038509614, 9767.658131965489, 9932.503374831229, 10019.198464122852, 22523.774762252167, 22689.773102269097, 22713.318600442013, 22718.772812271996, 22722.97746601407, 7705.653245603961, 7734.458587898793, 7771.33943614799, 7796.259355361231, 7981.281684648409, 4231.314503256771, 4242.278812601865, 4253.532111467736, 4276.444062271947, 4280.978595107067, 3749.9437508437395, 3797.1646237827636, 3829.368154254517, 3833.463315135883, 3837.2517359114704, 670.6747227594612, 683.2723149845498, 683.3235097253782, 688.1638808847175, 706.2831226305304, 530.0379810643747, 554.6561132098125, 612.1338306296541, 613.3437222172322, 615.230961298377, 7850.921490785133, 7908.853216283606, 8275.08974012858, 8583.742487725378, 8674.175953284428, 537.9704116273564, 554.8973439913628, 610.2280615022, 629.276332217953, 633.4140919649305, 3224.822634755111, 3447.3967055765143, 3980.24375368679, 4032.717709760347, 4092.4884389451317, 103603.0, 103871.0, 105340.94659053464, 106328.0, 106418.0, 67850.32149678539, 79336.80994785082, 84409.15590844136, 85207.0, 88011.55994219988, 65942.67028664827, 75758.9999999989, 76990.61504692552, 77318.0, 78065.0, 8006.239407256301, 8095.23095305945, 8130.268275855202, 8148.918510814816, 8238.588070596566, 50771.238431424295, 51117.48882511127, 52695.0, 53047.46952530425, 56060.43939560552, 53275.467245327054, 53786.46213537815, 53963.46036539741, 57617.42382576121, 72545.0, 11373.088776517705, 11501.367424791717, 11596.536138554364, 11767.411629418666, 12222.816657749963, 12100.45547950362, 12142.08934329911, 12274.202176858476, 12323.260604363766, 12844.678883027998, 11478.253913495597, 11887.76224475523, 12007.75984480323, 12238.510459581874, 12276.32480213561, 9534.856977145488, 9868.0, 11534.769304613694, 11824.93575578202, 12221.938890305491, 9435.339526233098, 11457.885421145682, 11681.182317238052, 11814.94092529532, 11870.58452954177, 9596.66411675588, 9719.319647624598, 9787.902120978699, 9964.202863770735, 10317.0, 9189.34299791831, 10087.445190514592, 10096.29325947206, 10097.44464054484, 10099.293049486465], "unit": "score", "name": "yui.html", "value": 7079.7410836978515}], "name": "dromaeo_css", "value": 7744.719510803482}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 118.0, 114.0, 116.0, 130.0, 116.0, 115.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.9}, {"lowerIsBetter": true, "replicates": [178.0, 119.0, 141.0, 153.0, 120.0, 139.0, 117.0, 154.0, 150.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.2}, {"lowerIsBetter": true, "replicates": [187.0, 280.0, 257.0, 200.0, 195.0, 196.0, 195.0, 197.0, 200.0, 202.0], "unit": "score", "name": "audio-dft", "value": 210.9}, {"lowerIsBetter": true, "replicates": [63.0, 73.0, 71.0, 117.0, 51.0, 72.0, 84.0, 86.0, 108.0, 84.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 114.0, 78.0, 81.0, 79.0, 115.0, 79.0, 81.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 90.9}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 92.0, 89.0, 93.0, 89.0, 92.0, 88.0, 116.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.4}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 97.0, 95.0, 95.0, 110.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 97.8}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 92.0, 122.0, 146.0, 144.0, 102.0, 147.0, 151.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 129.1}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 57.0, 59.0, 59.0, 60.0, 58.0, 68.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 75.0, 63.0, 104.0, 66.0, 83.0, 62.0, 84.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.5}, {"lowerIsBetter": true, "replicates": [88.0, 108.0, 113.0, 108.0, 102.0, 83.0, 86.0, 81.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.7}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 126.0, 125.0, 124.0, 146.0, 135.0, 127.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [129.0, 136.0, 137.0, 138.0, 174.0, 165.0, 136.0, 135.0, 138.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 68.0, 85.0, 102.0, 95.0, 74.0, 65.0, 81.0, 95.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 79.7}], "name": "kraken", "value": 1531.0}]} 04:01:54 INFO - Return code: 0 04:01:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:01:54 ERROR - # TBPL SUCCESS # 04:01:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:54 INFO - 2016-04-27 04:01:54.756 screenresolution[1681:10313] starting screenresolution argv=screenresolution get 04:01:54 INFO - 2016-04-27 04:01:54.758 screenresolution[1681:10313] Display 0: 1600x1200x32@60 04:01:54 INFO - 2016-04-27 04:01:54.764 screenresolution[1682:10316] starting screenresolution argv=screenresolution list 04:01:54 INFO - Available Modes on Display 0 04:01:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:55 INFO - Intel Iris: 04:01:55 INFO - Chipset Model: Intel Iris 04:01:55 INFO - Type: GPU 04:01:55 INFO - Bus: Built-In 04:01:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:55 INFO - Vendor: Intel (0x8086) 04:01:55 INFO - Device ID: 0x0a2e 04:01:55 INFO - Revision ID: 0x0009 04:01:55 INFO - Displays: 04:01:55 INFO - Display: 04:01:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:55 INFO - Display Serial Number: 1600x1200 60 04:01:55 INFO - Main Display: Yes 04:01:55 INFO - Mirror: Off 04:01:55 INFO - Online: Yes 04:01:55 INFO - Rotation: Supported 04:01:55 INFO - Return code: 0 04:01:55 INFO - Running post-action listener: _resource_record_post_action 04:01:55 INFO - Running post-run listener: _resource_record_post_run 04:01:56 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 37725696; Write bytes: 665650688; Read time: 396; Write time: 2295 04:01:56 INFO - install - Wall time: 34s; CPU: 56.0%; Read bytes: 352002560; Write bytes: 352966144; Read time: 27869; Write time: 686 04:01:56 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36771328; Write bytes: 301207552; Read time: 382; Write time: 1575 04:01:56 INFO - Running post-run listener: _upload_blobber_files 04:01:56 INFO - Blob upload gear active. 04:01:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:56 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 04:01:56 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'] 04:01:56 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 04:01:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:57 INFO - (blobuploader) - INFO - Done attempting. 04:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:58 INFO - (blobuploader) - INFO - Done attempting. 04:01:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:58 INFO - Return code: 0 04:01:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cade8b24ceac54e1e0672ff5e9dbe2c9d2ef7ba9c729cc46d0a5a0e780a3d4aae8edddf1e1bc0dc980bb5fad3119f0294a5b80e2c9e7024b53dc5a001d0198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec10bc12319deb50a512d2545e56c7f8144e35b62dfe885976c1e333115325774c20fc638e462a3910c1cb72c629b3bdfd0861ac223c952449d0b94588e94e4"} 04:01:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:58 INFO - Contents: 04:01:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cade8b24ceac54e1e0672ff5e9dbe2c9d2ef7ba9c729cc46d0a5a0e780a3d4aae8edddf1e1bc0dc980bb5fad3119f0294a5b80e2c9e7024b53dc5a001d0198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec10bc12319deb50a512d2545e56c7f8144e35b62dfe885976c1e333115325774c20fc638e462a3910c1cb72c629b3bdfd0861ac223c952449d0b94588e94e4"} 04:01:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:58 INFO - Copying logs to upload dir... 04:01:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.318950 ========= master_lag: 1.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-27 04:02:00.386928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:02:00.394577) ========= 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.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/b2cade8b24ceac54e1e0672ff5e9dbe2c9d2ef7ba9c729cc46d0a5a0e780a3d4aae8edddf1e1bc0dc980bb5fad3119f0294a5b80e2c9e7024b53dc5a001d0198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec10bc12319deb50a512d2545e56c7f8144e35b62dfe885976c1e333115325774c20fc638e462a3910c1cb72c629b3bdfd0861ac223c952449d0b94588e94e4"} build_url:https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/SQDTyWLnRTi58-v24Lw8jQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2cade8b24ceac54e1e0672ff5e9dbe2c9d2ef7ba9c729cc46d0a5a0e780a3d4aae8edddf1e1bc0dc980bb5fad3119f0294a5b80e2c9e7024b53dc5a001d0198", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec10bc12319deb50a512d2545e56c7f8144e35b62dfe885976c1e333115325774c20fc638e462a3910c1cb72c629b3bdfd0861ac223c952449d0b94588e94e4"}' ========= master_lag: 0.43 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 04:02:00.835307) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:02:00.835657) ========= 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.0DVAlsPifd/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.rZvH691seC/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005097 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 04:02:00.856343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:02:00.856626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 04:02:00.856972) ========= ========= Total master_lag: 2.24 =========