builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0100 starttime: 1460665482.54 results: success (0) buildid: 20160414122941 builduid: 7d34eed9a0f44d49aa4951ccbb44dede revision: 7c924c7d25e9227fedea4b6b602455a21632aa9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:42.545109) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:42.545527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:42.545801) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:43.005842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:43.006226) ========= 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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-14 13:24:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2016-04-14 13:24:43 (14.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.391610 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:43.769311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:43.769636) ========= 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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.027671 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:43.872165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-14 13:24:43.872550) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7c924c7d25e9227fedea4b6b602455a21632aa9b --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 7c924c7d25e9227fedea4b6b602455a21632aa9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-14 13:24:43,917 truncating revision to first 12 chars 2016-04-14 13:24:43,917 Setting DEBUG logging. 2016-04-14 13:24:43,917 attempt 1/10 2016-04-14 13:24:43,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7c924c7d25e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 13:24:45,246 unpacking tar archive at: mozilla-aurora-7c924c7d25e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572040 ========= master_lag: 2.76 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-14 13:24:48.205907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:48.206238) ========= script_repo_revision: 7c924c7d25e9227fedea4b6b602455a21632aa9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:48.206644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:48.206908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 13:24:49.054910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-14 13:24:49.055250) ========= /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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:24:49 INFO - MultiFileLogger online at 20160414 13:24:49 in /builds/slave/test 13:24:49 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 13:24:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:24:49 INFO - {'append_to_log': False, 13:24:49 INFO - 'base_work_dir': '/builds/slave/test', 13:24:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:24:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:24:49 INFO - 'branch': 'Mozilla-Aurora', 13:24:49 INFO - 'buildbot_json_path': 'buildprops.json', 13:24:49 INFO - 'config_files': ('talos/mac_config.py',), 13:24:49 INFO - 'default_actions': ('clobber', 13:24:49 INFO - 'read-buildbot-config', 13:24:49 INFO - 'download-and-extract', 13:24:49 INFO - 'populate-webroot', 13:24:49 INFO - 'create-virtualenv', 13:24:49 INFO - 'install', 13:24:49 INFO - 'run-tests'), 13:24:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:24:49 INFO - 'download_minidump_stackwalk': True, 13:24:49 INFO - 'download_symbols': 'ondemand', 13:24:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:24:49 INFO - 'tooltool.py': '/tools/tooltool.py', 13:24:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:24:49 INFO - '/tools/misc-python/virtualenv.py')}, 13:24:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:24:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:24:49 INFO - 'installer_path': 'installer.exe', 13:24:49 INFO - 'log_level': 'info', 13:24:49 INFO - 'log_name': 'talos', 13:24:49 INFO - 'log_to_console': True, 13:24:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:24:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:24:49 INFO - 'opt_config_files': (), 13:24:49 INFO - 'pip_index': False, 13:24:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:24:49 INFO - 'cmd': ('bash', 13:24:49 INFO - '-c', 13:24:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:24:49 INFO - 'enabled': True, 13:24:49 INFO - 'halt_on_failure': False, 13:24:49 INFO - 'name': 'check_screen_resolution'},), 13:24:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:24:49 INFO - 'cmd': ('bash', 13:24:49 INFO - '-c', 13:24:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:24:49 INFO - 'enabled': True, 13:24:49 INFO - 'halt_on_failure': False, 13:24:49 INFO - 'name': 'check_screen_resolution'},), 13:24:49 INFO - 'run_cmd_checks_enabled': True, 13:24:49 INFO - 'sps_profile': False, 13:24:49 INFO - 'sps_profile_interval': 0, 13:24:49 INFO - 'suite': 'dromaeojs-e10s', 13:24:49 INFO - 'system_bits': '32', 13:24:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:24:49 INFO - 'title': 't-yosemite-r7-0100', 13:24:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:24:49 INFO - 'use_talos_json': True, 13:24:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:24:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:24:49 INFO - 'work_dir': 'build'} 13:24:49 INFO - ##### 13:24:49 INFO - ##### Running clobber step. 13:24:49 INFO - ##### 13:24:49 INFO - Running pre-action listener: _resource_record_pre_action 13:24:49 INFO - Running main action method: clobber 13:24:49 INFO - rmtree: /builds/slave/test/build 13:24:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:24:51 INFO - Running post-action listener: _resource_record_post_action 13:24:51 INFO - ##### 13:24:51 INFO - ##### Running read-buildbot-config step. 13:24:51 INFO - ##### 13:24:51 INFO - Running pre-action listener: _resource_record_pre_action 13:24:51 INFO - Running main action method: read_buildbot_config 13:24:51 INFO - Using buildbot properties: 13:24:51 INFO - { 13:24:51 INFO - "project": "", 13:24:51 INFO - "product": "firefox", 13:24:51 INFO - "script_repo_revision": "production", 13:24:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:24:51 INFO - "repository": "", 13:24:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:24:51 INFO - "buildid": "20160414122941", 13:24:51 INFO - "pgo_build": "False", 13:24:51 INFO - "basedir": "/builds/slave/test", 13:24:51 INFO - "buildnumber": 263, 13:24:51 INFO - "slavename": "t-yosemite-r7-0100", 13:24:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:24:51 INFO - "platform": "yosemite_r7", 13:24:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:24:51 INFO - "branch": "mozilla-aurora", 13:24:51 INFO - "repo_path": "releases/mozilla-aurora", 13:24:51 INFO - "revision": "7c924c7d25e9227fedea4b6b602455a21632aa9b", 13:24:51 INFO - "stage_platform": "macosx64", 13:24:51 INFO - "builduid": "7d34eed9a0f44d49aa4951ccbb44dede", 13:24:51 INFO - "slavebuilddir": "test" 13:24:51 INFO - } 13:24:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 13:24:51 INFO - Running post-action listener: _resource_record_post_action 13:24:51 INFO - ##### 13:24:51 INFO - ##### Running download-and-extract step. 13:24:51 INFO - ##### 13:24:51 INFO - Running pre-action listener: _resource_record_pre_action 13:24:51 INFO - Running main action method: download_and_extract 13:24:51 INFO - mkdir: /builds/slave/test/build/tests 13:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:51 INFO - https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:24:53 INFO - Downloaded 1277 bytes. 13:24:53 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:24:53 INFO - Using the following test package requirements: 13:24:53 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:24:53 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 13:24:53 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 13:24:53 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'jsshell-mac.zip'], 13:24:53 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 13:24:53 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:24:53 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 13:24:53 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 13:24:53 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 13:24:53 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:24:53 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:24:53 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 13:24:53 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:24:53 INFO - https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:24:55 INFO - Downloaded 17910946 bytes. 13:24:55 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'] 13:24:55 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 13:24:58 INFO - Return code: 0 13:24:58 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 13:24:58 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')]} 13:24:58 INFO - https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:25:03 INFO - Downloaded 17910946 bytes. 13:25:03 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'] 13:25:03 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 13:25:06 INFO - Return code: 0 13:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:06 INFO - https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:25:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:25:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:25:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:25:07 INFO - Downloaded 10845168 bytes. 13:25:07 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'] 13:25:07 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 13:25:08 INFO - Return code: 0 13:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:08 INFO - https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 13:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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 13:25:11 INFO - Downloaded 115195395 bytes. 13:25:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:25:11 INFO - mkdir: /builds/slave/test/properties 13:25:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:11 INFO - Contents: 13:25:11 INFO - build_url:https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:25:12 INFO - Running post-action listener: _resource_record_post_action 13:25:12 INFO - Running post-action listener: set_extra_try_arguments 13:25:12 INFO - ##### 13:25:12 INFO - ##### Running populate-webroot step. 13:25:12 INFO - ##### 13:25:12 INFO - Running pre-action listener: _resource_record_pre_action 13:25:12 INFO - Running main action method: populate_webroot 13:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:12 INFO - '--tppagecycles', 13:25:12 INFO - '7'], 13:25:12 INFO - 'tests': ['tsvgm']}}, 13:25:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:25:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:25:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'tests': ['damp', 'tps']}, 13:25:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['damp', 'tps']}, 13:25:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:12 INFO - 'other': {'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'other_l64': {'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'other_nol64': {'tests': ['a11yr', 13:25:12 INFO - 'ts_paint', 13:25:12 INFO - 'tpaint', 13:25:12 INFO - 'sessionrestore', 13:25:12 INFO - 'sessionrestore_no_auto_restore', 13:25:12 INFO - 'tabpaint']}, 13:25:12 INFO - 'svgr': {'tests': ['tsvgx', 13:25:12 INFO - 'tsvgr_opacity', 13:25:12 INFO - 'tart', 13:25:12 INFO - 'tscrollx', 13:25:12 INFO - 'cart']}, 13:25:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['tsvgx', 13:25:12 INFO - 'tsvgr_opacity', 13:25:12 INFO - 'tart', 13:25:12 INFO - 'tscrollx', 13:25:12 INFO - 'cart']}, 13:25:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'tests': ['tp5o']}, 13:25:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'talos_options': ['--e10s'], 13:25:12 INFO - 'tests': ['tp5o']}, 13:25:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'talos_options': ['--xperf_path', 13:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:12 INFO - 'tests': ['tp5n']}, 13:25:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:12 INFO - 'talos_options': ['--e10s', 13:25:12 INFO - '--xperf_path', 13:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:12 INFO - 'tests': ['tp5n']}}, 13:25:12 INFO - 'talos.zip': {'path': '', 13:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:12 INFO - Running post-action listener: _resource_record_post_action 13:25:12 INFO - ##### 13:25:12 INFO - ##### Running create-virtualenv step. 13:25:12 INFO - ##### 13:25:12 INFO - Running pre-action listener: _resource_record_pre_action 13:25:12 INFO - Running main action method: create_virtualenv 13:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:12 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 13:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:12 INFO - Using real prefix '/tools/python27' 13:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:16 INFO - Installing pip.................done. 13:25:16 INFO - Return code: 0 13:25:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:16 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:16 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 13:25:16 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 13:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:16 INFO - 'HOME': '/Users/cltbld', 13:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:16 INFO - 'LOGNAME': 'cltbld', 13:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:16 INFO - 'MOZ_NO_REMOTE': '1', 13:25:16 INFO - 'NO_EM_RESTART': '1', 13:25:16 INFO - 'PAGER': '/bin/cat', 13:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:16 INFO - 'PWD': '/builds/slave/test', 13:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:16 INFO - 'SHELL': '/bin/bash', 13:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:16 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:16 INFO - 'USER': 'cltbld', 13:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:16 INFO - 'XPC_FLAGS': '0x0', 13:25:16 INFO - 'XPC_SERVICE_NAME': '0', 13:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:16 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 13:25:16 INFO - Cleaning up... 13:25:16 INFO - Return code: 0 13:25:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:16 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:16 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 13:25:16 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 13:25:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:16 INFO - 'HOME': '/Users/cltbld', 13:25:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:16 INFO - 'LOGNAME': 'cltbld', 13:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:16 INFO - 'MOZ_NO_REMOTE': '1', 13:25:16 INFO - 'NO_EM_RESTART': '1', 13:25:16 INFO - 'PAGER': '/bin/cat', 13:25:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:16 INFO - 'PWD': '/builds/slave/test', 13:25:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:16 INFO - 'SHELL': '/bin/bash', 13:25:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:16 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:16 INFO - 'USER': 'cltbld', 13:25:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:16 INFO - 'XPC_FLAGS': '0x0', 13:25:16 INFO - 'XPC_SERVICE_NAME': '0', 13:25:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:16 INFO - Downloading/unpacking psutil>=0.7.1 13:25:16 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 13:25:16 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 13:25:16 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 13:25:16 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 13:25:16 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 13:25:16 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 13:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:19 INFO - Installing collected packages: psutil 13:25:19 INFO - Running setup.py install for psutil 13:25:19 INFO - building 'psutil._psutil_osx' extension 13:25:19 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 13:25:20 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 13:25:20 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 13:25:20 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 13:25:20 INFO - building 'psutil._psutil_posix' extension 13:25:20 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 13:25:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:25:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:25:20 INFO - ^ 13:25:20 INFO - 1 warning generated. 13:25:20 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 13:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:20 INFO - Successfully installed psutil 13:25:20 INFO - Cleaning up... 13:25:21 INFO - Return code: 0 13:25:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:21 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:21 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 13:25:21 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 13:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:21 INFO - 'HOME': '/Users/cltbld', 13:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:21 INFO - 'LOGNAME': 'cltbld', 13:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:21 INFO - 'MOZ_NO_REMOTE': '1', 13:25:21 INFO - 'NO_EM_RESTART': '1', 13:25:21 INFO - 'PAGER': '/bin/cat', 13:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:21 INFO - 'PWD': '/builds/slave/test', 13:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:21 INFO - 'SHELL': '/bin/bash', 13:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:21 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:21 INFO - 'USER': 'cltbld', 13:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:21 INFO - 'XPC_FLAGS': '0x0', 13:25:21 INFO - 'XPC_SERVICE_NAME': '0', 13:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:25:21 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 13:25:21 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 13:25:21 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 13:25:21 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 13:25:21 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 13:25:21 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 13:25:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:25:23 INFO - Installing collected packages: mozsystemmonitor 13:25:23 INFO - Running setup.py install for mozsystemmonitor 13:25:23 INFO - Successfully installed mozsystemmonitor 13:25:23 INFO - Cleaning up... 13:25:23 INFO - Return code: 0 13:25:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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', '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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:25: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 blobuploader==1.2.4 13:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:23 INFO - 'HOME': '/Users/cltbld', 13:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:23 INFO - 'LOGNAME': 'cltbld', 13:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:23 INFO - 'MOZ_NO_REMOTE': '1', 13:25:23 INFO - 'NO_EM_RESTART': '1', 13:25:23 INFO - 'PAGER': '/bin/cat', 13:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:23 INFO - 'PWD': '/builds/slave/test', 13:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:23 INFO - 'SHELL': '/bin/bash', 13:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:23 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:23 INFO - 'USER': 'cltbld', 13:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:23 INFO - 'XPC_FLAGS': '0x0', 13:25:23 INFO - 'XPC_SERVICE_NAME': '0', 13:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:25:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25:27 INFO - Downloading docopt-0.6.1.tar.gz 13:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:25:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:25:27 INFO - Running setup.py install for blobuploader 13:25:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:25:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:25:27 INFO - Running setup.py install for requests 13:25:28 INFO - Running setup.py install for docopt 13:25:28 INFO - Successfully installed blobuploader requests docopt 13:25:28 INFO - Cleaning up... 13:25:28 INFO - Return code: 0 13:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:28 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:28 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 13:25:28 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 13:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:28 INFO - 'HOME': '/Users/cltbld', 13:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:28 INFO - 'LOGNAME': 'cltbld', 13:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:28 INFO - 'MOZ_NO_REMOTE': '1', 13:25:28 INFO - 'NO_EM_RESTART': '1', 13:25:28 INFO - 'PAGER': '/bin/cat', 13:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:28 INFO - 'PWD': '/builds/slave/test', 13:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:28 INFO - 'SHELL': '/bin/bash', 13:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:28 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:28 INFO - 'USER': 'cltbld', 13:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:28 INFO - 'XPC_FLAGS': '0x0', 13:25:28 INFO - 'XPC_SERVICE_NAME': '0', 13:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-icjcUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-99FBr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-LQz7ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-gVcO9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-EVl_VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-T83WXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-X__wcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ieLirf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Yu4ylh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WeI1wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-mCPmix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kCs4MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-lK5Tq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tqYYlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ORSkH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-PPdW9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zXm4aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:25:30 INFO - Running setup.py install for manifestparser 13:25:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:25:31 INFO - Running setup.py install for mozcrash 13:25:31 INFO - Running setup.py install for mozdebug 13:25:31 INFO - Running setup.py install for mozdevice 13:25:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:25:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:25:31 INFO - Running setup.py install for mozfile 13:25:31 INFO - Running setup.py install for mozhttpd 13:25:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:25:31 INFO - Running setup.py install for mozinfo 13:25:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:25:31 INFO - Running setup.py install for mozInstall 13:25:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Running setup.py install for mozleak 13:25:32 INFO - Running setup.py install for mozlog 13:25:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Running setup.py install for moznetwork 13:25:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Running setup.py install for mozprocess 13:25:32 INFO - Running setup.py install for mozprofile 13:25:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:25:32 INFO - Running setup.py install for mozrunner 13:25:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:25:33 INFO - Running setup.py install for mozscreenshot 13:25:33 INFO - Running setup.py install for moztest 13:25:33 INFO - Running setup.py install for mozversion 13:25:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:25:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:25:33 INFO - Cleaning up... 13:25:33 INFO - Return code: 0 13:25:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:33 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:33 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 13:25:33 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 13:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:33 INFO - 'HOME': '/Users/cltbld', 13:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:33 INFO - 'LOGNAME': 'cltbld', 13:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:33 INFO - 'MOZ_NO_REMOTE': '1', 13:25:33 INFO - 'NO_EM_RESTART': '1', 13:25:33 INFO - 'PAGER': '/bin/cat', 13:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:33 INFO - 'PWD': '/builds/slave/test', 13:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:33 INFO - 'SHELL': '/bin/bash', 13:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:33 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:33 INFO - 'USER': 'cltbld', 13:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:33 INFO - 'XPC_FLAGS': '0x0', 13:25:33 INFO - 'XPC_SERVICE_NAME': '0', 13:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-O_WFM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:33 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)) 13:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WHV3jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:25:33 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)) 13:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:25:33 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-JXCK1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-QYBKvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ttAPt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-FH3XPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SS_ilT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TT44Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-E1ois_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KAx8MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-007ONz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:25:34 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)) 13:25:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:25:34 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-CUbx2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:25:35 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)) 13:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:25:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-i4LMDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:25:35 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)) 13:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:25:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-oYJZk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:25:35 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)) 13:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ecn5cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:25:35 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)) 13:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:25:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uV02O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:25:35 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)) 13:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:25:35 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-EWOsLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:25:35 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)) 13:25:35 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)) 13:25:35 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)) 13:25:35 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)) 13:25:35 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)) 13:25:35 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)) 13:25:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:38 INFO - Downloading blessings-1.6.tar.gz 13:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:25:38 INFO - Installing collected packages: blessings 13:25:38 INFO - Running setup.py install for blessings 13:25:38 INFO - Successfully installed blessings 13:25:38 INFO - Cleaning up... 13:25:38 INFO - Return code: 0 13:25:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:25:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:25:39 INFO - Reading from file tmpfile_stdout 13:25:39 INFO - Current package versions: 13:25:39 INFO - blessings == 1.6 13:25:39 INFO - blobuploader == 1.2.4 13:25:39 INFO - docopt == 0.6.1 13:25:39 INFO - manifestparser == 1.1 13:25:39 INFO - mozInstall == 1.12 13:25:39 INFO - mozcrash == 0.17 13:25:39 INFO - mozdebug == 0.1 13:25:39 INFO - mozdevice == 0.48 13:25:39 INFO - mozfile == 1.2 13:25:39 INFO - mozhttpd == 0.7 13:25:39 INFO - mozinfo == 0.9 13:25:39 INFO - mozleak == 0.1 13:25:39 INFO - mozlog == 3.1 13:25:39 INFO - moznetwork == 0.27 13:25:39 INFO - mozprocess == 0.22 13:25:39 INFO - mozprofile == 0.28 13:25:39 INFO - mozrunner == 6.11 13:25:39 INFO - mozscreenshot == 0.1 13:25:39 INFO - mozsystemmonitor == 0.0 13:25:39 INFO - moztest == 0.7 13:25:39 INFO - mozversion == 1.4 13:25:39 INFO - psutil == 3.1.1 13:25:39 INFO - requests == 1.2.3 13:25:39 INFO - wsgiref == 0.1.2 13:25:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:39 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:39 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 13:25:39 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 13:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:39 INFO - 'HOME': '/Users/cltbld', 13:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:39 INFO - 'LOGNAME': 'cltbld', 13:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:39 INFO - 'MOZ_NO_REMOTE': '1', 13:25:39 INFO - 'NO_EM_RESTART': '1', 13:25:39 INFO - 'PAGER': '/bin/cat', 13:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:39 INFO - 'PWD': '/builds/slave/test', 13:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:39 INFO - 'SHELL': '/bin/bash', 13:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:39 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:39 INFO - 'USER': 'cltbld', 13:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:39 INFO - 'XPC_FLAGS': '0x0', 13:25:39 INFO - 'XPC_SERVICE_NAME': '0', 13:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 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)) 13:25:39 INFO - Cleaning up... 13:25:39 INFO - Return code: 0 13:25:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:25:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:39 INFO - 'HOME': '/Users/cltbld', 13:25:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:39 INFO - 'LOGNAME': 'cltbld', 13:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:39 INFO - 'MOZ_NO_REMOTE': '1', 13:25:39 INFO - 'NO_EM_RESTART': '1', 13:25:39 INFO - 'PAGER': '/bin/cat', 13:25:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:39 INFO - 'PWD': '/builds/slave/test', 13:25:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:39 INFO - 'SHELL': '/bin/bash', 13:25:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:39 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:39 INFO - 'USER': 'cltbld', 13:25:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:39 INFO - 'XPC_FLAGS': '0x0', 13:25:39 INFO - 'XPC_SERVICE_NAME': '0', 13:25:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:40 INFO - Downloading/unpacking jsonschema 13:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:25:42 INFO - Downloading/unpacking functools32 (from jsonschema) 13:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:42 INFO - Downloading functools32-3.2.3-2.tar.gz 13:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:25:42 INFO - warning: no files found matching '*.txt' 13:25:42 INFO - no previously-included directories found matching 'build' 13:25:42 INFO - no previously-included directories found matching 'dist' 13:25:42 INFO - no previously-included directories found matching '.git*' 13:25:42 INFO - Installing collected packages: jsonschema, functools32 13:25:42 INFO - Running setup.py install for functools32 13:25:43 INFO - warning: no files found matching '*.txt' 13:25:43 INFO - no previously-included directories found matching 'build' 13:25:43 INFO - no previously-included directories found matching 'dist' 13:25:43 INFO - no previously-included directories found matching '.git*' 13:25:43 INFO - Successfully installed jsonschema functools32 13:25:43 INFO - Cleaning up... 13:25:43 INFO - Return code: 0 13:25:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:25:43 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')]} 13:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:43 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')]} 13:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:43 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 0x107034a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10703b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae0c8d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, '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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 13:25:43 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 13:25:43 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 13:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:25:43 INFO - 'HOME': '/Users/cltbld', 13:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:25:43 INFO - 'LOGNAME': 'cltbld', 13:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:43 INFO - 'MOZ_NO_REMOTE': '1', 13:25:43 INFO - 'NO_EM_RESTART': '1', 13:25:43 INFO - 'PAGER': '/bin/cat', 13:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:43 INFO - 'PWD': '/builds/slave/test', 13:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:25:43 INFO - 'SHELL': '/bin/bash', 13:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:25:43 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:25:43 INFO - 'USER': 'cltbld', 13:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:43 INFO - 'XPC_FLAGS': '0x0', 13:25:43 INFO - 'XPC_SERVICE_NAME': '0', 13:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:43 INFO - Downloading/unpacking flake8 13:25:43 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 13:25:43 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 13:25:43 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 13:25:43 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 13:25:43 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 13:25:43 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 13:25:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:25:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:25:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 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 13:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:25:47 INFO - no previously-included directories found matching 'docs/_build' 13:25:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:25:47 INFO - Running setup.py install for pep8 13:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:25:47 INFO - no previously-included directories found matching 'docs/_build' 13:25:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:25:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:25:47 INFO - Cleaning up... 13:25:47 INFO - Return code: 0 13:25:47 INFO - Running post-action listener: _resource_record_post_action 13:25:47 INFO - Running post-action listener: _start_resource_monitoring 13:25:47 INFO - Starting resource monitoring. 13:25:47 INFO - ##### 13:25:47 INFO - ##### Running install step. 13:25:47 INFO - ##### 13:25:47 INFO - Running pre-action listener: _resource_record_pre_action 13:25:47 INFO - Running main action method: install 13:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:25:47 INFO - Reading from file tmpfile_stdout 13:25:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:25:47 INFO - Reading from file tmpfile_stdout 13:25:47 INFO - Output received: 13:25:47 INFO - Usage: mozinstall [options] installer 13:25:47 INFO - Options: 13:25:47 INFO - -h, --help show this help message and exit 13:25:47 INFO - -d DEST, --destination=DEST 13:25:47 INFO - Directory to install application into. [default: 13:25:47 INFO - "/builds/slave/test"] 13:25:47 INFO - --app=APP Application being installed. [default: firefox] 13:25:47 INFO - mkdir: /builds/slave/test/build/application 13:25:47 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'] 13:25:47 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 13:26:20 INFO - Reading from file tmpfile_stdout 13:26:20 INFO - Output received: 13:26:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:26:20 INFO - Running post-action listener: _resource_record_post_action 13:26:20 INFO - ##### 13:26:20 INFO - ##### Running run-tests step. 13:26:20 INFO - ##### 13:26:20 INFO - Running pre-action listener: _resource_record_pre_action 13:26:20 INFO - Running main action method: run_tests 13:26:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:26:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:26:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:26:20 INFO - 2016-04-14 13:26:20.163 screenresolution[1644:7575] starting screenresolution argv=screenresolution get 13:26:20 INFO - 2016-04-14 13:26:20.166 screenresolution[1644:7575] Display 0: 1600x1200x32@60 13:26:20 INFO - 2016-04-14 13:26:20.171 screenresolution[1645:7577] starting screenresolution argv=screenresolution list 13:26:20 INFO - Available Modes on Display 0 13:26:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:26:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:26:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:26:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:26:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:26:20 INFO - Intel Iris: 13:26:20 INFO - Chipset Model: Intel Iris 13:26:20 INFO - Type: GPU 13:26:20 INFO - Bus: Built-In 13:26:20 INFO - VRAM (Dynamic, Max): 1536 MB 13:26:20 INFO - Vendor: Intel (0x8086) 13:26:20 INFO - Device ID: 0x0a2e 13:26:20 INFO - Revision ID: 0x0009 13:26:20 INFO - Displays: 13:26:20 INFO - Display: 13:26:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:26:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:26:20 INFO - Display Serial Number: 1600x1200 60 13:26:20 INFO - Main Display: Yes 13:26:20 INFO - Mirror: Off 13:26:20 INFO - Online: Yes 13:26:20 INFO - Rotation: Supported 13:26:20 INFO - Return code: 0 13:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:20 INFO - Python 2.7.3 13:26:20 INFO - Return code: 0 13:26:20 INFO - grabbing minidump binary from tooltool 13:26:20 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')]} 13:26:20 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 0x106ed8d30>, '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 0x106d3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:20 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 13:26:20 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 13:26:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:20 INFO - Return code: 0 13:26:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:26:21 INFO - Return code: 0 13:26:21 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/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 13:26:21 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/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 13:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g3EGYRfK0i/Render', 13:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:21 INFO - 'HOME': '/Users/cltbld', 13:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:21 INFO - 'LOGNAME': 'cltbld', 13:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:21 INFO - 'MOZ_NO_REMOTE': '1', 13:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:21 INFO - 'NO_EM_RESTART': '1', 13:26:21 INFO - 'PAGER': '/bin/cat', 13:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:21 INFO - 'PWD': '/builds/slave/test', 13:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:21 INFO - 'SHELL': '/bin/bash', 13:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ej1pgQnaHD/Listeners', 13:26:21 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 13:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:21 INFO - 'USER': 'cltbld', 13:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:21 INFO - 'XPC_FLAGS': '0x0', 13:26:21 INFO - 'XPC_SERVICE_NAME': '0', 13:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:21 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/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 13:26:21 INFO - mozversion application_buildid: 20160414122941 13:26:21 INFO - mozversion application_changeset: 7c924c7d25e9227fedea4b6b602455a21632aa9b 13:26:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:21 INFO - mozversion application_name: Firefox 13:26:21 INFO - mozversion application_remotingname: firefox-dev 13:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:26:21 INFO - mozversion application_vendor: Mozilla 13:26:21 INFO - mozversion application_version: 47.0a2 13:26:21 INFO - mozversion platform_buildid: 20160414122941 13:26:21 INFO - mozversion platform_changeset: 7c924c7d25e9227fedea4b6b602455a21632aa9b 13:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:26:21 INFO - mozversion platform_version: 47.0a2 13:26:21 INFO - using testdate: 1460665581 13:26:21 INFO - actual date: 1460665581 13:26:21 INFO - starting webserver on 'localhost:49278' 13:26:21 INFO - SUITE-START | Running 2 tests 13:26:21 INFO - TEST-START | dromaeo_css 13:26:21 INFO - operating with platform_type : mac_ 13:26:21 INFO - Initialising browser for dromaeo_css test... 13:26:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp35JaiM/profile http://localhost:49278/getInfo.html) 13:26:24 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 13:26:24 INFO - PROCESS | 1663 | colorDepth:24 13:26:24 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 13:26:24 INFO - PROCESS | 1663 | __metrics 13:26:24 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:26:25 INFO - TEST-INFO | 1663: exit 0 13:26:25 INFO - Browser initialized. 13:26:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:25 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp35JaiM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:37 INFO - PROCESS | 1666 | RSS: Main: 217726976 13:26:37 INFO - PROCESS | 1666 | 13:27:26 INFO - PROCESS | 1666 | 1460665646958 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] 13:29:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 13:29:39 INFO - PROCESS | 1666 | RSS: Main: 230305792 13:29:39 INFO - PROCESS | 1666 | 13:32:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 13:32:41 INFO - PROCESS | 1666 | RSS: Main: 241008640 13:32:41 INFO - PROCESS | 1666 | 13:35:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 13:35:43 INFO - PROCESS | 1666 | RSS: Main: 243605504 13:35:43 INFO - PROCESS | 1666 | 13:38:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 13:38:46 INFO - PROCESS | 1666 | RSS: Main: 245108736 13:38:46 INFO - PROCESS | 1666 | 13:41:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 13:41:49 INFO - PROCESS | 1666 | RSS: Main: 247345152 13:41:49 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 13:44:51 INFO - PROCESS | 1666 | RSS: Main: 248909824 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | __start_tp_report 13:44:51 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 13:44:51 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 13:44:51 INFO - PROCESS | 1666 | |i|pagename|runs| 13:44:51 INFO - PROCESS | 1666 | |0;dojo.html;3477.269773347597;3518.630543792902;3535.71714262859;3566.1262990567316;3578.2306804037125;5719.914201286984;5748.688483637272;5756;5782.76868925243;5789.507891829199;5715.457031581993;5719.914201286973;5750.942490575093;5782.248307720001;5783.045797443428;5185.299984502091;5219.478052194788;5282.128448805943;5300.09898317285;5309.362876454811;5186.766595503193;5268.4994925482015;5275.393329767068;5301.363836339645;5329.22726204702;3742.8128593570214;4334.674899382543;5286.497782710637;5296.735163241842;5299.894002119974;4467.419235499397;5237.292965449654;5277.8944421111555;5309.097453432906;5349.090654588729;4267.978660106711;5154.664946778447;5262.131748261532;5274.947250527523;5340.706261155635;4630.398048253739;5459.989901868167;5691.8292451226525;5709.571782116358;5711.600187986843;6197.504199664016;6257.8748425031245;6262.561620686553;6305.432511073979;6319.304876463585;6186.041163619601;6194.752209911598;6282;6286.339934306923;6292.150559674431;5908.320543137551;5910.320313163998;5933.199018132583;5936.436038576328;5971.164037034819;6298.7795427160745;6311.715972781236;6329.968350158312;6347.968260158762;6509.707063182168;6095.359987201368;6127.433875357673;6190.690465476709;6229.065640153923;6251.3123556408755;5630.873825234969;6272.341404152498;6290.930541807904;6294.590851594632;6302.936970630327;5899.262592175978;6185.978913932719;6245.812625621239;6267.091271765568;6279.058141278753;6169.074638804125;6184.196054512884;6201.131841542187;6236.338493107913;6333.65164915934;4211.368294755811;4906.067847109038;4930.778114984834;4982.526659967298;4990.201567749215;3847.480590120354;4462.821487140478;4485.304777759387;4492.640588752892;4506.752128632957;5699.800506982236;5707.629004114802;5822.33043200029;5848.766049358063;5935.465808077293;6195.31851496335;6263.655498947511;6265.060240963892;6272.435480806749;6283.560150789401;5833.504152147115;5883.588148829541;5889.204957330791;5900.380460051719;5901.58688891782;5310.150375939908;5434;5471.5896307777075;5483.561315094783;5535.861603459945;6348.936510634927;6349.746010159542;6363.872722545616;6384;6397.488200943913;6221.906671400023;6263.217097862767;6272.466840318624;6281.214848143982;6283.842903927439;6267.905981410374;6338.176037115146;6390.840228994312;6421.1010458536775;6432.13166222554;6239.937600623935;6279.215098112736;6280.152179455715;6299.685015749286;6305.684715764285;6206.906896396467;6273.592216505913;6291.213598300213;6300.338464461165;6319.304876463677;6134.5705800595315;6152.723127459186;6170.444659980623;6209.410106039919;6213.409726076015;5973.398306438714;6172.938270617236;6205.6586887721605;6212.06818977157;6215.160953271431;5744.626599271034;5993.670348130895;6091.939080609137;6117.908231376622;6139.324674285915;6157.32269450369;6203.379662033761;6213.689315534115;6213.96893015532;6215.34738852414;6068.726907289094;6083.7870674526175;6087.269527656709;6093.725782339894;6115.938840611715 13:44:51 INFO - PROCESS | 1666 | |1;ext.html;490.7006725897202;491.8278602489127;636.214275369918;674.7618120748426;680.2177495879739;30957.535636965462;39078.60921390793;39098.609013909925;39198.41202381963;39307.80346098273;40352;40901.18197636046;40943.18113637726;40963.79518102413;41164.79417602915;9576.233901287898;9803.705888823346;9825.606975720963;9844.212463002943;9863.506824658774;9615.326927115104;9760.707178784647;9761;9774.90225097747;9786.461744604045;8206.630701618411;9751.609935602568;9762.609495620167;9771.120599146076;9783.46190959497;9716.417014979088;9777.315587908884;9779.022097790235;9795.608175672964;9841.065098815601;9624.663136790248;9663.951680241555;9669.661561845372;9697.90302096977;9712.61149554024;27322.863385682944;32623.51064734031;39579.40630890539;39677;39774.40338394926;3126.812391256532;3335.5997280326274;3338.6160591532043;3480.269143479872;3502.1419752160627;26518.60222096651;26682.33294167642;27873.860630696716;28031.719682803116;28387.858060709772;2198.791114844103;2620.620010098525;2623.3835048763526;2635.288472112519;2733.7949653776045;437533;439172;440195;440741.9999999968;442246;47669;47715.76142119267;63403;65972.01041984375;66170.66914665492;46508.5349146511;47004;47208;47390.341338053695;47392.763036184595;16894;17037.659246814994;17071.573210669583;17074;17109.743353849703;13346.265955372548;13435.731285374237;13443.932780336036;13484.730305393838;13515.662108447368;15043.323050462755;15059.021163624548;15363.462278820187;15442.382304707686;15556.299966501534;6527.184101987252;6658.667066646648;6660.70026848793;6679.799606011828;6691.698873550702;997.897323457569;1042.3485321673954;1059.613241166984;1121.7476067884825;1159.6231224851956;29784.553231701542;30021.099367019026;30504;30690.77236910543;30781.846090769403;1117.435694974049;1154.5901205072078;1164.9631827673377;1207.589419597341;1293.5666551705096;14529.78205326921;15021.324040417989;15239.771403428957;16355.018698878106;16697;615663;680492.597537019;685177;692082;694516.0548394553;63980.72038559296;64055.6797216011;64266.35733642604;65043.34956650467;65288;1487.5091219897624;1515.9166245856584;1517.332373755566;1523.6876440329706;1640.1635166065155;30390;30677.525144287087;30867.228319292197;31261.905833295725;31298;47013.294800578704;49316.75341623269;52109.47890521046;52449.47550524446;52871.47128528666;440802;442339;447282;514673;514978;28566.571501427912;33252.83373583117;33919;34063.31873362568;34465.82767086149;44798.328025079;44806.87982800456;46279;46393.53606463892;46429.767851160526;31147;36561.45157822582;37051.444228336055;37543.81228093951;38276.23447530978;36015;37077.81461092677;37173.442398363506;37194.44208336823;37357.43963840599;27532;36716.082097947765;37042.444363334034;37606.81196594109;38574.42138367983;32102.839485802422;32532.51201231936;34208.486872697424;34784.82607586946;35457;24174.274771756875;24640.340538954697;24731.876340618182;24827.87586062058;24901.750982489943 13:44:51 INFO - PROCESS | 1666 | |2;jquery.html;363.25895173845356;384.139527458493;386.688715583955;386.9864554740583;386.9903252418691;20049.498762530926;20924.686129708065;21481.67777483335;21795.346139615816;21840.344789656298;19506.927119008484;20808.791912080873;20838.47903802402;21272;21473.46316342092;5380.650257733245;5505.476979686943;5539.335279766414;5541.0580201365865;5559.8888022239535;4276.208901353244;6880.483963702717;6891.758788442406;6902.240753517109;6911.377975982161;5465.262189604412;6785.6267905265195;6796.7621133260345;6824.385805277524;6840.623765692885;6005.1892994445625;6051.425114614105;6062.484688801457;6066.393360663942;6082.300535438415;5714.257146570961;5718.456746609066;5757.021306377926;5759.913601295984;5781.364049954502;25685.3578660535;25794.484110317877;25908.481830363286;26883.19350419471;26923.86538067297;2076.678114892194;2267.1498188179435;2403.42317843718;2590.0805214148895;2792.902248421316;9868.95065524675;10109.39343639384;10249.948750256275;10329.741756456073;10567.841482377771;1635.2232689472523;1746.8777185596887;1777.3246166456793;1801.7297405389165;1817.7727784026997;108264.4586777061;112602;114442.42778786052;116524;118619;11404.030657394214;11563.710907227218;11570.19008669385;11634.301941883514;11820.70448238801;14346.282685865664;14362.353694083791;14363.210023448602;14401.495947641783;14401.855981440262;8701.129887011375;8987.281017518582;9056.95844977836;9092.363534552518;9105.408148470327;9201.539923003957;9229.446233226028;9236.307276954256;9299.95350023259;9317.534123293808;4490.034642551802;4580.175568397721;4598.540145985375;4610.377599024089;4653.022865198279;1937.6027914277822;1956.9608607827763;1957.1290775605005;1982.3656429942569;1987.3441764217773;781.6638845296463;879.9340049496313;986.1716158426956;1002.5362970063643;1050.76883085721;15237.619059523378;18454.630907382045;19876.50308742264;20480;20628.27801026957;989.6585677941099;1012.7620009297809;1031.159604921986;1048.119579553179;1051.4374809476892;11135.888641113484;11537.596184133516;11575.131865109983;11638.94180529109;11685.766284674259;445578;539123;542988;603897;663724;113593.43203284097;116717;123051.38474307572;123755.76244237623;127222.36388817997;989.8416253399422;1031.7317497450717;1034.6947650443137;1037.1288117980782;1070.8714954205388;15724.76412853831;17984.460466185512;17985.910070449565;18246.817531825043;18307.816921831145;53327.200091999424;55783.16325255043;57494;59843.45280181566;60207.69896150491;75489.62255188689;79920;81383.5930820342;84403.5779821097;85466;11932.403379831147;12217.266963982189;12371.381430928597;12399.94600458971;12485;11079.778404431705;14033.719325613227;14042.297885105909;14161;14693;11750.823737643772;12123.81814272769;12146.939265303618;12200.938995305321;12255.816162757388;9769.413835169913;11809.468573914366;11954.222975506564;12178.75642487163;12186.57346992851;11891.821622675494;12247.203931744409;12301.384930753606;12314;12486.500539978299;12039.458224379749;12062.939685301517;12175.208611440228;12206.633800985985;12294.877051229374;12173.026157907523;12229.75540489203;12232.449539770554;12250.87749122533;12385.133040687066 13:44:51 INFO - PROCESS | 1666 | |3;mootools.html;1654.1233146432392;1677.958051048724;2019.6367451969916;2053.37372101509;2083.541620843414;8437.15628437156;8938.240249578794;9190.483570210916;9405.153536181742;9419.905800941997;9064.546772661373;9083.318751093679;9174;9185;9190.126937940884;2563.4104156044073;2572.3697694064886;2589.9093531726394;2598.4153565447814;2602.986985065072;2512.6859142607173;2558.8976440942433;2582.715901250861;2584.6769153855766;2594.4811037792515;2253.278950735765;2516.32059343977;2547.681539807524;2573.137998770414;2582.2769624505167;2556.309796354983;2567.897284108643;2568.4221050263727;2593.922182334533;2597.142942828862;2295.3458264394567;2444.4844196598046;2554.3358726731;2562.3722188064044;2596.415806443554;7654.73208437702;9172.449653020773;9276.304277179239;9284.489353085577;9335.113164249386;4669.556392142741;5845.561582881259;5891.99836027872;5895.145203945404;5901.822945311647;3571.5178450909057;3685.207680348738;3691.8523259069607;3695.334839728848;3712.7029837612927;1039.4542864995863;1059.9894001059968;1060.0830281806182;1065.8188108021654;1066.5467176450056;12475.875241247562;12577.811332830015;12597.622071337782;12607.684807879785;12646.114771965966;5043.9747801260755;5088.414832294259;5146.485351464824;5159.432462429129;5215.113430716788;10666.200034997251;10781.892181078245;10819.13446924244;10827;10852.023317901427;5745.511631511285;5798.246227990334;5830.533557315404;5847.356790753014;5880.7353669085;4666.813327466931;5067.442581316052;5147.0735267651435;5150.922736158961;5211.42674305826;4098.016476045727;4113.568075352105;4121.155163191538;4133.21468920904;4139.710220284612;1349.2107117336272;1353.349764732239;1366.077897419238;1369.2879702554617;1377.5109836008073;1359.0962010263065;1389.603962870577;1394.9442022319197;1439.143709492871;1450.8259008918997;8549.914500855037;8730.301575873915;8773.903262092239;8804.735857924272;8810.207081362709;1170.6839153428527;1231.7167051578188;1267.0497127154633;1280.9231446113263;1286.9356532173354;6350.428461438492;6411.583247089017;6439.54923155384;6485.643289619022;6486.481081513468;11209.271397359145;11383.373914434786;11436.885631143748;11566.47950842214;11627.76744465106;11118.55525778976;11158.051565616852;11343.546258149747;11440.370779607036;11440.656780296604;8760.4305720128;8870.2460290876;8909.955450222837;8944.552772361356;8999.775005624912;8132.83734325322;8227.13615070409;8248.051474080317;8296.045954715284;8348.123447037973;9976.700698978751;9983.700488985342;10125.59497620087;10156.441395723306;10203.132733717717;10191.388516689023;10322.174226061747;10549.78900421972;10581.888901665523;10603.310784798963;6557.672116394257;7113.679884405317;7591.278828511283;7785.92214077852;7838.921610783819;8543.444676096035;8580.699675511576;8604.48373097616;8642.049374568918;8700.956495217484;7470.365018973231;7637.579933103732;7661.770146895602;7672.347850432776;7785.065792104983;7507.624618769149;7569.924300756922;7615.581143037186;7700.306972372513;7725.22747725223;8105.27052565272;8135.959320203598;8183.263506284463;8203.71287004952;8208.712695055645;7253.673584688596;7321.121465424183;7372.741954031583;7376.7049318026675;7426.368758655575;7450;7470.2903224193615;7510.849783004419;7533.6233188339265;7543.43424243173 13:44:51 INFO - PROCESS | 1666 | |4;prototype.html;297.35622377552613;307.84915391458185;334.7780600807054;342.7789076045949;347.5256275184373;6964.616946067964;6987.336203060714;6997.795694356274;7002.719891204346;7014.649267536615;6928.584284942907;6936.410405115571;6937.618430986294;6979.022936788853;7001.964990175042;4573.7713114344315;4789.640776941744;4862.586680132193;5121.308623335858;5163.896722065547;4454.933176002362;4993.776524751423;5048.242763585455;5110.540051395374;5114.769835357418;5015.498450154992;5038.269450929613;5044.82343117991;5065.468125846788;5095.541401273885;4300.290452075404;4368.453943257093;4858.174110401223;5058.696478211301;5063.18988961768;3943.152222272225;4061.431399604058;4195.958040419618;4398.098389830077;4447.755373454459;6362.1093046973465;6681.432078273353;6723.731050757964;6723.865522689568;6757.526973111884;5928.258967629046;5985.581009329305;5987.491063259628;6011.428914253139;6026.0960855871535;7429.257074292582;7453.85092298151;7470.3650189733935;7476.551406915548;7514;4900.191468407708;4912.189488734354;4912.680675756064;4924.359833221694;4929.704217746947;7057.541259818096;7732.7680169595005;7852.568108754016;7853.293203611703;7908.051033875971;4875.024995001014;4923.384576927884;4964.205727083649;4965.155923493015;4976.925346119739;4344.196323680129;5019.322391477177;5029.798808047711;5030.37120359955;5048.318477005557;5936.406359364029;5949.762009519657;5983.431574000463;6000.459958603659;6012.819615411545;6126.989046807316;7400.814979625445;7411.407087432993;7416.25837416254;7435.256474352522;1733.0043696679718;1733.2113888180847;1764.7705798246145;1785.81248968859;1787.9195436205403;960.9855852162223;1145.3414286785132;1158.44394690549;1158.8377627132209;1162.91859569831;6832.316768323228;6870.7595234166565;6901.102856628707;6905.585664860024;6911.619860907598;6520.967395163088;6940.785362561532;7706.845863082707;7715.189905059888;7734.071911370672;6859.348361905611;6870.393043652122;6877.828054298682;6903.206131294865;6913.170419549586;3687.778733276012;4047.6357127858046;4066.268071747114;4171.624553790173;4174.227767862894;7915.802104947423;7980.561069141253;8108.270255677017;8140.674373025131;8173.18268173178;7989.162492626612;8019.879701804478;8043.075046369742;8048;8062.234087761771;8111.594420278962;8113.432059755761;8119.9188008120345;8151.633176506953;8157.306628936488;5907.822765317047;7703.114141873756;7758.107817601048;7771.844563108819;7795.181505941794;6352;7353.191148973716;7560.9621951889885;7624.8475030500185;7648.426368022309;6219.968900155471;7295.708171673074;7991.920080799117;8104.392170587347;8159.755207343789;4987.10232158215;5036.521530454601;5048.318477005557;5049.974750126373;5070.492950705047;6321.652309123042;7431.777046688608;7654.004979352649;7685.154632990479;7714.884276735966;7403.925960740539;7424.628768561658;7429.294217049372;7432.92567074344;7459.515131516434;7392.002079719384;7399.704011839682;7424.10910690699;7429;7507.099148102263;6912;7224.060872086595;7239.420846332386;7248.818779530554;7288.708451661874;7369;7380.889286660812;7385.113786345673;7400.444966627417;7461.515001524884;7165.283471652793;7204.135503739375;7205.495615306878;7210.315020073084;7236.167840698387 13:44:51 INFO - PROCESS | 1666 | |5;yui.html;724.5145752345929;750.9061367329084;774.8411575626995;775.9573223472706;778.0663204155015;14295.641914018177;15222.086674799506;15578.844211557882;15583.987040842338;15588.922055389707;14185.929070354634;14258.71482570348;14277.571672849805;14294.78557821631;14316.427342906298;765.5789315876274;948.0235357581685;953.3469573342283;954.8901876284247;976.541025717915;954.413035982869;954.4702690007043;963.8361478548663;969.0842154164318;976.1214906584061;999.1557134221571;1001.4241810958691;1006.4263369879171;1013.4831236069584;1016.7508960304735;983.2183414185704;993.8459538771538;994.2145704893126;997.8403455447094;1006.5722068121056;747.9027726395589;750.1373420566392;758.2493331601675;758.8482303539259;761.7372006657749;15313.923430382776;15640.608984775357;15669.981451205635;15728.60678483047;15756.684866302725;13154.934225328907;13180.86819131806;13289.269090200036;13300.80292773655;13353.065285430024;10146.753039027513;10194;10212.897871021269;10364.481775911174;10433;3523.8942831714835;3549.239591124408;3551.5738111426795;3625.909352266188;3791.905202369935;75247.62376188084;75497.62251188763;75734.48531029349;76641.23358766397;76654.23345766526;9712.562934667956;9744;9787.608495660093;9872.160866326443;9916.603335866628;22303.219387321366;22466.663000055014;22510.549789004457;22512.212072577382;22564.548709025727;7528.171901090986;7543.358814500719;7591.772246832604;7596.886046709304;7663.463557550918;4097.385392191195;4128.876133715993;4165.062860856344;4216.177845320194;4275.700700950966;3619.76471529355;3643.4899114124046;3676.889693309205;3676.988828072248;3681.7606855554304;652.4291245160484;656.9292053952028;666.3769375633798;675.1864003875319;692.9861402771917;492.07735495945104;497.4105684763567;602.6354055796268;609.9908501372483;622.6762083716442;6944.4444444444325;7988;8425.199606037417;8451.704190353432;8492;540.2166858055834;589.4783116941537;608.3490664988508;610.2402508876477;614.5575185866259;3719.34911390511;3852.9614703853163;3991.401289806552;4035.124191935673;4049.250888585621;99406.00593993967;101955;102535.4873225644;102731.97268027374;102778;81663;82038.35923281501;82172;82435.05389676639;84415.57792211;61637.69181154066;72530.63734681398;72681.63659181776;73829;73847.63076184585;7806.4925779824125;8009.799755006172;8013.719519817012;8019.5990200490905;8165.2243036911395;51220.74389628177;51557.71105722387;51651;52421;53352.93294134173;48639.75680121718;66405.33594663991;71486.28513714796;71794;72385.27614723996;10310.536025879004;10441.112505436819;10494.52774625159;10602.25784195099;10711.785764284827;10875.945620271848;11103.833442498208;11312.6040588579;11351.659450216506;11928.926396624345;10207.89792102099;10261.179105671677;10268.332558383681;10505.68482945513;11207.71980700489;10411.739706507398;10437.843432348673;10480.213983951082;10665.786684266426;11272.774544509228;10173.898261017592;10228.335158214692;10372.740681483023;10502.737431564272;11172.888271117185;8894.644214231359;8957.507337096262;8958.820823583623;9135.680251191176;9231.615257711397;8679.696210632597;8908.420952638058;9063.821703178544;9149.496777677025;9178.128077832594 13:44:51 INFO - PROCESS | 1666 | __end_tp_report 13:44:51 INFO - PROCESS | 1666 | __start_cc_report 13:44:51 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,364 13:44:51 INFO - PROCESS | 1666 | __end_cc_report 13:44:51 INFO - PROCESS | 1666 | __startTimestamp1460666691818__endTimestamp 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | ------- Summary: start ------- 13:44:51 INFO - PROCESS | 1666 | Number of tests: 6 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5766.56 Median:6087.27 stddev:690.24 (11.3%) stddev-sans-first:668.59 13:44:51 INFO - PROCESS | 1666 | Values: 3477.3 3518.6 3535.7 3566.1 3578.2 5719.9 5748.7 5756.0 5782.8 5789.5 5715.5 5719.9 5750.9 5782.2 5783.0 5185.3 5219.5 5282.1 5300.1 5309.4 5186.8 5268.5 5275.4 5301.4 5329.2 3742.8 4334.7 5286.5 5296.7 5299.9 4467.4 5237.3 5277.9 5309.1 5349.1 4268.0 5154.7 5262.1 5274.9 5340.7 4630.4 5460.0 5691.8 5709.6 5711.6 6197.5 6257.9 6262.6 6305.4 6319.3 6186.0 6194.8 6282.0 6286.3 6292.2 5908.3 5910.3 5933.2 5936.4 5971.2 6298.8 6311.7 6330.0 6348.0 6509.7 6095.4 6127.4 6190.7 6229.1 6251.3 5630.9 6272.3 6290.9 6294.6 6302.9 5899.3 6186.0 6245.8 6267.1 6279.1 6169.1 6184.2 6201.1 6236.3 6333.7 4211.4 4906.1 4930.8 4982.5 4990.2 3847.5 4462.8 4485.3 4492.6 4506.8 5699.8 5707.6 5822.3 5848.8 5935.5 6195.3 6263.7 6265.1 6272.4 6283.6 5833.5 5883.6 5889.2 5900.4 5901.6 5310.2 5434.0 5471.6 5483.6 5535.9 6348.9 6349.7 6363.9 6384.0 6397.5 6221.9 6263.2 6272.5 6281.2 6283.8 6267.9 6338.2 6390.8 6421.1 6432.1 6239.9 6279.2 6280.2 6299.7 6305.7 6206.9 6273.6 6291.2 6300.3 6319.3 6134.6 6152.7 6170.4 6209.4 6213.4 5973.4 6172.9 6205.7 6212.1 6215.2 5744.6 5993.7 6091.9 6117.9 6139.3 6157.3 6203.4 6213.7 6214.0 6215.3 6068.7 6083.8 6087.3 6093.7 6115.9 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:66151.77 Median:38425.33 stddev:144205.79 (375.3%) stddev-sans-first:144526.06 13:44:51 INFO - PROCESS | 1666 | Values: 490.7 491.8 636.2 674.8 680.2 30957.5 39078.6 39098.6 39198.4 39307.8 40352.0 40901.2 40943.2 40963.8 41164.8 9576.2 9803.7 9825.6 9844.2 9863.5 9615.3 9760.7 9761.0 9774.9 9786.5 8206.6 9751.6 9762.6 9771.1 9783.5 9716.4 9777.3 9779.0 9795.6 9841.1 9624.7 9664.0 9669.7 9697.9 9712.6 27322.9 32623.5 39579.4 39677.0 39774.4 3126.8 3335.6 3338.6 3480.3 3502.1 26518.6 26682.3 27873.9 28031.7 28387.9 2198.8 2620.6 2623.4 2635.3 2733.8 437533.0 439172.0 440195.0 440742.0 442246.0 47669.0 47715.8 63403.0 65972.0 66170.7 46508.5 47004.0 47208.0 47390.3 47392.8 16894.0 17037.7 17071.6 17074.0 17109.7 13346.3 13435.7 13443.9 13484.7 13515.7 15043.3 15059.0 15363.5 15442.4 15556.3 6527.2 6658.7 6660.7 6679.8 6691.7 997.9 1042.3 1059.6 1121.7 1159.6 29784.6 30021.1 30504.0 30690.8 30781.8 1117.4 1154.6 1165.0 1207.6 1293.6 14529.8 15021.3 15239.8 16355.0 16697.0 615663.0 680492.6 685177.0 692082.0 694516.1 63980.7 64055.7 64266.4 65043.3 65288.0 1487.5 1515.9 1517.3 1523.7 1640.2 30390.0 30677.5 30867.2 31261.9 31298.0 47013.3 49316.8 52109.5 52449.5 52871.5 440802.0 442339.0 447282.0 514673.0 514978.0 28566.6 33252.8 33919.0 34063.3 34465.8 44798.3 44806.9 46279.0 46393.5 46429.8 31147.0 36561.5 37051.4 37543.8 38276.2 36015.0 37077.8 37173.4 37194.4 37357.4 27532.0 36716.1 37042.4 37606.8 38574.4 32102.8 32532.5 34208.5 34784.8 35457.0 24174.3 24640.3 24731.9 24827.9 24901.8 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34278.23 Median:10931.92 stddev:94161.17 (861.3%) stddev-sans-first:94390.88 13:44:51 INFO - PROCESS | 1666 | Values: 363.3 384.1 386.7 387.0 387.0 20049.5 20924.7 21481.7 21795.3 21840.3 19506.9 20808.8 20838.5 21272.0 21473.5 5380.7 5505.5 5539.3 5541.1 5559.9 4276.2 6880.5 6891.8 6902.2 6911.4 5465.3 6785.6 6796.8 6824.4 6840.6 6005.2 6051.4 6062.5 6066.4 6082.3 5714.3 5718.5 5757.0 5759.9 5781.4 25685.4 25794.5 25908.5 26883.2 26923.9 2076.7 2267.1 2403.4 2590.1 2792.9 9869.0 10109.4 10249.9 10329.7 10567.8 1635.2 1746.9 1777.3 1801.7 1817.8 108264.5 112602.0 114442.4 116524.0 118619.0 11404.0 11563.7 11570.2 11634.3 11820.7 14346.3 14362.4 14363.2 14401.5 14401.9 8701.1 8987.3 9057.0 9092.4 9105.4 9201.5 9229.4 9236.3 9300.0 9317.5 4490.0 4580.2 4598.5 4610.4 4653.0 1937.6 1957.0 1957.1 1982.4 1987.3 781.7 879.9 986.2 1002.5 1050.8 15237.6 18454.6 19876.5 20480.0 20628.3 989.7 1012.8 1031.2 1048.1 1051.4 11135.9 11537.6 11575.1 11638.9 11685.8 445578.0 539123.0 542988.0 603897.0 663724.0 113593.4 116717.0 123051.4 123755.8 127222.4 989.8 1031.7 1034.7 1037.1 1070.9 15724.8 17984.5 17985.9 18246.8 18307.8 53327.2 55783.2 57494.0 59843.5 60207.7 75489.6 79920.0 81383.6 84403.6 85466.0 11932.4 12217.3 12371.4 12399.9 12485.0 11079.8 14033.7 14042.3 14161.0 14693.0 11750.8 12123.8 12146.9 12200.9 12255.8 9769.4 11809.5 11954.2 12178.8 12186.6 11891.8 12247.2 12301.4 12314.0 12486.5 12039.5 12062.9 12175.2 12206.6 12294.9 12173.0 12229.8 12232.4 12250.9 12385.1 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6375.91 Median:5055.71 stddev:3366.12 (66.6%) stddev-sans-first:3356.86 13:44:51 INFO - PROCESS | 1666 | Values: 1654.1 1678.0 2019.6 2053.4 2083.5 8437.2 8938.2 9190.5 9405.2 9419.9 9064.5 9083.3 9174.0 9185.0 9190.1 2563.4 2572.4 2589.9 2598.4 2603.0 2512.7 2558.9 2582.7 2584.7 2594.5 2253.3 2516.3 2547.7 2573.1 2582.3 2556.3 2567.9 2568.4 2593.9 2597.1 2295.3 2444.5 2554.3 2562.4 2596.4 7654.7 9172.4 9276.3 9284.5 9335.1 4669.6 5845.6 5892.0 5895.1 5901.8 3571.5 3685.2 3691.9 3695.3 3712.7 1039.5 1060.0 1060.1 1065.8 1066.5 12475.9 12577.8 12597.6 12607.7 12646.1 5044.0 5088.4 5146.5 5159.4 5215.1 10666.2 10781.9 10819.1 10827.0 10852.0 5745.5 5798.2 5830.5 5847.4 5880.7 4666.8 5067.4 5147.1 5150.9 5211.4 4098.0 4113.6 4121.2 4133.2 4139.7 1349.2 1353.3 1366.1 1369.3 1377.5 1359.1 1389.6 1394.9 1439.1 1450.8 8549.9 8730.3 8773.9 8804.7 8810.2 1170.7 1231.7 1267.0 1280.9 1286.9 6350.4 6411.6 6439.5 6485.6 6486.5 11209.3 11383.4 11436.9 11566.5 11627.8 11118.6 11158.1 11343.5 11440.4 11440.7 8760.4 8870.2 8910.0 8944.6 8999.8 8132.8 8227.1 8248.1 8296.0 8348.1 9976.7 9983.7 10125.6 10156.4 10203.1 10191.4 10322.2 10549.8 10581.9 10603.3 6557.7 7113.7 7591.3 7785.9 7838.9 8543.4 8580.7 8604.5 8642.0 8701.0 7470.4 7637.6 7661.8 7672.3 7785.1 7507.6 7569.9 7615.6 7700.3 7725.2 8105.3 8136.0 8183.3 8203.7 8208.7 7253.7 7321.1 7372.7 7376.7 7426.4 7450.0 7470.3 7510.8 7533.6 7543.4 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6036.40 Median:6902.15 stddev:1939.60 (28.1%) stddev-sans-first:1896.61 13:44:51 INFO - PROCESS | 1666 | Values: 297.4 307.8 334.8 342.8 347.5 6964.6 6987.3 6997.8 7002.7 7014.6 6928.6 6936.4 6937.6 6979.0 7002.0 4573.8 4789.6 4862.6 5121.3 5163.9 4454.9 4993.8 5048.2 5110.5 5114.8 5015.5 5038.3 5044.8 5065.5 5095.5 4300.3 4368.5 4858.2 5058.7 5063.2 3943.2 4061.4 4196.0 4398.1 4447.8 6362.1 6681.4 6723.7 6723.9 6757.5 5928.3 5985.6 5987.5 6011.4 6026.1 7429.3 7453.9 7470.4 7476.6 7514.0 4900.2 4912.2 4912.7 4924.4 4929.7 7057.5 7732.8 7852.6 7853.3 7908.1 4875.0 4923.4 4964.2 4965.2 4976.9 4344.2 5019.3 5029.8 5030.4 5048.3 5936.4 5949.8 5983.4 6000.5 6012.8 6127.0 7400.8 7411.4 7416.3 7435.3 1733.0 1733.2 1764.8 1785.8 1787.9 961.0 1145.3 1158.4 1158.8 1162.9 6832.3 6870.8 6901.1 6905.6 6911.6 6521.0 6940.8 7706.8 7715.2 7734.1 6859.3 6870.4 6877.8 6903.2 6913.2 3687.8 4047.6 4066.3 4171.6 4174.2 7915.8 7980.6 8108.3 8140.7 8173.2 7989.2 8019.9 8043.1 8048.0 8062.2 8111.6 8113.4 8119.9 8151.6 8157.3 5907.8 7703.1 7758.1 7771.8 7795.2 6352.0 7353.2 7561.0 7624.8 7648.4 6220.0 7295.7 7991.9 8104.4 8159.8 4987.1 5036.5 5048.3 5050.0 5070.5 6321.7 7431.8 7654.0 7685.2 7714.9 7403.9 7424.6 7429.3 7432.9 7459.5 7392.0 7399.7 7424.1 7429.0 7507.1 6912.0 7224.1 7239.4 7248.8 7288.7 7369.0 7380.9 7385.1 7400.4 7461.5 7165.3 7204.1 7205.5 7210.3 7236.2 13:44:51 INFO - PROCESS | 1666 | 13:44:51 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18559.97 Median:52886.97 stddev:26599.16 (50.3%) stddev-sans-first:26640.07 13:44:51 INFO - PROCESS | 1666 | Values: 724.5 750.9 774.8 776.0 778.1 14295.6 15222.1 15578.8 15584.0 15588.9 14185.9 14258.7 14277.6 14294.8 14316.4 765.6 948.0 953.3 954.9 976.5 954.4 954.5 963.8 969.1 976.1 999.2 1001.4 1006.4 1013.5 1016.8 983.2 993.8 994.2 997.8 1006.6 747.9 750.1 758.2 758.8 761.7 15313.9 15640.6 15670.0 15728.6 15756.7 13154.9 13180.9 13289.3 13300.8 13353.1 10146.8 10194.0 10212.9 10364.5 10433.0 3523.9 3549.2 3551.6 3625.9 3791.9 75247.6 75497.6 75734.5 76641.2 76654.2 9712.6 9744.0 9787.6 9872.2 9916.6 22303.2 22466.7 22510.5 22512.2 22564.5 7528.2 7543.4 7591.8 7596.9 7663.5 4097.4 4128.9 4165.1 4216.2 4275.7 3619.8 3643.5 3676.9 3677.0 3681.8 652.4 656.9 666.4 675.2 693.0 492.1 497.4 602.6 610.0 622.7 6944.4 7988.0 8425.2 8451.7 8492.0 540.2 589.5 608.3 610.2 614.6 3719.3 3853.0 3991.4 4035.1 4049.3 99406.0 101955.0 102535.5 102732.0 102778.0 81663.0 82038.4 82172.0 82435.1 84415.6 61637.7 72530.6 72681.6 73829.0 73847.6 7806.5 8009.8 8013.7 8019.6 8165.2 51220.7 51557.7 51651.0 52421.0 53352.9 48639.8 66405.3 71486.3 71794.0 72385.3 10310.5 10441.1 10494.5 10602.3 10711.8 10875.9 11103.8 11312.6 11351.7 11928.9 10207.9 10261.2 10268.3 10505.7 11207.7 10411.7 10437.8 10480.2 10665.8 11272.8 10173.9 10228.3 10372.7 10502.7 11172.9 8894.6 8957.5 8958.8 9135.7 9231.6 8679.7 8908.4 9063.8 9149.5 9178.1 13:44:51 INFO - PROCESS | 1666 | -------- Summary: end -------- 13:44:51 INFO - PROCESS | 1666 | 13:44:52 INFO - TEST-INFO | 1666: exit 0 13:44:52 INFO - TEST-OK | dromaeo_css | took 1110446ms 13:44:52 INFO - TEST-START | kraken 13:44:52 INFO - operating with platform_type : mac_ 13:44:52 INFO - Initialising browser for kraken test... 13:44:52 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmprnku57/profile http://localhost:49278/getInfo.html) 13:44:54 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 13:44:54 INFO - PROCESS | 1679 | colorDepth:24 13:44:54 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 13:44:54 INFO - PROCESS | 1679 | __metrics 13:44:54 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:44:55 INFO - TEST-INFO | 1679: exit 0 13:44:55 INFO - Browser initialized. 13:44:55 INFO - Running cycle 1/1 for kraken test... 13:44:55 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmprnku57/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:07 INFO - PROCESS | 1682 | RSS: Main: 217735168 13:45:07 INFO - PROCESS | 1682 | 13:45:09 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:10 INFO - PROCESS | 1682 | RSS: Main: 230633472 13:45:10 INFO - PROCESS | 1682 | 13:45:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 13:45:13 INFO - PROCESS | 1682 | RSS: Main: 238907392 13:45:13 INFO - PROCESS | 1682 | 13:45:17 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 13:45:18 INFO - PROCESS | 1682 | RSS: Main: 241164288 13:45:18 INFO - PROCESS | 1682 | 13:45:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 13:45:20 INFO - PROCESS | 1682 | RSS: Main: 243941376 13:45:20 INFO - PROCESS | 1682 | 13:45:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:23 INFO - PROCESS | 1682 | RSS: Main: 244146176 13:45:23 INFO - PROCESS | 1682 | 13:45:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:26 INFO - PROCESS | 1682 | RSS: Main: 244404224 13:45:26 INFO - PROCESS | 1682 | 13:45:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:30 INFO - PROCESS | 1682 | RSS: Main: 244719616 13:45:30 INFO - PROCESS | 1682 | 13:45:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 13:45:33 INFO - PROCESS | 1682 | RSS: Main: 245088256 13:45:33 INFO - PROCESS | 1682 | 13:45:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:35 INFO - PROCESS | 1682 | RSS: Main: 244137984 13:45:35 INFO - PROCESS | 1682 | 13:45:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:38 INFO - PROCESS | 1682 | RSS: Main: 244346880 13:45:38 INFO - PROCESS | 1682 | 13:45:40 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:40 INFO - PROCESS | 1682 | RSS: Main: 245280768 13:45:40 INFO - PROCESS | 1682 | 13:45:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:45:44 INFO - PROCESS | 1682 | RSS: Main: 245354496 13:45:44 INFO - PROCESS | 1682 | 13:45:46 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:45:47 INFO - PROCESS | 1682 | RSS: Main: 245776384 13:45:47 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 13:45:49 INFO - PROCESS | 1682 | RSS: Main: 246796288 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | __start_tp_report 13:45:49 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 13:45:49 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 13:45:49 INFO - PROCESS | 1682 | |i|pagename|runs| 13:45:49 INFO - PROCESS | 1682 | |0;ai-astar;117;112;117;116;116;130;114;115;116;115 13:45:49 INFO - PROCESS | 1682 | |1;audio-beat-detection;152;136;181;155;119;137;140;121;161;131 13:45:49 INFO - PROCESS | 1682 | |2;audio-dft;196;255;210;282;200;279;241;247;257;193 13:45:49 INFO - PROCESS | 1682 | |3;audio-fft;72;69;71;110;58;67;72;51;149;51 13:45:49 INFO - PROCESS | 1682 | |4;audio-oscillator;86;82;120;96;114;123;152;121;67;143 13:45:49 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;93;88;88;86;89;85;88;74;137;89 13:45:49 INFO - PROCESS | 1682 | |6;imaging-darkroom;95;93;96;94;94;93;124;152;94;94 13:45:49 INFO - PROCESS | 1682 | |7;imaging-desaturate;149;147;93;91;98;109;93;92;93;91 13:45:49 INFO - PROCESS | 1682 | |8;json-parse-financial;54;62;60;58;60;62;60;69;59;55 13:45:49 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;66;63;68;70;71;66;65;65;65;68 13:45:49 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;83;84;84;82;85;82;84;82;86 13:45:49 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;122;121;125;162;135;136;127;139;143;135 13:45:49 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;137;133;174;179;174;135;143;175;180;165 13:45:49 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;68;67;67;69;64;66;66;67;65 13:45:49 INFO - PROCESS | 1682 | __end_tp_report 13:45:49 INFO - PROCESS | 1682 | __start_cc_report 13:45:49 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,917 13:45:49 INFO - PROCESS | 1682 | __end_cc_report 13:45:49 INFO - PROCESS | 1682 | __startTimestamp1460666749508__endTimestamp 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | ------- Summary: start ------- 13:45:49 INFO - PROCESS | 1682 | Number of tests: 14 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:116.80 Median:116.00 stddev:4.87 (4.2%) stddev-sans-first:5.17 13:45:49 INFO - PROCESS | 1682 | Values: 117.0 112.0 117.0 116.0 116.0 130.0 114.0 115.0 116.0 115.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:146.00 stddev:19.12 (13.1%) stddev-sans-first:20.02 13:45:49 INFO - PROCESS | 1682 | Values: 152.0 136.0 181.0 155.0 119.0 137.0 140.0 121.0 161.0 131.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:236.00 Median:251.00 stddev:33.89 (13.5%) stddev-sans-first:32.70 13:45:49 INFO - PROCESS | 1682 | Values: 196.0 255.0 210.0 282.0 200.0 279.0 241.0 247.0 257.0 193.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:77.00 Median:68.00 stddev:30.25 (44.5%) stddev-sans-first:32.03 13:45:49 INFO - PROCESS | 1682 | Values: 72.0 69.0 71.0 110.0 58.0 67.0 72.0 51.0 149.0 51.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:109.50 stddev:27.21 (24.8%) stddev-sans-first:27.39 13:45:49 INFO - PROCESS | 1682 | Values: 86.0 82.0 120.0 96.0 114.0 123.0 152.0 121.0 67.0 143.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:88.00 stddev:16.67 (18.9%) stddev-sans-first:17.67 13:45:49 INFO - PROCESS | 1682 | Values: 93.0 88.0 88.0 86.0 89.0 85.0 88.0 74.0 137.0 89.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:94.00 stddev:19.66 (20.9%) stddev-sans-first:20.64 13:45:49 INFO - PROCESS | 1682 | Values: 95.0 93.0 96.0 94.0 94.0 93.0 124.0 152.0 94.0 94.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:92.50 stddev:22.98 (24.8%) stddev-sans-first:18.24 13:45:49 INFO - PROCESS | 1682 | Values: 149.0 147.0 93.0 91.0 98.0 109.0 93.0 92.0 93.0 91.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:4.15 (6.9%) stddev-sans-first:3.81 13:45:49 INFO - PROCESS | 1682 | Values: 54.0 62.0 60.0 58.0 60.0 62.0 60.0 69.0 59.0 55.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:2.50 (3.7%) stddev-sans-first:2.64 13:45:49 INFO - PROCESS | 1682 | Values: 66.0 63.0 68.0 70.0 71.0 66.0 65.0 65.0 65.0 68.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 13:45:49 INFO - PROCESS | 1682 | Values: 82.0 83.0 84.0 84.0 82.0 85.0 82.0 84.0 82.0 86.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:135.50 stddev:12.19 (9.0%) stddev-sans-first:12.06 13:45:49 INFO - PROCESS | 1682 | Values: 122.0 121.0 125.0 162.0 135.0 136.0 127.0 139.0 143.0 135.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:174.00 stddev:19.92 (11.5%) stddev-sans-first:19.40 13:45:49 INFO - PROCESS | 1682 | Values: 137.0 133.0 174.0 179.0 174.0 135.0 143.0 175.0 180.0 165.0 13:45:49 INFO - PROCESS | 1682 | 13:45:49 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 13:45:49 INFO - PROCESS | 1682 | Values: 66.0 68.0 67.0 67.0 69.0 64.0 66.0 66.0 67.0 65.0 13:45:49 INFO - PROCESS | 1682 | -------- Summary: end -------- 13:45:49 INFO - PROCESS | 1682 | 13:45:50 INFO - TEST-INFO | 1682: exit 0 13:45:50 INFO - TEST-OK | kraken | took 57898ms 13:45:50 INFO - SUITE-END | took 1168s 13:45:50 INFO - Completed test suite (00:19:28) 13:45:50 INFO - javascript benchmark 13:45:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3477.269773347597, 3518.630543792902, 3535.71714262859, 3566.1262990567316, 3578.2306804037125, 5719.914201286984, 5748.688483637272, 5756.0, 5782.76868925243, 5789.507891829199, 5715.457031581993, 5719.914201286973, 5750.942490575093, 5782.248307720001, 5783.045797443428, 5185.299984502091, 5219.478052194788, 5282.128448805943, 5300.09898317285, 5309.362876454811, 5186.766595503193, 5268.4994925482015, 5275.393329767068, 5301.363836339645, 5329.22726204702, 3742.8128593570214, 4334.674899382543, 5286.497782710637, 5296.735163241842, 5299.894002119974, 4467.419235499397, 5237.292965449654, 5277.8944421111555, 5309.097453432906, 5349.090654588729, 4267.978660106711, 5154.664946778447, 5262.131748261532, 5274.947250527523, 5340.706261155635, 4630.398048253739, 5459.989901868167, 5691.8292451226525, 5709.571782116358, 5711.600187986843, 6197.504199664016, 6257.8748425031245, 6262.561620686553, 6305.432511073979, 6319.304876463585, 6186.041163619601, 6194.752209911598, 6282.0, 6286.339934306923, 6292.150559674431, 5908.320543137551, 5910.320313163998, 5933.199018132583, 5936.436038576328, 5971.164037034819, 6298.7795427160745, 6311.715972781236, 6329.968350158312, 6347.968260158762, 6509.707063182168, 6095.359987201368, 6127.433875357673, 6190.690465476709, 6229.065640153923, 6251.3123556408755, 5630.873825234969, 6272.341404152498, 6290.930541807904, 6294.590851594632, 6302.936970630327, 5899.262592175978, 6185.978913932719, 6245.812625621239, 6267.091271765568, 6279.058141278753, 6169.074638804125, 6184.196054512884, 6201.131841542187, 6236.338493107913, 6333.65164915934, 4211.368294755811, 4906.067847109038, 4930.778114984834, 4982.526659967298, 4990.201567749215, 3847.480590120354, 4462.821487140478, 4485.304777759387, 4492.640588752892, 4506.752128632957, 5699.800506982236, 5707.629004114802, 5822.33043200029, 5848.766049358063, 5935.465808077293, 6195.31851496335, 6263.655498947511, 6265.060240963892, 6272.435480806749, 6283.560150789401, 5833.504152147115, 5883.588148829541, 5889.204957330791, 5900.380460051719, 5901.58688891782, 5310.150375939908, 5434.0, 5471.5896307777075, 5483.561315094783, 5535.861603459945, 6348.936510634927, 6349.746010159542, 6363.872722545616, 6384.0, 6397.488200943913, 6221.906671400023, 6263.217097862767, 6272.466840318624, 6281.214848143982, 6283.842903927439, 6267.905981410374, 6338.176037115146, 6390.840228994312, 6421.1010458536775, 6432.13166222554, 6239.937600623935, 6279.215098112736, 6280.152179455715, 6299.685015749286, 6305.684715764285, 6206.906896396467, 6273.592216505913, 6291.213598300213, 6300.338464461165, 6319.304876463677, 6134.5705800595315, 6152.723127459186, 6170.444659980623, 6209.410106039919, 6213.409726076015, 5973.398306438714, 6172.938270617236, 6205.6586887721605, 6212.06818977157, 6215.160953271431, 5744.626599271034, 5993.670348130895, 6091.939080609137, 6117.908231376622, 6139.324674285915, 6157.32269450369, 6203.379662033761, 6213.689315534115, 6213.96893015532, 6215.34738852414, 6068.726907289094, 6083.7870674526175, 6087.269527656709, 6093.725782339894, 6115.938840611715], "unit": "score", "name": "dojo.html", "value": 5722.553194820194}, {"lowerIsBetter": false, "replicates": [490.7006725897202, 491.8278602489127, 636.214275369918, 674.7618120748426, 680.2177495879739, 30957.535636965462, 39078.60921390793, 39098.609013909925, 39198.41202381963, 39307.80346098273, 40352.0, 40901.18197636046, 40943.18113637726, 40963.79518102413, 41164.79417602915, 9576.233901287898, 9803.705888823346, 9825.606975720963, 9844.212463002943, 9863.506824658774, 9615.326927115104, 9760.707178784647, 9761.0, 9774.90225097747, 9786.461744604045, 8206.630701618411, 9751.609935602568, 9762.609495620167, 9771.120599146076, 9783.46190959497, 9716.417014979088, 9777.315587908884, 9779.022097790235, 9795.608175672964, 9841.065098815601, 9624.663136790248, 9663.951680241555, 9669.661561845372, 9697.90302096977, 9712.61149554024, 27322.863385682944, 32623.51064734031, 39579.40630890539, 39677.0, 39774.40338394926, 3126.812391256532, 3335.5997280326274, 3338.6160591532043, 3480.269143479872, 3502.1419752160627, 26518.60222096651, 26682.33294167642, 27873.860630696716, 28031.719682803116, 28387.858060709772, 2198.791114844103, 2620.620010098525, 2623.3835048763526, 2635.288472112519, 2733.7949653776045, 437533.0, 439172.0, 440195.0, 440741.9999999968, 442246.0, 47669.0, 47715.76142119267, 63403.0, 65972.01041984375, 66170.66914665492, 46508.5349146511, 47004.0, 47208.0, 47390.341338053695, 47392.763036184595, 16894.0, 17037.659246814994, 17071.573210669583, 17074.0, 17109.743353849703, 13346.265955372548, 13435.731285374237, 13443.932780336036, 13484.730305393838, 13515.662108447368, 15043.323050462755, 15059.021163624548, 15363.462278820187, 15442.382304707686, 15556.299966501534, 6527.184101987252, 6658.667066646648, 6660.70026848793, 6679.799606011828, 6691.698873550702, 997.897323457569, 1042.3485321673954, 1059.613241166984, 1121.7476067884825, 1159.6231224851956, 29784.553231701542, 30021.099367019026, 30504.0, 30690.77236910543, 30781.846090769403, 1117.435694974049, 1154.5901205072078, 1164.9631827673377, 1207.589419597341, 1293.5666551705096, 14529.78205326921, 15021.324040417989, 15239.771403428957, 16355.018698878106, 16697.0, 615663.0, 680492.597537019, 685177.0, 692082.0, 694516.0548394553, 63980.72038559296, 64055.6797216011, 64266.35733642604, 65043.34956650467, 65288.0, 1487.5091219897624, 1515.9166245856584, 1517.332373755566, 1523.6876440329706, 1640.1635166065155, 30390.0, 30677.525144287087, 30867.228319292197, 31261.905833295725, 31298.0, 47013.294800578704, 49316.75341623269, 52109.47890521046, 52449.47550524446, 52871.47128528666, 440802.0, 442339.0, 447282.0, 514673.0, 514978.0, 28566.571501427912, 33252.83373583117, 33919.0, 34063.31873362568, 34465.82767086149, 44798.328025079, 44806.87982800456, 46279.0, 46393.53606463892, 46429.767851160526, 31147.0, 36561.45157822582, 37051.444228336055, 37543.81228093951, 38276.23447530978, 36015.0, 37077.81461092677, 37173.442398363506, 37194.44208336823, 37357.43963840599, 27532.0, 36716.082097947765, 37042.444363334034, 37606.81196594109, 38574.42138367983, 32102.839485802422, 32532.51201231936, 34208.486872697424, 34784.82607586946, 35457.0, 24174.274771756875, 24640.340538954697, 24731.876340618182, 24827.87586062058, 24901.750982489943], "unit": "score", "name": "ext.html", "value": 19595.030408219875}, {"lowerIsBetter": false, "replicates": [363.25895173845356, 384.139527458493, 386.688715583955, 386.9864554740583, 386.9903252418691, 20049.498762530926, 20924.686129708065, 21481.67777483335, 21795.346139615816, 21840.344789656298, 19506.927119008484, 20808.791912080873, 20838.47903802402, 21272.0, 21473.46316342092, 5380.650257733245, 5505.476979686943, 5539.335279766414, 5541.0580201365865, 5559.8888022239535, 4276.208901353244, 6880.483963702717, 6891.758788442406, 6902.240753517109, 6911.377975982161, 5465.262189604412, 6785.6267905265195, 6796.7621133260345, 6824.385805277524, 6840.623765692885, 6005.1892994445625, 6051.425114614105, 6062.484688801457, 6066.393360663942, 6082.300535438415, 5714.257146570961, 5718.456746609066, 5757.021306377926, 5759.913601295984, 5781.364049954502, 25685.3578660535, 25794.484110317877, 25908.481830363286, 26883.19350419471, 26923.86538067297, 2076.678114892194, 2267.1498188179435, 2403.42317843718, 2590.0805214148895, 2792.902248421316, 9868.95065524675, 10109.39343639384, 10249.948750256275, 10329.741756456073, 10567.841482377771, 1635.2232689472523, 1746.8777185596887, 1777.3246166456793, 1801.7297405389165, 1817.7727784026997, 108264.4586777061, 112602.0, 114442.42778786052, 116524.0, 118619.0, 11404.030657394214, 11563.710907227218, 11570.19008669385, 11634.301941883514, 11820.70448238801, 14346.282685865664, 14362.353694083791, 14363.210023448602, 14401.495947641783, 14401.855981440262, 8701.129887011375, 8987.281017518582, 9056.95844977836, 9092.363534552518, 9105.408148470327, 9201.539923003957, 9229.446233226028, 9236.307276954256, 9299.95350023259, 9317.534123293808, 4490.034642551802, 4580.175568397721, 4598.540145985375, 4610.377599024089, 4653.022865198279, 1937.6027914277822, 1956.9608607827763, 1957.1290775605005, 1982.3656429942569, 1987.3441764217773, 781.6638845296463, 879.9340049496313, 986.1716158426956, 1002.5362970063643, 1050.76883085721, 15237.619059523378, 18454.630907382045, 19876.50308742264, 20480.0, 20628.27801026957, 989.6585677941099, 1012.7620009297809, 1031.159604921986, 1048.119579553179, 1051.4374809476892, 11135.888641113484, 11537.596184133516, 11575.131865109983, 11638.94180529109, 11685.766284674259, 445578.0, 539123.0, 542988.0, 603897.0, 663724.0, 113593.43203284097, 116717.0, 123051.38474307572, 123755.76244237623, 127222.36388817997, 989.8416253399422, 1031.7317497450717, 1034.6947650443137, 1037.1288117980782, 1070.8714954205388, 15724.76412853831, 17984.460466185512, 17985.910070449565, 18246.817531825043, 18307.816921831145, 53327.200091999424, 55783.16325255043, 57494.0, 59843.45280181566, 60207.69896150491, 75489.62255188689, 79920.0, 81383.5930820342, 84403.5779821097, 85466.0, 11932.403379831147, 12217.266963982189, 12371.381430928597, 12399.94600458971, 12485.0, 11079.778404431705, 14033.719325613227, 14042.297885105909, 14161.0, 14693.0, 11750.823737643772, 12123.81814272769, 12146.939265303618, 12200.938995305321, 12255.816162757388, 9769.413835169913, 11809.468573914366, 11954.222975506564, 12178.75642487163, 12186.57346992851, 11891.821622675494, 12247.203931744409, 12301.384930753606, 12314.0, 12486.500539978299, 12039.458224379749, 12062.939685301517, 12175.208611440228, 12206.633800985985, 12294.877051229374, 12173.026157907523, 12229.75540489203, 12232.449539770554, 12250.87749122533, 12385.133040687066], "unit": "score", "name": "jquery.html", "value": 10035.613297111446}, {"lowerIsBetter": false, "replicates": [1654.1233146432392, 1677.958051048724, 2019.6367451969916, 2053.37372101509, 2083.541620843414, 8437.15628437156, 8938.240249578794, 9190.483570210916, 9405.153536181742, 9419.905800941997, 9064.546772661373, 9083.318751093679, 9174.0, 9185.0, 9190.126937940884, 2563.4104156044073, 2572.3697694064886, 2589.9093531726394, 2598.4153565447814, 2602.986985065072, 2512.6859142607173, 2558.8976440942433, 2582.715901250861, 2584.6769153855766, 2594.4811037792515, 2253.278950735765, 2516.32059343977, 2547.681539807524, 2573.137998770414, 2582.2769624505167, 2556.309796354983, 2567.897284108643, 2568.4221050263727, 2593.922182334533, 2597.142942828862, 2295.3458264394567, 2444.4844196598046, 2554.3358726731, 2562.3722188064044, 2596.415806443554, 7654.73208437702, 9172.449653020773, 9276.304277179239, 9284.489353085577, 9335.113164249386, 4669.556392142741, 5845.561582881259, 5891.99836027872, 5895.145203945404, 5901.822945311647, 3571.5178450909057, 3685.207680348738, 3691.8523259069607, 3695.334839728848, 3712.7029837612927, 1039.4542864995863, 1059.9894001059968, 1060.0830281806182, 1065.8188108021654, 1066.5467176450056, 12475.875241247562, 12577.811332830015, 12597.622071337782, 12607.684807879785, 12646.114771965966, 5043.9747801260755, 5088.414832294259, 5146.485351464824, 5159.432462429129, 5215.113430716788, 10666.200034997251, 10781.892181078245, 10819.13446924244, 10827.0, 10852.023317901427, 5745.511631511285, 5798.246227990334, 5830.533557315404, 5847.356790753014, 5880.7353669085, 4666.813327466931, 5067.442581316052, 5147.0735267651435, 5150.922736158961, 5211.42674305826, 4098.016476045727, 4113.568075352105, 4121.155163191538, 4133.21468920904, 4139.710220284612, 1349.2107117336272, 1353.349764732239, 1366.077897419238, 1369.2879702554617, 1377.5109836008073, 1359.0962010263065, 1389.603962870577, 1394.9442022319197, 1439.143709492871, 1450.8259008918997, 8549.914500855037, 8730.301575873915, 8773.903262092239, 8804.735857924272, 8810.207081362709, 1170.6839153428527, 1231.7167051578188, 1267.0497127154633, 1280.9231446113263, 1286.9356532173354, 6350.428461438492, 6411.583247089017, 6439.54923155384, 6485.643289619022, 6486.481081513468, 11209.271397359145, 11383.373914434786, 11436.885631143748, 11566.47950842214, 11627.76744465106, 11118.55525778976, 11158.051565616852, 11343.546258149747, 11440.370779607036, 11440.656780296604, 8760.4305720128, 8870.2460290876, 8909.955450222837, 8944.552772361356, 8999.775005624912, 8132.83734325322, 8227.13615070409, 8248.051474080317, 8296.045954715284, 8348.123447037973, 9976.700698978751, 9983.700488985342, 10125.59497620087, 10156.441395723306, 10203.132733717717, 10191.388516689023, 10322.174226061747, 10549.78900421972, 10581.888901665523, 10603.310784798963, 6557.672116394257, 7113.679884405317, 7591.278828511283, 7785.92214077852, 7838.921610783819, 8543.444676096035, 8580.699675511576, 8604.48373097616, 8642.049374568918, 8700.956495217484, 7470.365018973231, 7637.579933103732, 7661.770146895602, 7672.347850432776, 7785.065792104983, 7507.624618769149, 7569.924300756922, 7615.581143037186, 7700.306972372513, 7725.22747725223, 8105.27052565272, 8135.959320203598, 8183.263506284463, 8203.71287004952, 8208.712695055645, 7253.673584688596, 7321.121465424183, 7372.741954031583, 7376.7049318026675, 7426.368758655575, 7450.0, 7470.2903224193615, 7510.849783004419, 7533.6233188339265, 7543.43424243173], "unit": "score", "name": "mootools.html", "value": 5205.925888110435}, {"lowerIsBetter": false, "replicates": [297.35622377552613, 307.84915391458185, 334.7780600807054, 342.7789076045949, 347.5256275184373, 6964.616946067964, 6987.336203060714, 6997.795694356274, 7002.719891204346, 7014.649267536615, 6928.584284942907, 6936.410405115571, 6937.618430986294, 6979.022936788853, 7001.964990175042, 4573.7713114344315, 4789.640776941744, 4862.586680132193, 5121.308623335858, 5163.896722065547, 4454.933176002362, 4993.776524751423, 5048.242763585455, 5110.540051395374, 5114.769835357418, 5015.498450154992, 5038.269450929613, 5044.82343117991, 5065.468125846788, 5095.541401273885, 4300.290452075404, 4368.453943257093, 4858.174110401223, 5058.696478211301, 5063.18988961768, 3943.152222272225, 4061.431399604058, 4195.958040419618, 4398.098389830077, 4447.755373454459, 6362.1093046973465, 6681.432078273353, 6723.731050757964, 6723.865522689568, 6757.526973111884, 5928.258967629046, 5985.581009329305, 5987.491063259628, 6011.428914253139, 6026.0960855871535, 7429.257074292582, 7453.85092298151, 7470.3650189733935, 7476.551406915548, 7514.0, 4900.191468407708, 4912.189488734354, 4912.680675756064, 4924.359833221694, 4929.704217746947, 7057.541259818096, 7732.7680169595005, 7852.568108754016, 7853.293203611703, 7908.051033875971, 4875.024995001014, 4923.384576927884, 4964.205727083649, 4965.155923493015, 4976.925346119739, 4344.196323680129, 5019.322391477177, 5029.798808047711, 5030.37120359955, 5048.318477005557, 5936.406359364029, 5949.762009519657, 5983.431574000463, 6000.459958603659, 6012.819615411545, 6126.989046807316, 7400.814979625445, 7411.407087432993, 7416.25837416254, 7435.256474352522, 1733.0043696679718, 1733.2113888180847, 1764.7705798246145, 1785.81248968859, 1787.9195436205403, 960.9855852162223, 1145.3414286785132, 1158.44394690549, 1158.8377627132209, 1162.91859569831, 6832.316768323228, 6870.7595234166565, 6901.102856628707, 6905.585664860024, 6911.619860907598, 6520.967395163088, 6940.785362561532, 7706.845863082707, 7715.189905059888, 7734.071911370672, 6859.348361905611, 6870.393043652122, 6877.828054298682, 6903.206131294865, 6913.170419549586, 3687.778733276012, 4047.6357127858046, 4066.268071747114, 4171.624553790173, 4174.227767862894, 7915.802104947423, 7980.561069141253, 8108.270255677017, 8140.674373025131, 8173.18268173178, 7989.162492626612, 8019.879701804478, 8043.075046369742, 8048.0, 8062.234087761771, 8111.594420278962, 8113.432059755761, 8119.9188008120345, 8151.633176506953, 8157.306628936488, 5907.822765317047, 7703.114141873756, 7758.107817601048, 7771.844563108819, 7795.181505941794, 6352.0, 7353.191148973716, 7560.9621951889885, 7624.8475030500185, 7648.426368022309, 6219.968900155471, 7295.708171673074, 7991.920080799117, 8104.392170587347, 8159.755207343789, 4987.10232158215, 5036.521530454601, 5048.318477005557, 5049.974750126373, 5070.492950705047, 6321.652309123042, 7431.777046688608, 7654.004979352649, 7685.154632990479, 7714.884276735966, 7403.925960740539, 7424.628768561658, 7429.294217049372, 7432.92567074344, 7459.515131516434, 7392.002079719384, 7399.704011839682, 7424.10910690699, 7429.0, 7507.099148102263, 6912.0, 7224.060872086595, 7239.420846332386, 7248.818779530554, 7288.708451661874, 7369.0, 7380.889286660812, 7385.113786345673, 7400.444966627417, 7461.515001524884, 7165.283471652793, 7204.135503739375, 7205.495615306878, 7210.315020073084, 7236.167840698387], "unit": "score", "name": "prototype.html", "value": 5384.013936313025}, {"lowerIsBetter": false, "replicates": [724.5145752345929, 750.9061367329084, 774.8411575626995, 775.9573223472706, 778.0663204155015, 14295.641914018177, 15222.086674799506, 15578.844211557882, 15583.987040842338, 15588.922055389707, 14185.929070354634, 14258.71482570348, 14277.571672849805, 14294.78557821631, 14316.427342906298, 765.5789315876274, 948.0235357581685, 953.3469573342283, 954.8901876284247, 976.541025717915, 954.413035982869, 954.4702690007043, 963.8361478548663, 969.0842154164318, 976.1214906584061, 999.1557134221571, 1001.4241810958691, 1006.4263369879171, 1013.4831236069584, 1016.7508960304735, 983.2183414185704, 993.8459538771538, 994.2145704893126, 997.8403455447094, 1006.5722068121056, 747.9027726395589, 750.1373420566392, 758.2493331601675, 758.8482303539259, 761.7372006657749, 15313.923430382776, 15640.608984775357, 15669.981451205635, 15728.60678483047, 15756.684866302725, 13154.934225328907, 13180.86819131806, 13289.269090200036, 13300.80292773655, 13353.065285430024, 10146.753039027513, 10194.0, 10212.897871021269, 10364.481775911174, 10433.0, 3523.8942831714835, 3549.239591124408, 3551.5738111426795, 3625.909352266188, 3791.905202369935, 75247.62376188084, 75497.62251188763, 75734.48531029349, 76641.23358766397, 76654.23345766526, 9712.562934667956, 9744.0, 9787.608495660093, 9872.160866326443, 9916.603335866628, 22303.219387321366, 22466.663000055014, 22510.549789004457, 22512.212072577382, 22564.548709025727, 7528.171901090986, 7543.358814500719, 7591.772246832604, 7596.886046709304, 7663.463557550918, 4097.385392191195, 4128.876133715993, 4165.062860856344, 4216.177845320194, 4275.700700950966, 3619.76471529355, 3643.4899114124046, 3676.889693309205, 3676.988828072248, 3681.7606855554304, 652.4291245160484, 656.9292053952028, 666.3769375633798, 675.1864003875319, 692.9861402771917, 492.07735495945104, 497.4105684763567, 602.6354055796268, 609.9908501372483, 622.6762083716442, 6944.4444444444325, 7988.0, 8425.199606037417, 8451.704190353432, 8492.0, 540.2166858055834, 589.4783116941537, 608.3490664988508, 610.2402508876477, 614.5575185866259, 3719.34911390511, 3852.9614703853163, 3991.401289806552, 4035.124191935673, 4049.250888585621, 99406.00593993967, 101955.0, 102535.4873225644, 102731.97268027374, 102778.0, 81663.0, 82038.35923281501, 82172.0, 82435.05389676639, 84415.57792211, 61637.69181154066, 72530.63734681398, 72681.63659181776, 73829.0, 73847.63076184585, 7806.4925779824125, 8009.799755006172, 8013.719519817012, 8019.5990200490905, 8165.2243036911395, 51220.74389628177, 51557.71105722387, 51651.0, 52421.0, 53352.93294134173, 48639.75680121718, 66405.33594663991, 71486.28513714796, 71794.0, 72385.27614723996, 10310.536025879004, 10441.112505436819, 10494.52774625159, 10602.25784195099, 10711.785764284827, 10875.945620271848, 11103.833442498208, 11312.6040588579, 11351.659450216506, 11928.926396624345, 10207.89792102099, 10261.179105671677, 10268.332558383681, 10505.68482945513, 11207.71980700489, 10411.739706507398, 10437.843432348673, 10480.213983951082, 10665.786684266426, 11272.774544509228, 10173.898261017592, 10228.335158214692, 10372.740681483023, 10502.737431564272, 11172.888271117185, 8894.644214231359, 8957.507337096262, 8958.820823583623, 9135.680251191176, 9231.615257711397, 8679.696210632597, 8908.420952638058, 9063.821703178544, 9149.496777677025, 9178.128077832594], "unit": "score", "name": "yui.html", "value": 6964.243590051077}], "name": "dromaeo_css", "value": 7767.8056947247505}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 112.0, 117.0, 116.0, 116.0, 130.0, 114.0, 115.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.8}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 181.0, 155.0, 119.0, 137.0, 140.0, 121.0, 161.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [196.0, 255.0, 210.0, 282.0, 200.0, 279.0, 241.0, 247.0, 257.0, 193.0], "unit": "score", "name": "audio-dft", "value": 236.0}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 71.0, 110.0, 58.0, 67.0, 72.0, 51.0, 149.0, 51.0], "unit": "score", "name": "audio-fft", "value": 77.0}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 120.0, 96.0, 114.0, 123.0, 152.0, 121.0, 67.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [93.0, 88.0, 88.0, 86.0, 89.0, 85.0, 88.0, 74.0, 137.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.7}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 96.0, 94.0, 94.0, 93.0, 124.0, 152.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 102.9}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 93.0, 91.0, 98.0, 109.0, 93.0, 92.0, 93.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 105.6}, {"lowerIsBetter": true, "replicates": [54.0, 62.0, 60.0, 58.0, 60.0, 62.0, 60.0, 69.0, 59.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 68.0, 70.0, 71.0, 66.0, 65.0, 65.0, 65.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 84.0, 82.0, 85.0, 82.0, 84.0, 82.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [122.0, 121.0, 125.0, 162.0, 135.0, 136.0, 127.0, 139.0, 143.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.5}, {"lowerIsBetter": true, "replicates": [137.0, 133.0, 174.0, 179.0, 174.0, 135.0, 143.0, 175.0, 180.0, 165.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.5}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 69.0, 64.0, 66.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1554.2000000000003}]} 13:45:50 INFO - Return code: 0 13:45:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:45:50 ERROR - # TBPL SUCCESS # 13:45:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:45:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:45:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:45:50 INFO - 2016-04-14 13:45:50.848 screenresolution[1687:10666] starting screenresolution argv=screenresolution get 13:45:50 INFO - 2016-04-14 13:45:50.851 screenresolution[1687:10666] Display 0: 1600x1200x32@60 13:45:50 INFO - 2016-04-14 13:45:50.857 screenresolution[1688:10669] starting screenresolution argv=screenresolution list 13:45:50 INFO - Available Modes on Display 0 13:45:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:45:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:45:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:45:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:45:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:45:51 INFO - Intel Iris: 13:45:51 INFO - Chipset Model: Intel Iris 13:45:51 INFO - Type: GPU 13:45:51 INFO - Bus: Built-In 13:45:51 INFO - VRAM (Dynamic, Max): 1536 MB 13:45:51 INFO - Vendor: Intel (0x8086) 13:45:51 INFO - Device ID: 0x0a2e 13:45:51 INFO - Revision ID: 0x0009 13:45:51 INFO - Displays: 13:45:51 INFO - Display: 13:45:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:45:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:45:51 INFO - Display Serial Number: 1600x1200 60 13:45:51 INFO - Main Display: Yes 13:45:51 INFO - Mirror: Off 13:45:51 INFO - Online: Yes 13:45:51 INFO - Rotation: Supported 13:45:51 INFO - Return code: 0 13:45:51 INFO - Running post-action listener: _resource_record_post_action 13:45:51 INFO - Running post-run listener: _resource_record_post_run 13:45:52 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37701120; Write bytes: 666756096; Read time: 395; Write time: 2058 13:45:52 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354275840; Write bytes: 352949760; Read time: 28080; Write time: 642 13:45:52 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36746752; Write bytes: 303468032; Read time: 381; Write time: 1326 13:45:52 INFO - Running post-run listener: _upload_blobber_files 13:45:52 INFO - Blob upload gear active. 13:45:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:45:52 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 13:45:52 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'] 13:45:52 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 13:45:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:45:53 INFO - (blobuploader) - INFO - Done attempting. 13:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:45:54 INFO - (blobuploader) - INFO - Done attempting. 13:45:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:45:54 INFO - Return code: 0 13:45:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:45:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:45:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84cb5742ca34fa30eeac452f336fb845b49fee6cc1813eb1ae447c1dbef69152722af20c3b795b8d50b693a2a28f162801120f0bb091206ed4b8f56fe20a0061", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cb9dbfcc1b6f0f0df26572b16b8b3ea42711bb964b88798716479a6f6316a5b16ab5aea1bc5bdf2dd0c366278dc3dbf02f0cf7d014fdd14a1718c63abf41e79"} 13:45:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:45:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:45:54 INFO - Contents: 13:45:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84cb5742ca34fa30eeac452f336fb845b49fee6cc1813eb1ae447c1dbef69152722af20c3b795b8d50b693a2a28f162801120f0bb091206ed4b8f56fe20a0061", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cb9dbfcc1b6f0f0df26572b16b8b3ea42711bb964b88798716479a6f6316a5b16ab5aea1bc5bdf2dd0c366278dc3dbf02f0cf7d014fdd14a1718c63abf41e79"} 13:45:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:45:54 INFO - Copying logs to upload dir... 13:45:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:45:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.419598 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-14 13:45:54.518670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 13:45:54.522494) ========= 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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/84cb5742ca34fa30eeac452f336fb845b49fee6cc1813eb1ae447c1dbef69152722af20c3b795b8d50b693a2a28f162801120f0bb091206ed4b8f56fe20a0061", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cb9dbfcc1b6f0f0df26572b16b8b3ea42711bb964b88798716479a6f6316a5b16ab5aea1bc5bdf2dd0c366278dc3dbf02f0cf7d014fdd14a1718c63abf41e79"} build_url:https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/GkC0f0uFR4Cnh7_rH2T1bQ/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/84cb5742ca34fa30eeac452f336fb845b49fee6cc1813eb1ae447c1dbef69152722af20c3b795b8d50b693a2a28f162801120f0bb091206ed4b8f56fe20a0061", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cb9dbfcc1b6f0f0df26572b16b8b3ea42711bb964b88798716479a6f6316a5b16ab5aea1bc5bdf2dd0c366278dc3dbf02f0cf7d014fdd14a1718c63abf41e79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 13:45:54.552306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:45:54.553025) ========= 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.g3EGYRfK0i/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.ej1pgQnaHD/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005218 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:45:54.606305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 13:45:54.607041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 13:45:54.607916) ========= ========= Total master_lag: 3.32 =========