builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0067 starttime: 1464621979.51 results: success (0) buildid: 20160530063038 builduid: d5106b02fbd2489aaefed5c209190034 revision: 3435dd7ad71fe9003bdeee18fd38d815e033beef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.508256) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.508734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.509040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.529416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.529691) ========= 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.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-30 08:26:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.33M=0.001s 2016-05-30 08:26:19 (8.33 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:19.670273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-30 08:26:19.670589) ========= 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.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.020331 ========= master_lag: 2.51 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-05-30 08:26:22.199914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.200275) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3435dd7ad71fe9003bdeee18fd38d815e033beef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3435dd7ad71fe9003bdeee18fd38d815e033beef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-30 08:26:22,267 truncating revision to first 12 chars 2016-05-30 08:26:22,267 Setting DEBUG logging. 2016-05-30 08:26:22,267 attempt 1/10 2016-05-30 08:26:22,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3435dd7ad71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 08:26:22,627 unpacking tar archive at: mozilla-central-3435dd7ad71f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.859362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.859681) ========= script_repo_revision: 3435dd7ad71fe9003bdeee18fd38d815e033beef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.860093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.860370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:26:22.876354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-30 08:26:22.876634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:23 INFO - MultiFileLogger online at 20160530 08:26:23 in /builds/slave/test 08:26:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:26:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:23 INFO - {'append_to_log': False, 08:26:23 INFO - 'base_work_dir': '/builds/slave/test', 08:26:23 INFO - 'blob_upload_branch': 'Firefox', 08:26:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:23 INFO - 'branch': 'Firefox', 08:26:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:23 INFO - 'config_files': ('talos/mac_config.py',), 08:26:23 INFO - 'default_actions': ('clobber', 08:26:23 INFO - 'read-buildbot-config', 08:26:23 INFO - 'download-and-extract', 08:26:23 INFO - 'populate-webroot', 08:26:23 INFO - 'create-virtualenv', 08:26:23 INFO - 'install', 08:26:23 INFO - 'run-tests'), 08:26:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:23 INFO - 'download_minidump_stackwalk': True, 08:26:23 INFO - 'download_symbols': 'ondemand', 08:26:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:23 INFO - 'installer_path': 'installer.exe', 08:26:23 INFO - 'log_level': 'info', 08:26:23 INFO - 'log_name': 'talos', 08:26:23 INFO - 'log_to_console': True, 08:26:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:26:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:26:23 INFO - 'opt_config_files': (), 08:26:23 INFO - 'pip_index': False, 08:26:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:23 INFO - 'cmd': ('bash', 08:26:23 INFO - '-c', 08:26:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:23 INFO - 'enabled': True, 08:26:23 INFO - 'halt_on_failure': False, 08:26:23 INFO - 'name': 'check_screen_resolution'},), 08:26:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:23 INFO - 'cmd': ('bash', 08:26:23 INFO - '-c', 08:26:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:23 INFO - 'enabled': True, 08:26:23 INFO - 'halt_on_failure': False, 08:26:23 INFO - 'name': 'check_screen_resolution'},), 08:26:23 INFO - 'run_cmd_checks_enabled': True, 08:26:23 INFO - 'sps_profile': False, 08:26:23 INFO - 'sps_profile_interval': 0, 08:26:23 INFO - 'suite': 'dromaeojs-e10s', 08:26:23 INFO - 'system_bits': '32', 08:26:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:23 INFO - 'title': 't-yosemite-r7-0067', 08:26:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:23 INFO - 'use_talos_json': True, 08:26:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:23 INFO - 'work_dir': 'build'} 08:26:23 INFO - ##### 08:26:23 INFO - ##### Running clobber step. 08:26:23 INFO - ##### 08:26:23 INFO - Running pre-action listener: _resource_record_pre_action 08:26:23 INFO - Running main action method: clobber 08:26:23 INFO - rmtree: /builds/slave/test/build 08:26:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:24 INFO - Running post-action listener: _resource_record_post_action 08:26:24 INFO - ##### 08:26:24 INFO - ##### Finished clobber step (success) 08:26:24 INFO - ##### 08:26:24 INFO - ##### 08:26:24 INFO - ##### Running read-buildbot-config step. 08:26:24 INFO - ##### 08:26:24 INFO - Running pre-action listener: _resource_record_pre_action 08:26:24 INFO - Running main action method: read_buildbot_config 08:26:24 INFO - Using buildbot properties: 08:26:24 INFO - { 08:26:24 INFO - "project": "", 08:26:24 INFO - "product": "firefox", 08:26:24 INFO - "script_repo_revision": "production", 08:26:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:26:24 INFO - "repository": "", 08:26:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:26:24 INFO - "buildid": "20160530063038", 08:26:24 INFO - "pgo_build": "False", 08:26:24 INFO - "basedir": "/builds/slave/test", 08:26:24 INFO - "buildnumber": 287, 08:26:24 INFO - "slavename": "t-yosemite-r7-0067", 08:26:24 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:26:24 INFO - "platform": "yosemite_r7", 08:26:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:26:24 INFO - "branch": "mozilla-central", 08:26:24 INFO - "repo_path": "mozilla-central", 08:26:24 INFO - "revision": "3435dd7ad71fe9003bdeee18fd38d815e033beef", 08:26:24 INFO - "stage_platform": "macosx64", 08:26:24 INFO - "builduid": "d5106b02fbd2489aaefed5c209190034", 08:26:24 INFO - "slavebuilddir": "test" 08:26:24 INFO - } 08:26:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 08:26:24 INFO - Running post-action listener: _resource_record_post_action 08:26:24 INFO - ##### 08:26:24 INFO - ##### Finished read-buildbot-config step (success) 08:26:24 INFO - ##### 08:26:24 INFO - ##### 08:26:24 INFO - ##### Running download-and-extract step. 08:26:24 INFO - ##### 08:26:24 INFO - Running pre-action listener: _resource_record_pre_action 08:26:24 INFO - Running main action method: download_and_extract 08:26:24 INFO - mkdir: /builds/slave/test/build/tests 08:26:24 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')]} 08:26:24 INFO - https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 08:26:25 INFO - Downloaded 1199 bytes. 08:26:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:26:25 INFO - Using the following test package requirements: 08:26:25 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:26:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 08:26:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 08:26:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'jsshell-mac.zip'], 08:26:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 08:26:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:26:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 08:26:25 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 08:26:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 08:26:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:26:25 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 08:26:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:25 INFO - https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:26:26 INFO - Downloaded 18684199 bytes. 08:26:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:26:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:26:29 INFO - Return code: 0 08:26:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:29 INFO - https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:26:31 INFO - Downloaded 18684199 bytes. 08:26:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:26:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:26:34 INFO - Return code: 0 08:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:34 INFO - https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:26:36 INFO - Downloaded 10834055 bytes. 08:26:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:26:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:26:36 INFO - Return code: 0 08:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:36 INFO - https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 08:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 08:26:39 INFO - Downloaded 110900553 bytes. 08:26:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:26:39 INFO - mkdir: /builds/slave/test/properties 08:26:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:39 INFO - Contents: 08:26:39 INFO - build_url:https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:26:40 INFO - Running post-action listener: _resource_record_post_action 08:26:40 INFO - Running post-action listener: set_extra_try_arguments 08:26:40 INFO - ##### 08:26:40 INFO - ##### Finished download-and-extract step (success) 08:26:40 INFO - ##### 08:26:40 INFO - ##### 08:26:40 INFO - ##### Running populate-webroot step. 08:26:40 INFO - ##### 08:26:40 INFO - Running pre-action listener: _resource_record_pre_action 08:26:40 INFO - Running main action method: populate_webroot 08:26:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:40 INFO - '--tppagecycles', 08:26:40 INFO - '7'], 08:26:40 INFO - 'tests': ['tsvgm']}}, 08:26:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['damp', 'tps']}, 08:26:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['damp', 'tps']}, 08:26:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['dromaeo_dom']}, 08:26:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['a11yr', 08:26:40 INFO - 'ts_paint', 08:26:40 INFO - 'tpaint', 08:26:40 INFO - 'sessionrestore', 08:26:40 INFO - 'sessionrestore_no_auto_restore', 08:26:40 INFO - 'tabpaint']}, 08:26:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tsvgx', 08:26:40 INFO - 'tsvgr_opacity', 08:26:40 INFO - 'tart', 08:26:40 INFO - 'tscrollx', 08:26:40 INFO - 'cart']}, 08:26:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:40 INFO - 'tsvgr_opacity', 08:26:40 INFO - 'tart', 08:26:40 INFO - 'tscrollx', 08:26:40 INFO - 'cart']}, 08:26:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s'], 08:26:40 INFO - 'tests': ['tp5o']}, 08:26:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'tests': ['tp5o']}, 08:26:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--disable-e10s', 08:26:40 INFO - '--xperf_path', 08:26:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:40 INFO - 'tests': ['tp5n']}, 08:26:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:40 INFO - 'talos_options': ['--xperf_path', 08:26:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:40 INFO - 'tests': ['tp5n']}}, 08:26:40 INFO - 'talos.zip': {'path': '', 08:26:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:40 INFO - Running post-action listener: _resource_record_post_action 08:26:40 INFO - ##### 08:26:40 INFO - ##### Finished populate-webroot step (success) 08:26:40 INFO - ##### 08:26:40 INFO - ##### 08:26:40 INFO - ##### Running create-virtualenv step. 08:26:40 INFO - ##### 08:26:40 INFO - Running pre-action listener: _resource_record_pre_action 08:26:40 INFO - Running main action method: create_virtualenv 08:26:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:40 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 08:26:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:40 INFO - Using real prefix '/tools/python27' 08:26:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:44 INFO - Installing pip.................done. 08:26:44 INFO - Return code: 0 08:26:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:44 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 08:26:44 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 08:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:44 INFO - 'HOME': '/Users/cltbld', 08:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PAGER': '/bin/cat', 08:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:26:44 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - 'XPC_FLAGS': '0x0', 08:26:44 INFO - 'XPC_SERVICE_NAME': '0', 08:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:44 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 08:26:44 INFO - Cleaning up... 08:26:44 INFO - Return code: 0 08:26:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:44 INFO - 'HOME': '/Users/cltbld', 08:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PAGER': '/bin/cat', 08:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:26:44 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - 'XPC_FLAGS': '0x0', 08:26:44 INFO - 'XPC_SERVICE_NAME': '0', 08:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:44 INFO - Downloading/unpacking psutil>=3.1.1 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:47 INFO - Installing collected packages: psutil 08:26:47 INFO - Running setup.py install for psutil 08:26:47 INFO - building 'psutil._psutil_osx' extension 08:26:47 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 08:26:48 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 08:26:48 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 08:26:48 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 08:26:48 INFO - building 'psutil._psutil_posix' extension 08:26:48 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 08:26:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:26:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:26:48 INFO - ^ 08:26:48 INFO - 1 warning generated. 08:26:48 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 08:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:48 INFO - Successfully installed psutil 08:26:48 INFO - Cleaning up... 08:26:48 INFO - Return code: 0 08:26:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:48 INFO - 'HOME': '/Users/cltbld', 08:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:48 INFO - 'LOGNAME': 'cltbld', 08:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:48 INFO - 'MOZ_NO_REMOTE': '1', 08:26:48 INFO - 'NO_EM_RESTART': '1', 08:26:48 INFO - 'PAGER': '/bin/cat', 08:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:48 INFO - 'PWD': '/builds/slave/test', 08:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:48 INFO - 'SHELL': '/bin/bash', 08:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:26:48 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:48 INFO - 'USER': 'cltbld', 08:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:48 INFO - 'XPC_FLAGS': '0x0', 08:26:48 INFO - 'XPC_SERVICE_NAME': '0', 08:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:49 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 08:26:49 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 08:26:49 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 08:26:49 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 08:26:49 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 08:26:49 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 08:26:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:51 INFO - Installing collected packages: mozsystemmonitor 08:26:51 INFO - Running setup.py install for mozsystemmonitor 08:26:51 INFO - Successfully installed mozsystemmonitor 08:26:51 INFO - Cleaning up... 08:26:51 INFO - Return code: 0 08:26:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:51 INFO - 'HOME': '/Users/cltbld', 08:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:51 INFO - 'LOGNAME': 'cltbld', 08:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:51 INFO - 'MOZ_NO_REMOTE': '1', 08:26:51 INFO - 'NO_EM_RESTART': '1', 08:26:51 INFO - 'PAGER': '/bin/cat', 08:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:51 INFO - 'PWD': '/builds/slave/test', 08:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:51 INFO - 'SHELL': '/bin/bash', 08:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:26:51 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:51 INFO - 'USER': 'cltbld', 08:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:51 INFO - 'XPC_FLAGS': '0x0', 08:26:51 INFO - 'XPC_SERVICE_NAME': '0', 08:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:55 INFO - Downloading docopt-0.6.1.tar.gz 08:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:55 INFO - Running setup.py install for blobuploader 08:26:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:55 INFO - Running setup.py install for requests 08:26:56 INFO - Running setup.py install for docopt 08:26:56 INFO - Successfully installed blobuploader requests docopt 08:26:56 INFO - Cleaning up... 08:26:56 INFO - Return code: 0 08:26:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:56 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')]} 08:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 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')]} 08:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:56 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:26:56 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 08:26:56 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 08:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:56 INFO - 'HOME': '/Users/cltbld', 08:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:56 INFO - 'LOGNAME': 'cltbld', 08:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:56 INFO - 'MOZ_NO_REMOTE': '1', 08:26:56 INFO - 'NO_EM_RESTART': '1', 08:26:56 INFO - 'PAGER': '/bin/cat', 08:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:56 INFO - 'PWD': '/builds/slave/test', 08:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:56 INFO - 'SHELL': '/bin/bash', 08:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:26:56 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:56 INFO - 'USER': 'cltbld', 08:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:56 INFO - 'XPC_FLAGS': '0x0', 08:26:56 INFO - 'XPC_SERVICE_NAME': '0', 08:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-s4KayP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:56 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-y716sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-tiIy7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-NNCmGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-YSUFJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-pd6LaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-CugQvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-KeKAHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-3grEvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Q5sIA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-dutgeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:57 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-xJZZGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:58 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-FsLZPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:58 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-9AsZlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:58 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-RPzFnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:58 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zTJChS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:58 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-5Ki518-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:58 INFO - Running setup.py install for manifestparser 08:26:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozcrash 08:26:58 INFO - Running setup.py install for mozdebug 08:26:58 INFO - Running setup.py install for mozdevice 08:26:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozfile 08:26:59 INFO - Running setup.py install for mozhttpd 08:26:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozinfo 08:26:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozInstall 08:26:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Running setup.py install for mozleak 08:26:59 INFO - Running setup.py install for mozlog 08:27:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Running setup.py install for moznetwork 08:27:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Running setup.py install for mozprocess 08:27:00 INFO - Running setup.py install for mozprofile 08:27:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Running setup.py install for mozrunner 08:27:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:00 INFO - Running setup.py install for mozscreenshot 08:27:00 INFO - Running setup.py install for moztest 08:27:00 INFO - Running setup.py install for mozversion 08:27:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:01 INFO - Cleaning up... 08:27:01 INFO - Return code: 0 08:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:01 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')]} 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 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')]} 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:01 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:27:01 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 08:27:01 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 08:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:01 INFO - 'HOME': '/Users/cltbld', 08:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:01 INFO - 'LOGNAME': 'cltbld', 08:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:01 INFO - 'MOZ_NO_REMOTE': '1', 08:27:01 INFO - 'NO_EM_RESTART': '1', 08:27:01 INFO - 'PAGER': '/bin/cat', 08:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:01 INFO - 'PWD': '/builds/slave/test', 08:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:01 INFO - 'SHELL': '/bin/bash', 08:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:27:01 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:01 INFO - 'USER': 'cltbld', 08:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:01 INFO - 'XPC_FLAGS': '0x0', 08:27:01 INFO - 'XPC_SERVICE_NAME': '0', 08:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-lCuqI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-Jv27fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-XaHds3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-kjY_BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-lcVMY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:01 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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:01 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-yv4dAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-erWqun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-J5fAPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-vjba0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-_LYuoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-W0TUU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ZtSwpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-SDms8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-dl91Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-S3aKZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:02 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)) 08:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:02 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-bK2QfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:03 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)) 08:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:03 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ilofmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:03 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)) 08:27:03 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)) 08:27:03 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)) 08:27:03 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)) 08:27:03 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)) 08:27:03 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)) 08:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:03 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 08:27:05 INFO - Downloading blessings-1.6.tar.gz 08:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:05 INFO - Installing collected packages: blessings 08:27:05 INFO - Running setup.py install for blessings 08:27:05 INFO - Successfully installed blessings 08:27:05 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:06 INFO - Reading from file tmpfile_stdout 08:27:06 INFO - Current package versions: 08:27:06 INFO - blessings == 1.6 08:27:06 INFO - blobuploader == 1.2.4 08:27:06 INFO - docopt == 0.6.1 08:27:06 INFO - manifestparser == 1.1 08:27:06 INFO - mozInstall == 1.12 08:27:06 INFO - mozcrash == 0.17 08:27:06 INFO - mozdebug == 0.1 08:27:06 INFO - mozdevice == 0.48 08:27:06 INFO - mozfile == 1.2 08:27:06 INFO - mozhttpd == 0.7 08:27:06 INFO - mozinfo == 0.9 08:27:06 INFO - mozleak == 0.1 08:27:06 INFO - mozlog == 3.2 08:27:06 INFO - moznetwork == 0.27 08:27:06 INFO - mozprocess == 0.22 08:27:06 INFO - mozprofile == 0.28 08:27:06 INFO - mozrunner == 6.11 08:27:06 INFO - mozscreenshot == 0.1 08:27:06 INFO - mozsystemmonitor == 0.3 08:27:06 INFO - moztest == 0.7 08:27:06 INFO - mozversion == 1.4 08:27:06 INFO - psutil == 3.1.1 08:27:06 INFO - requests == 1.2.3 08:27:06 INFO - wsgiref == 0.1.2 08:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27: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')]} 08:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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')]} 08:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:27:06 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 08:27:06 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 08:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:06 INFO - 'HOME': '/Users/cltbld', 08:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:06 INFO - 'LOGNAME': 'cltbld', 08:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:06 INFO - 'MOZ_NO_REMOTE': '1', 08:27:06 INFO - 'NO_EM_RESTART': '1', 08:27:06 INFO - 'PAGER': '/bin/cat', 08:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:06 INFO - 'PWD': '/builds/slave/test', 08:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:06 INFO - 'SHELL': '/bin/bash', 08:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:27:06 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:06 INFO - 'USER': 'cltbld', 08:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:06 INFO - 'XPC_FLAGS': '0x0', 08:27:06 INFO - 'XPC_SERVICE_NAME': '0', 08:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 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)) 08:27:06 INFO - Cleaning up... 08:27:06 INFO - Return code: 0 08:27:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27: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')]} 08:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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')]} 08:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:06 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:27:06 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 08:27:06 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 08:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:06 INFO - 'HOME': '/Users/cltbld', 08:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:06 INFO - 'LOGNAME': 'cltbld', 08:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:06 INFO - 'MOZ_NO_REMOTE': '1', 08:27:06 INFO - 'NO_EM_RESTART': '1', 08:27:06 INFO - 'PAGER': '/bin/cat', 08:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:06 INFO - 'PWD': '/builds/slave/test', 08:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:06 INFO - 'SHELL': '/bin/bash', 08:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:27:06 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:06 INFO - 'USER': 'cltbld', 08:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:06 INFO - 'XPC_FLAGS': '0x0', 08:27:06 INFO - 'XPC_SERVICE_NAME': '0', 08:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:06 INFO - Downloading/unpacking jsonschema 08:27:06 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 08:27:06 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 08:27:06 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 08:27:06 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 08:27:06 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 08:27:06 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 08:27:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:27:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 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 08:27:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:27:09 INFO - warning: no files found matching '*.txt' 08:27:09 INFO - no previously-included directories found matching 'build' 08:27:09 INFO - no previously-included directories found matching 'dist' 08:27:09 INFO - no previously-included directories found matching '.git*' 08:27:09 INFO - Installing collected packages: jsonschema, functools32 08:27:09 INFO - Running setup.py install for functools32 08:27:09 INFO - warning: no files found matching '*.txt' 08:27:09 INFO - no previously-included directories found matching 'build' 08:27:09 INFO - no previously-included directories found matching 'dist' 08:27:09 INFO - no previously-included directories found matching '.git*' 08:27:09 INFO - Successfully installed jsonschema functools32 08:27:09 INFO - Cleaning up... 08:27:09 INFO - Return code: 0 08:27:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:09 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 0x105e53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e59570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8349c6a250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, '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.fXuXm0uldR/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.X6ViNQbhsm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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 08:27:09 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 08:27:10 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 08:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:10 INFO - 'HOME': '/Users/cltbld', 08:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:10 INFO - 'LOGNAME': 'cltbld', 08:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:10 INFO - 'MOZ_NO_REMOTE': '1', 08:27:10 INFO - 'NO_EM_RESTART': '1', 08:27:10 INFO - 'PAGER': '/bin/cat', 08:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:10 INFO - 'PWD': '/builds/slave/test', 08:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:10 INFO - 'SHELL': '/bin/bash', 08:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:27:10 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:10 INFO - 'USER': 'cltbld', 08:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:10 INFO - 'XPC_FLAGS': '0x0', 08:27:10 INFO - 'XPC_SERVICE_NAME': '0', 08:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:10 INFO - Downloading/unpacking flake8 08:27:10 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 08:27:10 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 08:27:10 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 08:27:10 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 08:27:10 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 08:27:10 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 08:27:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:27:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:27:12 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 08:27:12 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 08:27:12 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 08:27:12 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 08:27:12 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 08:27:12 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 08:27:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:27:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 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 08:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:27:14 INFO - no previously-included directories found matching 'docs/_build' 08:27:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:27:14 INFO - Running setup.py install for pep8 08:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:27:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:27:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:27:14 INFO - no previously-included directories found matching 'docs/_build' 08:27:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:27:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:27:14 INFO - Cleaning up... 08:27:14 INFO - Return code: 0 08:27:14 INFO - Running post-action listener: _resource_record_post_action 08:27:14 INFO - Running post-action listener: _start_resource_monitoring 08:27:14 INFO - Starting resource monitoring. 08:27:14 INFO - ##### 08:27:14 INFO - ##### Finished create-virtualenv step (success) 08:27:14 INFO - ##### 08:27:14 INFO - ##### 08:27:14 INFO - ##### Running install step. 08:27:14 INFO - ##### 08:27:14 INFO - Running pre-action listener: _resource_record_pre_action 08:27:14 INFO - Running main action method: install 08:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:14 INFO - Reading from file tmpfile_stdout 08:27:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:14 INFO - Reading from file tmpfile_stdout 08:27:14 INFO - Output received: 08:27:14 INFO - Usage: mozinstall [options] installer 08:27:14 INFO - Options: 08:27:14 INFO - -h, --help show this help message and exit 08:27:14 INFO - -d DEST, --destination=DEST 08:27:14 INFO - Directory to install application into. [default: 08:27:14 INFO - "/builds/slave/test"] 08:27:14 INFO - --app=APP Application being installed. [default: firefox] 08:27:14 INFO - mkdir: /builds/slave/test/build/application 08:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:27:48 INFO - Reading from file tmpfile_stdout 08:27:48 INFO - Output received: 08:27:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:27:48 INFO - Running post-action listener: _resource_record_post_action 08:27:48 INFO - ##### 08:27:48 INFO - ##### Finished install step (success) 08:27:48 INFO - ##### 08:27:48 INFO - ##### 08:27:48 INFO - ##### Running run-tests step. 08:27:48 INFO - ##### 08:27:48 INFO - Running pre-action listener: _resource_record_pre_action 08:27:48 INFO - Running main action method: run_tests 08:27:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:48 INFO - 2016-05-30 08:27:48.368 screenresolution[1989:10189] starting screenresolution argv=screenresolution get 08:27:48 INFO - 2016-05-30 08:27:48.370 screenresolution[1989:10189] Display 0: 1600x1200x32@60 08:27:48 INFO - 2016-05-30 08:27:48.376 screenresolution[1990:10191] starting screenresolution argv=screenresolution list 08:27:48 INFO - Available Modes on Display 0 08:27:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:48 INFO - Intel Iris: 08:27:48 INFO - Chipset Model: Intel Iris 08:27:48 INFO - Type: GPU 08:27:48 INFO - Bus: Built-In 08:27:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:48 INFO - Vendor: Intel (0x8086) 08:27:48 INFO - Device ID: 0x0a2e 08:27:48 INFO - Revision ID: 0x0009 08:27:48 INFO - Displays: 08:27:48 INFO - Display: 08:27:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:48 INFO - Display Serial Number: 1600x1200 60 08:27:48 INFO - Main Display: Yes 08:27:48 INFO - Mirror: Off 08:27:48 INFO - Online: Yes 08:27:48 INFO - Rotation: Supported 08:27:48 INFO - Return code: 0 08:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:48 INFO - Python 2.7.3 08:27:48 INFO - Return code: 0 08:27:48 INFO - grabbing minidump binary from tooltool 08:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf7d30>, '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 0x105b1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ceeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:48 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 08:27:48 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 08:27:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:27:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:48 INFO - Return code: 0 08:27:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:27:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:27:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:27:49 INFO - Return code: 0 08:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 08:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --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 08:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXuXm0uldR/Render', 08:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:49 INFO - 'HOME': '/Users/cltbld', 08:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:49 INFO - 'LOGNAME': 'cltbld', 08:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:49 INFO - 'MOZ_NO_REMOTE': '1', 08:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:49 INFO - 'NO_EM_RESTART': '1', 08:27:49 INFO - 'PAGER': '/bin/cat', 08:27:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:49 INFO - 'PWD': '/builds/slave/test', 08:27:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:49 INFO - 'SHELL': '/bin/bash', 08:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X6ViNQbhsm/Listeners', 08:27:49 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 08:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:49 INFO - 'USER': 'cltbld', 08:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:49 INFO - 'XPC_FLAGS': '0x0', 08:27:49 INFO - 'XPC_SERVICE_NAME': '0', 08:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 08:27:50 INFO - mozversion application_buildid: 20160530063038 08:27:50 INFO - mozversion application_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 08:27:50 INFO - mozversion application_display_name: Nightly 08:27:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:50 INFO - mozversion application_name: Firefox 08:27:50 INFO - mozversion application_remotingname: firefox 08:27:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:27:50 INFO - mozversion application_vendor: Mozilla 08:27:50 INFO - mozversion application_version: 49.0a1 08:27:50 INFO - mozversion platform_buildid: 20160530063038 08:27:50 INFO - mozversion platform_changeset: 3435dd7ad71fe9003bdeee18fd38d815e033beef 08:27:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:27:50 INFO - mozversion platform_version: 49.0a1 08:27:50 INFO - using testdate: 1464622070 08:27:50 INFO - actual date: 1464622070 08:27:50 INFO - starting webserver on 'localhost:49400' 08:27:50 INFO - SUITE-START | Running 2 tests 08:27:50 INFO - TEST-START | dromaeo_css 08:27:50 INFO - operating with platform_type : mac_ 08:27:50 INFO - Initialising browser for dromaeo_css test... 08:27:50 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpfwA1Sj/profile http://localhost:49400/getInfo.html) 08:27:53 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 08:27:53 INFO - PROCESS | 2008 | colorDepth:24 08:27:53 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 08:27:53 INFO - PROCESS | 2008 | __metrics 08:27:53 ERROR - PROCESS | 2008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:27:53 INFO - TEST-INFO | 2008: exit 0 08:27:53 INFO - Browser initialized. 08:27:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:53 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpfwA1Sj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:05 INFO - PROCESS | 2011 | RSS: Main: 252813312 08:28:05 INFO - PROCESS | 2011 | 08:28:55 INFO - PROCESS | 2011 | 1464622135419 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] 08:31:06 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49400/tests/dromaeo/cssquery-ext.html) 08:31:07 INFO - PROCESS | 2011 | RSS: Main: 265240576 08:31:07 INFO - PROCESS | 2011 | 08:34:09 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-ext.html (next: http://localhost:49400/tests/dromaeo/cssquery-jquery.html) 08:34:10 INFO - PROCESS | 2011 | RSS: Main: 276611072 08:34:10 INFO - PROCESS | 2011 | 08:37:12 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49400/tests/dromaeo/cssquery-mootools.html) 08:37:13 INFO - PROCESS | 2011 | RSS: Main: 278749184 08:37:13 INFO - PROCESS | 2011 | 08:40:14 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49400/tests/dromaeo/cssquery-prototype.html) 08:40:15 INFO - PROCESS | 2011 | RSS: Main: 280182784 08:40:15 INFO - PROCESS | 2011 | 08:43:18 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49400/tests/dromaeo/cssquery-yui.html) 08:43:18 INFO - PROCESS | 2011 | RSS: Main: 283701248 08:43:18 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49400/tests/dromaeo/cssquery-yui.html (next: http://localhost:49400/tests/dromaeo/cssquery-dojo.html) 08:46:21 INFO - PROCESS | 2011 | RSS: Main: 283955200 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | __start_tp_report 08:46:21 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 08:46:21 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 08:46:21 INFO - PROCESS | 2011 | |i|pagename|runs| 08:46:21 INFO - PROCESS | 2011 | |0;dojo.html;2716.959245611315;3502.194495266089;3539.0621485306383;3551.360755064089;3569.2147727499946;5904.173415721797;5956.344802071774;5992.670403127826;6003.579749417542;6004;5774.538036957044;5906.88186236275;5920.911186332198;5948.88102237955;6022.367651396606;5265.4208037115795;5284.128118860383;5383.569314454854;5386.676799392029;5420.349558053039;232.85358805680406;5256.684598924076;5305.204219367107;5358.303420555322;5362.115250983583;5345.786168553273;5355.250264962889;5363.517283444508;5388.703621300827;5407.107827208506;5346.545543628797;5379.1662292344745;5391.946080539184;5396.64921780083;5421.972890135524;5224.190250511177;5248.895022099575;5273.077211487975;5315.149576067849;5317.521423071942;5727.3699893011735;5833.066709326487;5887.70561471929;5902.675352855591;5931.733072011727;6174.536909731743;6230.221222347207;6275.6862156891975;6288.654124023177;6289.654069026247;5292.285541451894;6215.627062376227;6262;6301.842453938642;6361.045843123522;6011.57918945674;6049.9697501512655;6073.726682299219;6076.453119219247;6079.756809727562;6182.103594978793;6334;6489.480841532666;6496.123023391876;6524.934750652527;6181.783637572664;6185.010398336244;6230.43926046658;6259.843503912348;6261.123442718023;6287.811365659038;6373.490120790419;6376.617402955838;6401.679916004181;6412.871742565123;6150.692465376714;6162.322144564095;6203.7828675996125;6270.498360131179;6283.214598175228;6215.192025036717;6229.719662615194;6257.311695713468;6266.937330626635;6283.560150789493;4311.504177019683;4742.695758666395;5010.899782004412;5023.8492845214705;5026.698398096126;4391.692581519327;4424.867253982386;4483.977580112079;4504.234280172379;4548.067646132535;5979.9402005980255;5988.131720900445;5992;6044.637321760709;6047.788327408608;6283.905741413882;6327.810165695037;6338.904916426257;6360.872782544323;6368.395002474757;4980.626453016038;5922.378150294243;5977.731002104916;6066.969665151734;6100.877982440326;5479;5520.227168196456;5526.50261476469;5539.7784088636;5579.721013949286;6391.6804159792755;6564.376384243489;6613.6362500062;6635.966820165965;6655.900161497581;6233.594816336924;6283.3402492737605;6317.336679648754;6340.619562826245;6359.8092057238355;6585.440237579859;6596.208454985433;6603.108580341593;6618.172728408949;6684.4652427804685;6163.19878415821;6206.782762603287;6261.279952805304;6281.591696539893;6301.0863424804065;6184.443400094013;6297.149884765681;6312.873742525216;6313.779017734358;6314.336994615499;6220.7511699533325;6223.564350495421;6237.157983672146;6251.843703907439;6271.216097987752;5675.858103547444;5767.567432442667;6146.279041868284;6244.812655620339;6264.749410023548;5194.844154675366;6079.088136779518;6098.11577321277;6179.6910154493;6186.288576813544;6194.5354098443695;6196.783112591038;6207.751689932352;6233.407826256498;6254.530910181846;5658.830235092953;5757.827265182052;6099.176611157437;6134.038624681799;6189.1025801257665 08:46:21 INFO - PROCESS | 2011 | |1;ext.html;480.9851213938591;518.2459521396369;524.6091661712026;530.2285175070273;560.7448610882051;41910.790446047766;42824.57175428245;42884;42932.570674293245;42971.14057718844;39353;43169.35245971305;43641.90895227613;43685.34471982923;43732.3440148398;9614.278929080312;9805.31362804604;9841.655542056029;9842;9843.360181588174;9721.368111072794;9821.705348839547;9829.361091529028;9849.753756156082;9863.210943124568;9827.066428689262;9854.063863932915;9858.408495490257;9864.802703945918;9892.159166470823;9797.853032204523;9836.655717049869;9857.162141218005;9864.654737084167;9877.802443951152;9623.470709110996;9707.174890134347;9715;9725.027497250288;9730.075642813921;40491;40539.39190912139;40624.59375406238;40879.38680919759;40931.97670058272;2982.2991596974693;3046.8628911699025;3320.5849268841393;3340.66593340664;3439.8452069656923;29569.55645665317;30264.697353026408;30614;30622.234444138852;32644.510332345035;3179.72972297355;3186.267158553546;3201.183698156978;3218.372417378612;3327.8835240766457;446805;447264.7636761828;450093;455108;455557;30757.69242307593;34093.97718068462;35142.64857351445;35733.82133089318;35749.64250357515;31435.371292574022;36375.454368184495;36632.633673662924;36687.816560917025;37343;16851.66296674084;16960.660786784196;16972.74540881888;17060.488185354458;17072.573185670208;12854.485820567073;12938.482460701467;12952.028597855198;12953.287569183596;12970.870291296966;20763.584728305348;20954.95225238732;20976.47558811042;21030.579388412145;21060.578788424147;6895.241523432418;7286.963565182246;7342.77971660851;8365.874511882326;8372.58137093143;757.5833291689548;895.0825403960993;1053.167997282154;1099.9065079468176;1136.3182090745486;25056.874715626305;25079.24762257135;30885.918992835144;31108;32318;1047.7223535763028;1061.8354155105972;1080.5785743560018;1096.3750662122513;1140.8916152965621;13468.326583670778;15969.920150399174;15972.840271597135;15991;16262.430814921421;674399;693186;694432;696187;700505;60695.69652151711;62070.0689489658;62813;62932.74134517284;63229;1395.2047333020284;1397.2873834344355;1403.9578812635636;1421.0549984260558;1421.1686163594206;28342.43315133727;29632.55551166691;30564.740906502848;31247;31433;54793.72603136959;59093;60739;60821.695891520256;64471.677641611495;576605;639034;646601;647940;649458;45659.315110272706;45905.77047114743;46424.30363544482;46648.06703865971;47103.822404440165;50248.49751502585;50421.74789126031;50477;51066.23400648919;51997.7400112997;40895.910408958865;41561;42027.94930126771;42511.57488425076;42709.57290427056;40311.596884031955;40990;41090.383644244765;41165.4904622634;42008.57991420047;39714.801425992686;39976.60023399729;40428.1914361717;40555.147261010155;40572.79713601413;30607.2348191297;34935;35310.07925938123;35674.82162589274;35719.821400892826;25066.37334066663;26066.478670426866;26256.474870502865;26732.732672673024;26954.73045269522 08:46:21 INFO - PROCESS | 2011 | |2;jquery.html;355.6265920783178;380.6440977685864;385.7319163181589;398.16981593377807;404.3913909566103;18038.4588462346;19212.807871921294;20523.692144617842;21745.23891663794;21776.346709598696;17445.389411370605;17952.55118622035;20797.896010519966;21445.034973426194;21659.891700541477;5296.867578310554;5888.676122813244;6090.8781824363705;6100.298465676437;6126.724297406605;5984.222051133346;6028.4272994065495;6056.697165141747;6058.787942422016;6063.818085457443;4947.194274089968;5154.355705536808;5988.902417117421;6013.428724271187;6026.126211699301;5098.821541246039;5759.280089988752;5975.52195824333;6023.969880150593;6027.005544085243;4542.977829988259;5206.739663016872;5229.738513074369;5232.947670523284;5234.6335756497065;18412.631747364976;25865.48269034609;26139.346516337053;26845.463090738074;27193.86403067972;2144.839137064711;2246.3597874605657;2284.497410569689;2373.9525209495887;2525.1414519063424;10152.492375381202;10411.323263987892;12554.937225313906;14679.706405871822;15119.563641454044;1875.943721688338;1905.5426697592616;1995.2916714566265;2047.2936836791282;2064.380685794271;118604;123766;124505.37747311297;124851;125722;11538.307701537935;11564.942175289238;11657.941710291394;11691.590794322157;11827.586034488751;14753.557393278219;14760.040597361138;14798.778018329735;14808.92595537037;14838.183899885395;8613.3109351253;8670.13298670128;8691.478511289217;8721.869171962426;8779.473231606124;8574.78563035929;8590.1839325264;8629.137086291446;8708.651653933772;8726.04013558508;4539.886502837456;4637.9536204637525;4641.327007583882;4644.094401591725;4712.340272361872;1787.5888545634316;1958.529952811315;1962.5682349883002;1975.9209631614574;1976.071246514136;859.879616853641;945.9337846350827;997.857453216078;1024.9846252306222;1053.947302634865;19382;21177.047032883558;21197.25809596657;21582.136714531556;21693.457663558536;865.7532603208056;915.3135148638521;944.4191822029402;951.1582249709057;996.0238965813543;10991.670249892515;11438.370889601152;11444.713882153013;11496.885031149748;11506.906843849822;559212;563763;572542;573123;575959;125939;126998.36500817622;127262;127379;130440;991.4299277915084;993.5181437003048;1007.9344842585208;1008.68226508651;1009.3540134314045;18744.437666870017;18950.715739263647;18984.335548255745;19109.904450477658;19207.137446342724;52060;52480.475195247556;52488;52832;52954.73522632516;74205.62897185696;74209;75353;75387.24612754022;76210;6664.933610622277;8080.71717489885;8239.958800206201;8535.658573656985;8605.225529702357;9863.704088877344;11854.703632409259;12549.121561490609;12691.936540317609;12754.68113297175;10669.413182274739;10827.404492752974;10828.404437755999;10917.727056823644;11031.558737650405;10690.839637405601;10783.245172837826;10825.729356766144;10911.83632245501;11186.440677966231;10996.28524145928;10997.61508347204;11207.327560346404;11239.831402528805;11274.605388811353;8183.304419124441;8273.83452330962;8449.83100338002;8509.702160424355;8537.060923298557;8181.590920454072;9845.458499782295;10827.67516974492;11186.776264474502;11253.212275140662 08:46:21 INFO - PROCESS | 2011 | |3;mootools.html;1551.286408252204;1554.2461905975597;1577.2429233967696;1896.8672192946499;1935.7289979402876;6661.134052573158;6858.382745552899;7693.538387696742;8528.275096616788;9022.54887255638;7572.280633339838;8683.696070637528;8819.470831750083;8829.293656507463;8846.849909511771;2013.7816620944263;2257.480779420726;2351.1065794997876;2380.6905102336673;2381.428457170275;2342.3558521406662;2363.231949616373;2385.439421735891;2396.2212281008656;2401.399650087478;1984.7022946558059;2367.3844800351944;2369.407648087978;2408.205292253561;2408.7832095111435;2342.730585982617;2355.0815182079004;2363.2791998440553;2375.3349062262596;2388.581998150317;2328.720553533587;2348.107719066744;2356;2359.315798418457;2364.609839376501;8809.779755506099;8837.734867953972;8881.955590222073;8883.64465421389;8907.109289071106;5230.895382092337;5267.236250743659;5392.325959255093;5437.728113594305;5440.972795136038;3542.5926018507944;3614.0964758810296;3694.2057457646733;3702.2040261343673;3709.5919448860604;1059.1103473082649;1068.743501559628;1081.0541026152894;1086.299336927685;1110.123002827765;11572.594959176473;11760.88239117615;11766.176367654267;11767.646970590897;11807.527698892034;4730.52694730531;4736.8342108026745;4848.200046992278;4849.054434385332;4860.562549370574;10009.549570269355;10018.74953126163;10026.448545330077;10030.699079027641;10073.647422340184;5330.680159190383;5342.038433082005;5397.892042159214;5409.486098820685;5426.2674538936735;4441.267190913528;4818.132736107535;4952.950470495321;4956.925646115311;4965.1311020571975;3932.803359831997;4013.494939397726;4027.395890616431;4066.6949978751713;4167.91664166715;1097.7365432296351;1221.0536833953756;1240.4480006397066;1297.688554746854;1308.0647337153791;807.9394045446616;925.726910561386;934.4860326820221;936.5317341329335;982.042508554154;5857.970710146422;5975.133605627247;6010.639361638228;6044.972354699712;6138.938610613926;365.7110882402872;422.35801581596417;425.97870106495174;429.72068155698423;446.92291577298556;3972.82122304497;3989.6209860063245;4059.106996460774;4068.9389659155136;4073.716779214538;10329.276950613385;10348.637797677045;10535.367877927349;10686.198535109897;10704.1436685065;10515.316504427188;10630.30902991303;10678.412687302272;10719.249652524404;10728.30266032721;8028.879566806502;8051.39614528901;8322.126176751353;8343.582820858812;8356.039055508572;5787.913181302368;5826.271716035496;5828.533717302521;5955.40445955401;5993.640381577119;8074.273315401642;9862.55618497155;9917.603295868084;10097.343672661253;10174.389536627827;8474.237318641352;9807.411555306704;9833;10192.745181370525;10236.641717539851;5782.421757824184;6796.694148763218;7440.330370266702;7505.211952744883;7554;8339.666413343399;8372.958135209285;8447.915520844714;8456.619452124793;8459.534725590152;7343.302386273295;7393.630318484162;7519.849603008019;7581.696732130874;7624.656890439833;7232.89150662751;7305.707771689073;7426.962865185639;7552.546847189186;7590.240975902366;6041.6677082759115;7066.893996589953;7137.1435427749;7142.464315176487;7151.749688760869;4642.907141857077;4715.891765435052;4944.085344211332;5032.974835125948;5063.1898896176435;4320.546342633978;5089.618278629044;5147.356580427447;5161.148410512224;5250.474952504719 08:46:21 INFO - PROCESS | 2011 | |4;prototype.html;309.7026854219949;317.82996097088056;318.44908308626077;319.9728023118035;325.1043375500496;5508.862278443036;5535.363433205182;5573.721313934302;5589.972050139754;5594.9369619772215;4974.577160941324;5449.618526703132;5475.972620136894;5486.725663716818;5494.335247405005;3937.625925537069;4034.677225821942;4082.142750022499;4147.191297696951;4160.4383408239955;3459.9827000865084;3508.631593682665;3670.0457880950876;4167.728842702974;4169.332906734908;3349.3971085204653;3515.962790976668;3838.9251009717323;4035.778032208227;4173.123644034757;3986.720929534934;4016.738911970742;4121.711480196387;4167.187398457318;4172.77049762263;2874.9712502875122;3470.958712386274;3477.4957631143598;3578.5526809148855;3592.8682465023694;4177.916441671149;5243.187305967581;5243.528082472558;5250.317458730379;5253.894922101575;3951.881443556669;4021.959780402217;4269.487661480611;4627.0745850829635;4811.470738218828;5745.7127143643065;5761.839310258653;5775.364709881909;5802.214936830303;5807.2160258365;3382.52644629752;3980.20395920817;3984.382420724792;3988.1684004356944;4034.394840773878;5805.593608447411;5896.027155519334;5961.493273071837;6117.357677443893;6136.8772624547255;3433.484977253432;4043.090304681482;4056.290149223874;4077.347624380144;4109.568495308009;3523.3834079036064;4087.6116768906904;4135.669146468275;4152.647025002848;4195.937060944088;3957.6240257175523;4781.42622885256;4792;4820.758962051954;4831.613470922318;5066.721330326867;5212.713300768494;5629.746661400247;5768.653880767168;5851.590388672752;1312.5406107862173;1399.0416564653042;1403.333416627094;1403.9438422462988;1411.8588141185799;723.6828971272234;829.6142293833396;858.4677499949946;874.7069731639845;880.7886107334193;4797.592204662643;4869.634777391639;5129.666571672829;5155.845324640267;5275.366955965309;5957.314908785458;5986.49114825236;6012.098185272157;6013.909791353133;6014.789482368096;4412.624926881251;5092.7158193594205;5244.842654720364;5498.642588231752;5578.9163162552595;2946.6169397978124;3115.8442077896466;3121.843907804601;3172.4131035757996;3194.7284480818926;5138.58891288696;5267.789288428497;5612.607117501817;6275.152854364603;6317.368263173737;5285.312909321764;5600.775968961278;5610.523105535994;5865.9441300566305;6229.221347331583;5371.62398632092;6183.752649893954;6312.715927783261;6348.365163483615;6361.332060133619;5311.521963023347;5716.971415142898;5986.3115741688525;5992.2809262886985;6026.487748541248;5225.555827754683;5446.645968012067;5659.207710920557;5775.768969241183;5937.673427961504;5542.667439953616;5993.730282137401;6053.152558641706;6267.6866156692895;6303.716332764945;3651.7626354286886;3947.9013024673463;3997.600239975979;4001.639852413297;4003.439518467475;5261.053010458154;5840.766369345349;5965.522758179422;6038.094285857156;6104.908426373519;4973.751312434436;5481.287432633732;5825.009748342707;5834.679092649945;5864.44287792659;5166.3800343958965;5367.785288588413;5368.0406651572675;5413.810516631899;5594.916076258941;5440.591955603425;5728.598998070095;5734.254546908875;5745.827625171251;5780.855478613068;4818.855434336975;5590.8043218487155;5810.331811841524;5833.7666493341485;5851.444112809277;4625.606823419912;4788.832390866303;5004.649674522894;5771.624844385102;5775.27809023872 08:46:21 INFO - PROCESS | 2011 | |5;yui.html;792.4017366887999;804.8390321935615;812.5206128384256;831.6484567194209;845.754731127973;12547.37263136844;14399.496017639385;14921.92539037306;15001.474948376781;15251.161186134772;12506.249625022505;13799.931000344985;13897.722045559109;13929.233892135928;13929.791053134211;720.7693538067821;905.4657751926378;915.4370062411602;921.230772305126;924.3806649544788;720.5640587444599;925.1858364639141;925.4863550729342;929.7489677786994;935.2190920581323;967.0377973915963;976.5166242709834;976.9804603907918;979.2459805949414;983.1888691829233;963.4363897120193;968.0899954043247;973.9610415583404;974.3423189347197;974.6978436684615;723.2116992478171;725.1696807155777;726.4878260826158;728.0789800901863;730.109266694637;14431.855681443156;14611.78082328766;14617.488387906373;14633.975621706484;14653.706925861423;13638.249896255702;13651.453941842314;13666.794998075036;13762.24307663078;13929.164250145024;9438.575264113131;11273.60542381021;11436.42817859112;11716.53133874644;11808.763824723543;3703.6481534254203;3750.79370634615;3788.5453745550435;3801.391777315644;3944.3689009758587;78209.82685259725;78786.6060669693;79689;80962;81607.5919620404;10675.252732308663;10686.305390149771;10725;10825.188110891715;10839.566417343218;20993.790062099488;21102.683459748117;21105.472363190736;21124.366269011953;21138;6624.403803657694;7777.766666999999;7945.761627151079;7980.960095199603;8086.1913808618665;4517.774111294422;4545.4545454545005;4566.315052742115;4569.680122391401;4628.907421851544;2920.8977685780897;3366.107981384935;3443.0359499340225;3454.240067185215;3455.1707590178175;579.6724850459477;648.6036178990752;662.460095022555;672.8116127484312;675.7769935921233;550.4385526762679;562.5864989232911;582.7639805878626;692.6467501574233;696.5994553131969;8645.524496152646;9072.183503484717;9097.90902090984;9153.130452606993;9362.765930851783;581.1515187825737;595.7557401465378;658.1805651963336;677.2989955396141;685.1538350137577;4247.447831781848;4251.586912247826;4336.739795612273;4360.345948107809;4399.868003959887;82348;83760;84897.57551212204;84903;84970.72543911847;75896.62051689706;77105.61447192729;77960.2713905022;79386;80921;67844.6607766958;69820.3017969824;71209;71463.55941080456;72362;7909.564973926259;8220.506769593605;8354.373421993254;8468.576571171294;8521.488710677379;32047.839760801045;44225.77887110544;44288;45401.31898021598;45557.772211138734;58034.129488058556;58171.709141455714;59861;61205;61469.692651536454;10160.93310202418;10205.591776328863;10757.731056723644;11138.918050241478;11854.762904742029;12036.157468977437;12039.63881083569;12040.638780836589;12206.938965305117;12262.938685306517;9394.389364691273;11281.830772538582;11532.481038353126;11616.419179040846;11674.474648641002;11221.990020898158;11501.597444089417;11571.594994175164;11632.476538555955;12039;10935.671929842118;11102.61140860066;11120.555177793121;11559.76880462403;11674.941625292158;8494.617742201739;9235.399699019543;9328.673496427593;9596.23230141601;10069.949650251994;9163.221126204347;9541.47521886303;9581.377210481296;9679.9032009679;9739.853902191331 08:46:21 INFO - PROCESS | 2011 | __end_tp_report 08:46:21 INFO - PROCESS | 2011 | __start_cc_report 08:46:21 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,411 08:46:21 INFO - PROCESS | 2011 | __end_cc_report 08:46:21 INFO - PROCESS | 2011 | __startTimestamp1464623181920__endTimestamp 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | ------- Summary: start ------- 08:46:21 INFO - PROCESS | 2011 | Number of tests: 6 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#0] dojo.html Cycles:165 Average:5820.08 Median:6099.18 stddev:802.34 (13.2%) stddev-sans-first:766.98 08:46:21 INFO - PROCESS | 2011 | Values: 2717.0 3502.2 3539.1 3551.4 3569.2 5904.2 5956.3 5992.7 6003.6 6004.0 5774.5 5906.9 5920.9 5948.9 6022.4 5265.4 5284.1 5383.6 5386.7 5420.3 232.9 5256.7 5305.2 5358.3 5362.1 5345.8 5355.3 5363.5 5388.7 5407.1 5346.5 5379.2 5391.9 5396.6 5422.0 5224.2 5248.9 5273.1 5315.1 5317.5 5727.4 5833.1 5887.7 5902.7 5931.7 6174.5 6230.2 6275.7 6288.7 6289.7 5292.3 6215.6 6262.0 6301.8 6361.0 6011.6 6050.0 6073.7 6076.5 6079.8 6182.1 6334.0 6489.5 6496.1 6524.9 6181.8 6185.0 6230.4 6259.8 6261.1 6287.8 6373.5 6376.6 6401.7 6412.9 6150.7 6162.3 6203.8 6270.5 6283.2 6215.2 6229.7 6257.3 6266.9 6283.6 4311.5 4742.7 5010.9 5023.8 5026.7 4391.7 4424.9 4484.0 4504.2 4548.1 5979.9 5988.1 5992.0 6044.6 6047.8 6283.9 6327.8 6338.9 6360.9 6368.4 4980.6 5922.4 5977.7 6067.0 6100.9 5479.0 5520.2 5526.5 5539.8 5579.7 6391.7 6564.4 6613.6 6636.0 6655.9 6233.6 6283.3 6317.3 6340.6 6359.8 6585.4 6596.2 6603.1 6618.2 6684.5 6163.2 6206.8 6261.3 6281.6 6301.1 6184.4 6297.1 6312.9 6313.8 6314.3 6220.8 6223.6 6237.2 6251.8 6271.2 5675.9 5767.6 6146.3 6244.8 6264.7 5194.8 6079.1 6098.1 6179.7 6186.3 6194.5 6196.8 6207.8 6233.4 6254.5 5658.8 5757.8 6099.2 6134.0 6189.1 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#1] ext.html Cycles:180 Average:72156.49 Median:40960.99 stddev:160828.78 (392.6%) stddev-sans-first:161189.91 08:46:21 INFO - PROCESS | 2011 | Values: 481.0 518.2 524.6 530.2 560.7 41910.8 42824.6 42884.0 42932.6 42971.1 39353.0 43169.4 43641.9 43685.3 43732.3 9614.3 9805.3 9841.7 9842.0 9843.4 9721.4 9821.7 9829.4 9849.8 9863.2 9827.1 9854.1 9858.4 9864.8 9892.2 9797.9 9836.7 9857.2 9864.7 9877.8 9623.5 9707.2 9715.0 9725.0 9730.1 40491.0 40539.4 40624.6 40879.4 40932.0 2982.3 3046.9 3320.6 3340.7 3439.8 29569.6 30264.7 30614.0 30622.2 32644.5 3179.7 3186.3 3201.2 3218.4 3327.9 446805.0 447264.8 450093.0 455108.0 455557.0 30757.7 34094.0 35142.6 35733.8 35749.6 31435.4 36375.5 36632.6 36687.8 37343.0 16851.7 16960.7 16972.7 17060.5 17072.6 12854.5 12938.5 12952.0 12953.3 12970.9 20763.6 20955.0 20976.5 21030.6 21060.6 6895.2 7287.0 7342.8 8365.9 8372.6 757.6 895.1 1053.2 1099.9 1136.3 25056.9 25079.2 30885.9 31108.0 32318.0 1047.7 1061.8 1080.6 1096.4 1140.9 13468.3 15969.9 15972.8 15991.0 16262.4 674399.0 693186.0 694432.0 696187.0 700505.0 60695.7 62070.1 62813.0 62932.7 63229.0 1395.2 1397.3 1404.0 1421.1 1421.2 28342.4 29632.6 30564.7 31247.0 31433.0 54793.7 59093.0 60739.0 60821.7 64471.7 576605.0 639034.0 646601.0 647940.0 649458.0 45659.3 45905.8 46424.3 46648.1 47103.8 50248.5 50421.7 50477.0 51066.2 51997.7 40895.9 41561.0 42027.9 42511.6 42709.6 40311.6 40990.0 41090.4 41165.5 42008.6 39714.8 39976.6 40428.2 40555.1 40572.8 30607.2 34935.0 35310.1 35674.8 35719.8 25066.4 26066.5 26256.5 26732.7 26954.7 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#2] jquery.html Cycles:180 Average:34291.64 Median:2329.22 stddev:95324.28 (4092.5%) stddev-sans-first:95557.63 08:46:21 INFO - PROCESS | 2011 | Values: 355.6 380.6 385.7 398.2 404.4 18038.5 19212.8 20523.7 21745.2 21776.3 17445.4 17952.6 20797.9 21445.0 21659.9 5296.9 5888.7 6090.9 6100.3 6126.7 5984.2 6028.4 6056.7 6058.8 6063.8 4947.2 5154.4 5988.9 6013.4 6026.1 5098.8 5759.3 5975.5 6024.0 6027.0 4543.0 5206.7 5229.7 5232.9 5234.6 18412.6 25865.5 26139.3 26845.5 27193.9 2144.8 2246.4 2284.5 2374.0 2525.1 10152.5 10411.3 12554.9 14679.7 15119.6 1875.9 1905.5 1995.3 2047.3 2064.4 118604.0 123766.0 124505.4 124851.0 125722.0 11538.3 11564.9 11657.9 11691.6 11827.6 14753.6 14760.0 14798.8 14808.9 14838.2 8613.3 8670.1 8691.5 8721.9 8779.5 8574.8 8590.2 8629.1 8708.7 8726.0 4539.9 4638.0 4641.3 4644.1 4712.3 1787.6 1958.5 1962.6 1975.9 1976.1 859.9 945.9 997.9 1025.0 1053.9 19382.0 21177.0 21197.3 21582.1 21693.5 865.8 915.3 944.4 951.2 996.0 10991.7 11438.4 11444.7 11496.9 11506.9 559212.0 563763.0 572542.0 573123.0 575959.0 125939.0 126998.4 127262.0 127379.0 130440.0 991.4 993.5 1007.9 1008.7 1009.4 18744.4 18950.7 18984.3 19109.9 19207.1 52060.0 52480.5 52488.0 52832.0 52954.7 74205.6 74209.0 75353.0 75387.2 76210.0 6664.9 8080.7 8240.0 8535.7 8605.2 9863.7 11854.7 12549.1 12691.9 12754.7 10669.4 10827.4 10828.4 10917.7 11031.6 10690.8 10783.2 10825.7 10911.8 11186.4 10996.3 10997.6 11207.3 11239.8 11274.6 8183.3 8273.8 8449.8 8509.7 8537.1 8181.6 9845.5 10827.7 11186.8 11253.2 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#3] mootools.html Cycles:180 Average:5661.10 Median:4833.17 stddev:3173.02 (65.7%) stddev-sans-first:3166.89 08:46:21 INFO - PROCESS | 2011 | Values: 1551.3 1554.2 1577.2 1896.9 1935.7 6661.1 6858.4 7693.5 8528.3 9022.5 7572.3 8683.7 8819.5 8829.3 8846.8 2013.8 2257.5 2351.1 2380.7 2381.4 2342.4 2363.2 2385.4 2396.2 2401.4 1984.7 2367.4 2369.4 2408.2 2408.8 2342.7 2355.1 2363.3 2375.3 2388.6 2328.7 2348.1 2356.0 2359.3 2364.6 8809.8 8837.7 8882.0 8883.6 8907.1 5230.9 5267.2 5392.3 5437.7 5441.0 3542.6 3614.1 3694.2 3702.2 3709.6 1059.1 1068.7 1081.1 1086.3 1110.1 11572.6 11760.9 11766.2 11767.6 11807.5 4730.5 4736.8 4848.2 4849.1 4860.6 10009.5 10018.7 10026.4 10030.7 10073.6 5330.7 5342.0 5397.9 5409.5 5426.3 4441.3 4818.1 4953.0 4956.9 4965.1 3932.8 4013.5 4027.4 4066.7 4167.9 1097.7 1221.1 1240.4 1297.7 1308.1 807.9 925.7 934.5 936.5 982.0 5858.0 5975.1 6010.6 6045.0 6138.9 365.7 422.4 426.0 429.7 446.9 3972.8 3989.6 4059.1 4068.9 4073.7 10329.3 10348.6 10535.4 10686.2 10704.1 10515.3 10630.3 10678.4 10719.2 10728.3 8028.9 8051.4 8322.1 8343.6 8356.0 5787.9 5826.3 5828.5 5955.4 5993.6 8074.3 9862.6 9917.6 10097.3 10174.4 8474.2 9807.4 9833.0 10192.7 10236.6 5782.4 6796.7 7440.3 7505.2 7554.0 8339.7 8373.0 8447.9 8456.6 8459.5 7343.3 7393.6 7519.8 7581.7 7624.7 7232.9 7305.7 7427.0 7552.5 7590.2 6041.7 7066.9 7137.1 7142.5 7151.7 4642.9 4715.9 4944.1 5033.0 5063.2 4320.5 5089.6 5147.4 5161.1 5250.5 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#4] prototype.html Cycles:180 Average:4645.88 Median:5247.58 stddev:1456.95 (27.8%) stddev-sans-first:1424.22 08:46:21 INFO - PROCESS | 2011 | Values: 309.7 317.8 318.4 320.0 325.1 5508.9 5535.4 5573.7 5590.0 5594.9 4974.6 5449.6 5476.0 5486.7 5494.3 3937.6 4034.7 4082.1 4147.2 4160.4 3460.0 3508.6 3670.0 4167.7 4169.3 3349.4 3516.0 3838.9 4035.8 4173.1 3986.7 4016.7 4121.7 4167.2 4172.8 2875.0 3471.0 3477.5 3578.6 3592.9 4177.9 5243.2 5243.5 5250.3 5253.9 3951.9 4022.0 4269.5 4627.1 4811.5 5745.7 5761.8 5775.4 5802.2 5807.2 3382.5 3980.2 3984.4 3988.2 4034.4 5805.6 5896.0 5961.5 6117.4 6136.9 3433.5 4043.1 4056.3 4077.3 4109.6 3523.4 4087.6 4135.7 4152.6 4195.9 3957.6 4781.4 4792.0 4820.8 4831.6 5066.7 5212.7 5629.7 5768.7 5851.6 1312.5 1399.0 1403.3 1403.9 1411.9 723.7 829.6 858.5 874.7 880.8 4797.6 4869.6 5129.7 5155.8 5275.4 5957.3 5986.5 6012.1 6013.9 6014.8 4412.6 5092.7 5244.8 5498.6 5578.9 2946.6 3115.8 3121.8 3172.4 3194.7 5138.6 5267.8 5612.6 6275.2 6317.4 5285.3 5600.8 5610.5 5865.9 6229.2 5371.6 6183.8 6312.7 6348.4 6361.3 5311.5 5717.0 5986.3 5992.3 6026.5 5225.6 5446.6 5659.2 5775.8 5937.7 5542.7 5993.7 6053.2 6267.7 6303.7 3651.8 3947.9 3997.6 4001.6 4003.4 5261.1 5840.8 5965.5 6038.1 6104.9 4973.8 5481.3 5825.0 5834.7 5864.4 5166.4 5367.8 5368.0 5413.8 5594.9 5440.6 5728.6 5734.3 5745.8 5780.9 4818.9 5590.8 5810.3 5833.8 5851.4 4625.6 4788.8 5004.6 5771.6 5775.3 08:46:21 INFO - PROCESS | 2011 | 08:46:21 INFO - PROCESS | 2011 | [#5] yui.html Cycles:180 Average:17728.37 Median:589.26 stddev:24354.50 (4133.1%) stddev-sans-first:24389.62 08:46:21 INFO - PROCESS | 2011 | Values: 792.4 804.8 812.5 831.6 845.8 12547.4 14399.5 14921.9 15001.5 15251.2 12506.2 13799.9 13897.7 13929.2 13929.8 720.8 905.5 915.4 921.2 924.4 720.6 925.2 925.5 929.7 935.2 967.0 976.5 977.0 979.2 983.2 963.4 968.1 974.0 974.3 974.7 723.2 725.2 726.5 728.1 730.1 14431.9 14611.8 14617.5 14634.0 14653.7 13638.2 13651.5 13666.8 13762.2 13929.2 9438.6 11273.6 11436.4 11716.5 11808.8 3703.6 3750.8 3788.5 3801.4 3944.4 78209.8 78786.6 79689.0 80962.0 81607.6 10675.3 10686.3 10725.0 10825.2 10839.6 20993.8 21102.7 21105.5 21124.4 21138.0 6624.4 7777.8 7945.8 7981.0 8086.2 4517.8 4545.5 4566.3 4569.7 4628.9 2920.9 3366.1 3443.0 3454.2 3455.2 579.7 648.6 662.5 672.8 675.8 550.4 562.6 582.8 692.6 696.6 8645.5 9072.2 9097.9 9153.1 9362.8 581.2 595.8 658.2 677.3 685.2 4247.4 4251.6 4336.7 4360.3 4399.9 82348.0 83760.0 84897.6 84903.0 84970.7 75896.6 77105.6 77960.3 79386.0 80921.0 67844.7 69820.3 71209.0 71463.6 72362.0 7909.6 8220.5 8354.4 8468.6 8521.5 32047.8 44225.8 44288.0 45401.3 45557.8 58034.1 58171.7 59861.0 61205.0 61469.7 10160.9 10205.6 10757.7 11138.9 11854.8 12036.2 12039.6 12040.6 12206.9 12262.9 9394.4 11281.8 11532.5 11616.4 11674.5 11222.0 11501.6 11571.6 11632.5 12039.0 10935.7 11102.6 11120.6 11559.8 11674.9 8494.6 9235.4 9328.7 9596.2 10069.9 9163.2 9541.5 9581.4 9679.9 9739.9 08:46:21 INFO - PROCESS | 2011 | -------- Summary: end -------- 08:46:21 INFO - PROCESS | 2011 | 08:46:22 INFO - TEST-INFO | 2011: exit 0 08:46:22 INFO - TEST-OK | dromaeo_css | took 1112388ms 08:46:22 INFO - TEST-START | kraken 08:46:22 INFO - operating with platform_type : mac_ 08:46:22 INFO - Initialising browser for kraken test... 08:46:22 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpze4PEI/profile http://localhost:49400/getInfo.html) 08:46:25 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 08:46:25 INFO - PROCESS | 2017 | colorDepth:24 08:46:25 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 08:46:25 INFO - PROCESS | 2017 | __metrics 08:46:25 ERROR - PROCESS | 2017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:46:26 INFO - TEST-INFO | 2017: exit 0 08:46:26 INFO - Browser initialized. 08:46:26 INFO - Running cycle 1/1 for kraken test... 08:46:26 INFO - TEST-INFO | started process 2019 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpze4PEI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:38 INFO - PROCESS | 2019 | RSS: Main: 252575744 08:46:38 INFO - PROCESS | 2019 | 08:46:40 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:41 INFO - PROCESS | 2019 | RSS: Main: 265494528 08:46:41 INFO - PROCESS | 2019 | 08:46:44 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-dft) 08:46:45 INFO - PROCESS | 2019 | RSS: Main: 269533184 08:46:45 INFO - PROCESS | 2019 | 08:46:48 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-fft) 08:46:49 INFO - PROCESS | 2019 | RSS: Main: 270172160 08:46:49 INFO - PROCESS | 2019 | 08:46:51 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator) 08:46:51 INFO - PROCESS | 2019 | RSS: Main: 270987264 08:46:51 INFO - PROCESS | 2019 | 08:46:53 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:54 INFO - PROCESS | 2019 | RSS: Main: 272003072 08:46:54 INFO - PROCESS | 2019 | 08:46:57 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:58 INFO - PROCESS | 2019 | RSS: Main: 271785984 08:46:58 INFO - PROCESS | 2019 | 08:47:01 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate) 08:47:02 INFO - PROCESS | 2019 | RSS: Main: 272224256 08:47:02 INFO - PROCESS | 2019 | 08:47:05 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial) 08:47:05 INFO - PROCESS | 2019 | RSS: Main: 272416768 08:47:05 INFO - PROCESS | 2019 | 08:47:07 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:47:08 INFO - PROCESS | 2019 | RSS: Main: 272003072 08:47:08 INFO - PROCESS | 2019 | 08:47:09 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:47:10 INFO - PROCESS | 2019 | RSS: Main: 271986688 08:47:10 INFO - PROCESS | 2019 | 08:47:12 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:13 INFO - PROCESS | 2019 | RSS: Main: 272318464 08:47:13 INFO - PROCESS | 2019 | 08:47:16 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:17 INFO - PROCESS | 2019 | RSS: Main: 272322560 08:47:17 INFO - PROCESS | 2019 | 08:47:20 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:20 INFO - PROCESS | 2019 | RSS: Main: 272277504 08:47:20 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49400/tests/kraken/driver.html?testName=ai-astar) 08:47:22 INFO - PROCESS | 2019 | RSS: Main: 273240064 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | __start_tp_report 08:47:22 INFO - PROCESS | 2019 | _x_x_mozilla_page_load 08:47:22 INFO - PROCESS | 2019 | _x_x_mozilla_page_load_details 08:47:22 INFO - PROCESS | 2019 | |i|pagename|runs| 08:47:22 INFO - PROCESS | 2019 | |0;ai-astar;118;110;115;114;116;116;115;114;117;115 08:47:22 INFO - PROCESS | 2019 | |1;audio-beat-detection;156;124;139;155;111;166;164;148;196;148 08:47:22 INFO - PROCESS | 2019 | |2;audio-dft;203;200;209;238;255;255;200;197;199;195 08:47:22 INFO - PROCESS | 2019 | |3;audio-fft;72;78;76;152;65;81;81;79;142;69 08:47:22 INFO - PROCESS | 2019 | |4;audio-oscillator;92;73;122;64;83;129;122;60;106;157 08:47:22 INFO - PROCESS | 2019 | |5;imaging-gaussian-blur;94;98;89;86;104;84;76;112;100;99 08:47:22 INFO - PROCESS | 2019 | |6;imaging-darkroom;93;96;114;154;132;107;153;150;100;95 08:47:22 INFO - PROCESS | 2019 | |7;imaging-desaturate;146;147;91;145;144;121;90;91;91;91 08:47:22 INFO - PROCESS | 2019 | |8;json-parse-financial;57;57;56;57;71;58;57;58;60;58 08:47:22 INFO - PROCESS | 2019 | |9;json-stringify-tinderbox;71;75;70;80;76;80;79;66;81;100 08:47:22 INFO - PROCESS | 2019 | |10;stanford-crypto-aes;83;110;114;110;86;87;91;90;117;87 08:47:22 INFO - PROCESS | 2019 | |11;stanford-crypto-ccm;145;143;116;144;138;148;151;139;172;152 08:47:22 INFO - PROCESS | 2019 | |12;stanford-crypto-pbkdf2;196;227;195;167;167;166;164;170;169;162 08:47:22 INFO - PROCESS | 2019 | |13;stanford-crypto-sha256-iterative;63;70;58;75;81;59;72;64;62;82 08:47:22 INFO - PROCESS | 2019 | __end_tp_report 08:47:22 INFO - PROCESS | 2019 | __start_cc_report 08:47:22 INFO - PROCESS | 2019 | _x_x_mozilla_cycle_collect,1053 08:47:22 INFO - PROCESS | 2019 | __end_cc_report 08:47:22 INFO - PROCESS | 2019 | __startTimestamp1464623242660__endTimestamp 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | ------- Summary: start ------- 08:47:22 INFO - PROCESS | 2019 | Number of tests: 14 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:2.16 (1.9%) stddev-sans-first:2.00 08:47:22 INFO - PROCESS | 2019 | Values: 118.0 110.0 115.0 114.0 116.0 116.0 115.0 114.0 117.0 115.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:155.50 stddev:23.45 (15.1%) stddev-sans-first:24.80 08:47:22 INFO - PROCESS | 2019 | Values: 156.0 124.0 139.0 155.0 111.0 166.0 164.0 148.0 196.0 148.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#2] audio-dft Cycles:10 Average:215.10 Median:206.00 stddev:24.36 (11.8%) stddev-sans-first:25.44 08:47:22 INFO - PROCESS | 2019 | Values: 203.0 200.0 209.0 238.0 255.0 255.0 200.0 197.0 199.0 195.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#3] audio-fft Cycles:10 Average:89.50 Median:77.00 stddev:30.84 (40.0%) stddev-sans-first:32.05 08:47:22 INFO - PROCESS | 2019 | Values: 72.0 78.0 76.0 152.0 65.0 81.0 81.0 79.0 142.0 69.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:62.00 stddev:31.74 (51.2%) stddev-sans-first:33.50 08:47:22 INFO - PROCESS | 2019 | Values: 92.0 73.0 122.0 64.0 83.0 129.0 122.0 60.0 106.0 157.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:87.50 stddev:10.61 (12.1%) stddev-sans-first:11.26 08:47:22 INFO - PROCESS | 2019 | Values: 94.0 98.0 89.0 86.0 104.0 84.0 76.0 112.0 100.0 99.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#6] imaging-darkroom Cycles:10 Average:119.40 Median:153.50 stddev:25.43 (16.6%) stddev-sans-first:25.11 08:47:22 INFO - PROCESS | 2019 | Values: 93.0 96.0 114.0 154.0 132.0 107.0 153.0 150.0 100.0 95.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:90.50 stddev:27.26 (30.1%) stddev-sans-first:26.61 08:47:22 INFO - PROCESS | 2019 | Values: 146.0 147.0 91.0 145.0 144.0 121.0 90.0 91.0 91.0 91.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:4.38 (7.6%) stddev-sans-first:4.59 08:47:22 INFO - PROCESS | 2019 | Values: 57.0 57.0 56.0 57.0 71.0 58.0 57.0 58.0 60.0 58.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:77.50 stddev:9.26 (11.9%) stddev-sans-first:9.49 08:47:22 INFO - PROCESS | 2019 | Values: 71.0 75.0 70.0 80.0 76.0 80.0 79.0 66.0 81.0 100.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#10] stanford-crypto-aes Cycles:10 Average:97.50 Median:86.50 stddev:13.44 (15.5%) stddev-sans-first:13.20 08:47:22 INFO - PROCESS | 2019 | Values: 83.0 110.0 114.0 110.0 86.0 87.0 91.0 90.0 117.0 87.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:146.50 stddev:13.96 (9.5%) stddev-sans-first:14.81 08:47:22 INFO - PROCESS | 2019 | Values: 145.0 143.0 116.0 144.0 138.0 148.0 151.0 139.0 172.0 152.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:169.50 stddev:21.07 (12.4%) stddev-sans-first:21.35 08:47:22 INFO - PROCESS | 2019 | Values: 196.0 227.0 195.0 167.0 167.0 166.0 164.0 170.0 169.0 162.0 08:47:22 INFO - PROCESS | 2019 | 08:47:22 INFO - PROCESS | 2019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:71.00 stddev:8.75 (12.3%) stddev-sans-first:9.04 08:47:22 INFO - PROCESS | 2019 | Values: 63.0 70.0 58.0 75.0 81.0 59.0 72.0 64.0 62.0 82.0 08:47:22 INFO - PROCESS | 2019 | -------- Summary: end -------- 08:47:22 INFO - PROCESS | 2019 | 08:47:23 INFO - TEST-INFO | 2019: exit 0 08:47:23 INFO - TEST-OK | kraken | took 61102ms 08:47:23 INFO - SUITE-END | took 1173s 08:47:23 INFO - Completed test suite (00:19:33) 08:47:23 INFO - javascript benchmark 08:47:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7266.649714527616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.959245611315, 3502.194495266089, 3539.0621485306383, 3551.360755064089, 3569.2147727499946, 5904.173415721797, 5956.344802071774, 5992.670403127826, 6003.579749417542, 6004.0, 5774.538036957044, 5906.88186236275, 5920.911186332198, 5948.88102237955, 6022.367651396606, 5265.4208037115795, 5284.128118860383, 5383.569314454854, 5386.676799392029, 5420.349558053039, 232.85358805680406, 5256.684598924076, 5305.204219367107, 5358.303420555322, 5362.115250983583, 5345.786168553273, 5355.250264962889, 5363.517283444508, 5388.703621300827, 5407.107827208506, 5346.545543628797, 5379.1662292344745, 5391.946080539184, 5396.64921780083, 5421.972890135524, 5224.190250511177, 5248.895022099575, 5273.077211487975, 5315.149576067849, 5317.521423071942, 5727.3699893011735, 5833.066709326487, 5887.70561471929, 5902.675352855591, 5931.733072011727, 6174.536909731743, 6230.221222347207, 6275.6862156891975, 6288.654124023177, 6289.654069026247, 5292.285541451894, 6215.627062376227, 6262.0, 6301.842453938642, 6361.045843123522, 6011.57918945674, 6049.9697501512655, 6073.726682299219, 6076.453119219247, 6079.756809727562, 6182.103594978793, 6334.0, 6489.480841532666, 6496.123023391876, 6524.934750652527, 6181.783637572664, 6185.010398336244, 6230.43926046658, 6259.843503912348, 6261.123442718023, 6287.811365659038, 6373.490120790419, 6376.617402955838, 6401.679916004181, 6412.871742565123, 6150.692465376714, 6162.322144564095, 6203.7828675996125, 6270.498360131179, 6283.214598175228, 6215.192025036717, 6229.719662615194, 6257.311695713468, 6266.937330626635, 6283.560150789493, 4311.504177019683, 4742.695758666395, 5010.899782004412, 5023.8492845214705, 5026.698398096126, 4391.692581519327, 4424.867253982386, 4483.977580112079, 4504.234280172379, 4548.067646132535, 5979.9402005980255, 5988.131720900445, 5992.0, 6044.637321760709, 6047.788327408608, 6283.905741413882, 6327.810165695037, 6338.904916426257, 6360.872782544323, 6368.395002474757, 4980.626453016038, 5922.378150294243, 5977.731002104916, 6066.969665151734, 6100.877982440326, 5479.0, 5520.227168196456, 5526.50261476469, 5539.7784088636, 5579.721013949286, 6391.6804159792755, 6564.376384243489, 6613.6362500062, 6635.966820165965, 6655.900161497581, 6233.594816336924, 6283.3402492737605, 6317.336679648754, 6340.619562826245, 6359.8092057238355, 6585.440237579859, 6596.208454985433, 6603.108580341593, 6618.172728408949, 6684.4652427804685, 6163.19878415821, 6206.782762603287, 6261.279952805304, 6281.591696539893, 6301.0863424804065, 6184.443400094013, 6297.149884765681, 6312.873742525216, 6313.779017734358, 6314.336994615499, 6220.7511699533325, 6223.564350495421, 6237.157983672146, 6251.843703907439, 6271.216097987752, 5675.858103547444, 5767.567432442667, 6146.279041868284, 6244.812655620339, 6264.749410023548, 5194.844154675366, 6079.088136779518, 6098.11577321277, 6179.6910154493, 6186.288576813544, 6194.5354098443695, 6196.783112591038, 6207.751689932352, 6233.407826256498, 6254.530910181846, 5658.830235092953, 5757.827265182052, 6099.176611157437, 6134.038624681799, 6189.1025801257665], "value": 5769.815609192023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.9851213938591, 518.2459521396369, 524.6091661712026, 530.2285175070273, 560.7448610882051, 41910.790446047766, 42824.57175428245, 42884.0, 42932.570674293245, 42971.14057718844, 39353.0, 43169.35245971305, 43641.90895227613, 43685.34471982923, 43732.3440148398, 9614.278929080312, 9805.31362804604, 9841.655542056029, 9842.0, 9843.360181588174, 9721.368111072794, 9821.705348839547, 9829.361091529028, 9849.753756156082, 9863.210943124568, 9827.066428689262, 9854.063863932915, 9858.408495490257, 9864.802703945918, 9892.159166470823, 9797.853032204523, 9836.655717049869, 9857.162141218005, 9864.654737084167, 9877.802443951152, 9623.470709110996, 9707.174890134347, 9715.0, 9725.027497250288, 9730.075642813921, 40491.0, 40539.39190912139, 40624.59375406238, 40879.38680919759, 40931.97670058272, 2982.2991596974693, 3046.8628911699025, 3320.5849268841393, 3340.66593340664, 3439.8452069656923, 29569.55645665317, 30264.697353026408, 30614.0, 30622.234444138852, 32644.510332345035, 3179.72972297355, 3186.267158553546, 3201.183698156978, 3218.372417378612, 3327.8835240766457, 446805.0, 447264.7636761828, 450093.0, 455108.0, 455557.0, 30757.69242307593, 34093.97718068462, 35142.64857351445, 35733.82133089318, 35749.64250357515, 31435.371292574022, 36375.454368184495, 36632.633673662924, 36687.816560917025, 37343.0, 16851.66296674084, 16960.660786784196, 16972.74540881888, 17060.488185354458, 17072.573185670208, 12854.485820567073, 12938.482460701467, 12952.028597855198, 12953.287569183596, 12970.870291296966, 20763.584728305348, 20954.95225238732, 20976.47558811042, 21030.579388412145, 21060.578788424147, 6895.241523432418, 7286.963565182246, 7342.77971660851, 8365.874511882326, 8372.58137093143, 757.5833291689548, 895.0825403960993, 1053.167997282154, 1099.9065079468176, 1136.3182090745486, 25056.874715626305, 25079.24762257135, 30885.918992835144, 31108.0, 32318.0, 1047.7223535763028, 1061.8354155105972, 1080.5785743560018, 1096.3750662122513, 1140.8916152965621, 13468.326583670778, 15969.920150399174, 15972.840271597135, 15991.0, 16262.430814921421, 674399.0, 693186.0, 694432.0, 696187.0, 700505.0, 60695.69652151711, 62070.0689489658, 62813.0, 62932.74134517284, 63229.0, 1395.2047333020284, 1397.2873834344355, 1403.9578812635636, 1421.0549984260558, 1421.1686163594206, 28342.43315133727, 29632.55551166691, 30564.740906502848, 31247.0, 31433.0, 54793.72603136959, 59093.0, 60739.0, 60821.695891520256, 64471.677641611495, 576605.0, 639034.0, 646601.0, 647940.0, 649458.0, 45659.315110272706, 45905.77047114743, 46424.30363544482, 46648.06703865971, 47103.822404440165, 50248.49751502585, 50421.74789126031, 50477.0, 51066.23400648919, 51997.7400112997, 40895.910408958865, 41561.0, 42027.94930126771, 42511.57488425076, 42709.57290427056, 40311.596884031955, 40990.0, 41090.383644244765, 41165.4904622634, 42008.57991420047, 39714.801425992686, 39976.60023399729, 40428.1914361717, 40555.147261010155, 40572.79713601413, 30607.2348191297, 34935.0, 35310.07925938123, 35674.82162589274, 35719.821400892826, 25066.37334066663, 26066.478670426866, 26256.474870502865, 26732.732672673024, 26954.73045269522], "value": 20255.908790199155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6265920783178, 380.6440977685864, 385.7319163181589, 398.16981593377807, 404.3913909566103, 18038.4588462346, 19212.807871921294, 20523.692144617842, 21745.23891663794, 21776.346709598696, 17445.389411370605, 17952.55118622035, 20797.896010519966, 21445.034973426194, 21659.891700541477, 5296.867578310554, 5888.676122813244, 6090.8781824363705, 6100.298465676437, 6126.724297406605, 5984.222051133346, 6028.4272994065495, 6056.697165141747, 6058.787942422016, 6063.818085457443, 4947.194274089968, 5154.355705536808, 5988.902417117421, 6013.428724271187, 6026.126211699301, 5098.821541246039, 5759.280089988752, 5975.52195824333, 6023.969880150593, 6027.005544085243, 4542.977829988259, 5206.739663016872, 5229.738513074369, 5232.947670523284, 5234.6335756497065, 18412.631747364976, 25865.48269034609, 26139.346516337053, 26845.463090738074, 27193.86403067972, 2144.839137064711, 2246.3597874605657, 2284.497410569689, 2373.9525209495887, 2525.1414519063424, 10152.492375381202, 10411.323263987892, 12554.937225313906, 14679.706405871822, 15119.563641454044, 1875.943721688338, 1905.5426697592616, 1995.2916714566265, 2047.2936836791282, 2064.380685794271, 118604.0, 123766.0, 124505.37747311297, 124851.0, 125722.0, 11538.307701537935, 11564.942175289238, 11657.941710291394, 11691.590794322157, 11827.586034488751, 14753.557393278219, 14760.040597361138, 14798.778018329735, 14808.92595537037, 14838.183899885395, 8613.3109351253, 8670.13298670128, 8691.478511289217, 8721.869171962426, 8779.473231606124, 8574.78563035929, 8590.1839325264, 8629.137086291446, 8708.651653933772, 8726.04013558508, 4539.886502837456, 4637.9536204637525, 4641.327007583882, 4644.094401591725, 4712.340272361872, 1787.5888545634316, 1958.529952811315, 1962.5682349883002, 1975.9209631614574, 1976.071246514136, 859.879616853641, 945.9337846350827, 997.857453216078, 1024.9846252306222, 1053.947302634865, 19382.0, 21177.047032883558, 21197.25809596657, 21582.136714531556, 21693.457663558536, 865.7532603208056, 915.3135148638521, 944.4191822029402, 951.1582249709057, 996.0238965813543, 10991.670249892515, 11438.370889601152, 11444.713882153013, 11496.885031149748, 11506.906843849822, 559212.0, 563763.0, 572542.0, 573123.0, 575959.0, 125939.0, 126998.36500817622, 127262.0, 127379.0, 130440.0, 991.4299277915084, 993.5181437003048, 1007.9344842585208, 1008.68226508651, 1009.3540134314045, 18744.437666870017, 18950.715739263647, 18984.335548255745, 19109.904450477658, 19207.137446342724, 52060.0, 52480.475195247556, 52488.0, 52832.0, 52954.73522632516, 74205.62897185696, 74209.0, 75353.0, 75387.24612754022, 76210.0, 6664.933610622277, 8080.71717489885, 8239.958800206201, 8535.658573656985, 8605.225529702357, 9863.704088877344, 11854.703632409259, 12549.121561490609, 12691.936540317609, 12754.68113297175, 10669.413182274739, 10827.404492752974, 10828.404437755999, 10917.727056823644, 11031.558737650405, 10690.839637405601, 10783.245172837826, 10825.729356766144, 10911.83632245501, 11186.440677966231, 10996.28524145928, 10997.61508347204, 11207.327560346404, 11239.831402528805, 11274.605388811353, 8183.304419124441, 8273.83452330962, 8449.83100338002, 8509.702160424355, 8537.060923298557, 8181.590920454072, 9845.458499782295, 10827.67516974492, 11186.776264474502, 11253.212275140662], "value": 9615.514805352335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.286408252204, 1554.2461905975597, 1577.2429233967696, 1896.8672192946499, 1935.7289979402876, 6661.134052573158, 6858.382745552899, 7693.538387696742, 8528.275096616788, 9022.54887255638, 7572.280633339838, 8683.696070637528, 8819.470831750083, 8829.293656507463, 8846.849909511771, 2013.7816620944263, 2257.480779420726, 2351.1065794997876, 2380.6905102336673, 2381.428457170275, 2342.3558521406662, 2363.231949616373, 2385.439421735891, 2396.2212281008656, 2401.399650087478, 1984.7022946558059, 2367.3844800351944, 2369.407648087978, 2408.205292253561, 2408.7832095111435, 2342.730585982617, 2355.0815182079004, 2363.2791998440553, 2375.3349062262596, 2388.581998150317, 2328.720553533587, 2348.107719066744, 2356.0, 2359.315798418457, 2364.609839376501, 8809.779755506099, 8837.734867953972, 8881.955590222073, 8883.64465421389, 8907.109289071106, 5230.895382092337, 5267.236250743659, 5392.325959255093, 5437.728113594305, 5440.972795136038, 3542.5926018507944, 3614.0964758810296, 3694.2057457646733, 3702.2040261343673, 3709.5919448860604, 1059.1103473082649, 1068.743501559628, 1081.0541026152894, 1086.299336927685, 1110.123002827765, 11572.594959176473, 11760.88239117615, 11766.176367654267, 11767.646970590897, 11807.527698892034, 4730.52694730531, 4736.8342108026745, 4848.200046992278, 4849.054434385332, 4860.562549370574, 10009.549570269355, 10018.74953126163, 10026.448545330077, 10030.699079027641, 10073.647422340184, 5330.680159190383, 5342.038433082005, 5397.892042159214, 5409.486098820685, 5426.2674538936735, 4441.267190913528, 4818.132736107535, 4952.950470495321, 4956.925646115311, 4965.1311020571975, 3932.803359831997, 4013.494939397726, 4027.395890616431, 4066.6949978751713, 4167.91664166715, 1097.7365432296351, 1221.0536833953756, 1240.4480006397066, 1297.688554746854, 1308.0647337153791, 807.9394045446616, 925.726910561386, 934.4860326820221, 936.5317341329335, 982.042508554154, 5857.970710146422, 5975.133605627247, 6010.639361638228, 6044.972354699712, 6138.938610613926, 365.7110882402872, 422.35801581596417, 425.97870106495174, 429.72068155698423, 446.92291577298556, 3972.82122304497, 3989.6209860063245, 4059.106996460774, 4068.9389659155136, 4073.716779214538, 10329.276950613385, 10348.637797677045, 10535.367877927349, 10686.198535109897, 10704.1436685065, 10515.316504427188, 10630.30902991303, 10678.412687302272, 10719.249652524404, 10728.30266032721, 8028.879566806502, 8051.39614528901, 8322.126176751353, 8343.582820858812, 8356.039055508572, 5787.913181302368, 5826.271716035496, 5828.533717302521, 5955.40445955401, 5993.640381577119, 8074.273315401642, 9862.55618497155, 9917.603295868084, 10097.343672661253, 10174.389536627827, 8474.237318641352, 9807.411555306704, 9833.0, 10192.745181370525, 10236.641717539851, 5782.421757824184, 6796.694148763218, 7440.330370266702, 7505.211952744883, 7554.0, 8339.666413343399, 8372.958135209285, 8447.915520844714, 8456.619452124793, 8459.534725590152, 7343.302386273295, 7393.630318484162, 7519.849603008019, 7581.696732130874, 7624.656890439833, 7232.89150662751, 7305.707771689073, 7426.962865185639, 7552.546847189186, 7590.240975902366, 6041.6677082759115, 7066.893996589953, 7137.1435427749, 7142.464315176487, 7151.749688760869, 4642.907141857077, 4715.891765435052, 4944.085344211332, 5032.974835125948, 5063.1898896176435, 4320.546342633978, 5089.618278629044, 5147.356580427447, 5161.148410512224, 5250.474952504719], "value": 4480.678174811618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7026854219949, 317.82996097088056, 318.44908308626077, 319.9728023118035, 325.1043375500496, 5508.862278443036, 5535.363433205182, 5573.721313934302, 5589.972050139754, 5594.9369619772215, 4974.577160941324, 5449.618526703132, 5475.972620136894, 5486.725663716818, 5494.335247405005, 3937.625925537069, 4034.677225821942, 4082.142750022499, 4147.191297696951, 4160.4383408239955, 3459.9827000865084, 3508.631593682665, 3670.0457880950876, 4167.728842702974, 4169.332906734908, 3349.3971085204653, 3515.962790976668, 3838.9251009717323, 4035.778032208227, 4173.123644034757, 3986.720929534934, 4016.738911970742, 4121.711480196387, 4167.187398457318, 4172.77049762263, 2874.9712502875122, 3470.958712386274, 3477.4957631143598, 3578.5526809148855, 3592.8682465023694, 4177.916441671149, 5243.187305967581, 5243.528082472558, 5250.317458730379, 5253.894922101575, 3951.881443556669, 4021.959780402217, 4269.487661480611, 4627.0745850829635, 4811.470738218828, 5745.7127143643065, 5761.839310258653, 5775.364709881909, 5802.214936830303, 5807.2160258365, 3382.52644629752, 3980.20395920817, 3984.382420724792, 3988.1684004356944, 4034.394840773878, 5805.593608447411, 5896.027155519334, 5961.493273071837, 6117.357677443893, 6136.8772624547255, 3433.484977253432, 4043.090304681482, 4056.290149223874, 4077.347624380144, 4109.568495308009, 3523.3834079036064, 4087.6116768906904, 4135.669146468275, 4152.647025002848, 4195.937060944088, 3957.6240257175523, 4781.42622885256, 4792.0, 4820.758962051954, 4831.613470922318, 5066.721330326867, 5212.713300768494, 5629.746661400247, 5768.653880767168, 5851.590388672752, 1312.5406107862173, 1399.0416564653042, 1403.333416627094, 1403.9438422462988, 1411.8588141185799, 723.6828971272234, 829.6142293833396, 858.4677499949946, 874.7069731639845, 880.7886107334193, 4797.592204662643, 4869.634777391639, 5129.666571672829, 5155.845324640267, 5275.366955965309, 5957.314908785458, 5986.49114825236, 6012.098185272157, 6013.909791353133, 6014.789482368096, 4412.624926881251, 5092.7158193594205, 5244.842654720364, 5498.642588231752, 5578.9163162552595, 2946.6169397978124, 3115.8442077896466, 3121.843907804601, 3172.4131035757996, 3194.7284480818926, 5138.58891288696, 5267.789288428497, 5612.607117501817, 6275.152854364603, 6317.368263173737, 5285.312909321764, 5600.775968961278, 5610.523105535994, 5865.9441300566305, 6229.221347331583, 5371.62398632092, 6183.752649893954, 6312.715927783261, 6348.365163483615, 6361.332060133619, 5311.521963023347, 5716.971415142898, 5986.3115741688525, 5992.2809262886985, 6026.487748541248, 5225.555827754683, 5446.645968012067, 5659.207710920557, 5775.768969241183, 5937.673427961504, 5542.667439953616, 5993.730282137401, 6053.152558641706, 6267.6866156692895, 6303.716332764945, 3651.7626354286886, 3947.9013024673463, 3997.600239975979, 4001.639852413297, 4003.439518467475, 5261.053010458154, 5840.766369345349, 5965.522758179422, 6038.094285857156, 6104.908426373519, 4973.751312434436, 5481.287432633732, 5825.009748342707, 5834.679092649945, 5864.44287792659, 5166.3800343958965, 5367.785288588413, 5368.0406651572675, 5413.810516631899, 5594.916076258941, 5440.591955603425, 5728.598998070095, 5734.254546908875, 5745.827625171251, 5780.855478613068, 4818.855434336975, 5590.8043218487155, 5810.331811841524, 5833.7666493341485, 5851.444112809277, 4625.606823419912, 4788.832390866303, 5004.649674522894, 5771.624844385102, 5775.27809023872], "value": 4180.106800865046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.4017366887999, 804.8390321935615, 812.5206128384256, 831.6484567194209, 845.754731127973, 12547.37263136844, 14399.496017639385, 14921.92539037306, 15001.474948376781, 15251.161186134772, 12506.249625022505, 13799.931000344985, 13897.722045559109, 13929.233892135928, 13929.791053134211, 720.7693538067821, 905.4657751926378, 915.4370062411602, 921.230772305126, 924.3806649544788, 720.5640587444599, 925.1858364639141, 925.4863550729342, 929.7489677786994, 935.2190920581323, 967.0377973915963, 976.5166242709834, 976.9804603907918, 979.2459805949414, 983.1888691829233, 963.4363897120193, 968.0899954043247, 973.9610415583404, 974.3423189347197, 974.6978436684615, 723.2116992478171, 725.1696807155777, 726.4878260826158, 728.0789800901863, 730.109266694637, 14431.855681443156, 14611.78082328766, 14617.488387906373, 14633.975621706484, 14653.706925861423, 13638.249896255702, 13651.453941842314, 13666.794998075036, 13762.24307663078, 13929.164250145024, 9438.575264113131, 11273.60542381021, 11436.42817859112, 11716.53133874644, 11808.763824723543, 3703.6481534254203, 3750.79370634615, 3788.5453745550435, 3801.391777315644, 3944.3689009758587, 78209.82685259725, 78786.6060669693, 79689.0, 80962.0, 81607.5919620404, 10675.252732308663, 10686.305390149771, 10725.0, 10825.188110891715, 10839.566417343218, 20993.790062099488, 21102.683459748117, 21105.472363190736, 21124.366269011953, 21138.0, 6624.403803657694, 7777.766666999999, 7945.761627151079, 7980.960095199603, 8086.1913808618665, 4517.774111294422, 4545.4545454545005, 4566.315052742115, 4569.680122391401, 4628.907421851544, 2920.8977685780897, 3366.107981384935, 3443.0359499340225, 3454.240067185215, 3455.1707590178175, 579.6724850459477, 648.6036178990752, 662.460095022555, 672.8116127484312, 675.7769935921233, 550.4385526762679, 562.5864989232911, 582.7639805878626, 692.6467501574233, 696.5994553131969, 8645.524496152646, 9072.183503484717, 9097.90902090984, 9153.130452606993, 9362.765930851783, 581.1515187825737, 595.7557401465378, 658.1805651963336, 677.2989955396141, 685.1538350137577, 4247.447831781848, 4251.586912247826, 4336.739795612273, 4360.345948107809, 4399.868003959887, 82348.0, 83760.0, 84897.57551212204, 84903.0, 84970.72543911847, 75896.62051689706, 77105.61447192729, 77960.2713905022, 79386.0, 80921.0, 67844.6607766958, 69820.3017969824, 71209.0, 71463.55941080456, 72362.0, 7909.564973926259, 8220.506769593605, 8354.373421993254, 8468.576571171294, 8521.488710677379, 32047.839760801045, 44225.77887110544, 44288.0, 45401.31898021598, 45557.772211138734, 58034.129488058556, 58171.709141455714, 59861.0, 61205.0, 61469.692651536454, 10160.93310202418, 10205.591776328863, 10757.731056723644, 11138.918050241478, 11854.762904742029, 12036.157468977437, 12039.63881083569, 12040.638780836589, 12206.938965305117, 12262.938685306517, 9394.389364691273, 11281.830772538582, 11532.481038353126, 11616.419179040846, 11674.474648641002, 11221.990020898158, 11501.597444089417, 11571.594994175164, 11632.476538555955, 12039.0, 10935.671929842118, 11102.61140860066, 11120.555177793121, 11559.76880462403, 11674.941625292158, 8494.617742201739, 9235.399699019543, 9328.673496427593, 9596.23230141601, 10069.949650251994, 9163.221126204347, 9541.47521886303, 9581.377210481296, 9679.9032009679, 9739.853902191331], "value": 6994.260936248558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1626.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 110.0, 115.0, 114.0, 116.0, 116.0, 115.0, 114.0, 117.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 139.0, 155.0, 111.0, 166.0, 164.0, 148.0, 196.0, 148.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 200.0, 209.0, 238.0, 255.0, 255.0, 200.0, 197.0, 199.0, 195.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 76.0, 152.0, 65.0, 81.0, 81.0, 79.0, 142.0, 69.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 122.0, 64.0, 83.0, 129.0, 122.0, 60.0, 106.0, 157.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 89.0, 86.0, 104.0, 84.0, 76.0, 112.0, 100.0, 99.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 114.0, 154.0, 132.0, 107.0, 153.0, 150.0, 100.0, 95.0], "value": 119.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 91.0, 145.0, 144.0, 121.0, 90.0, 91.0, 91.0, 91.0], "value": 115.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 71.0, 58.0, 57.0, 58.0, 60.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 70.0, 80.0, 76.0, 80.0, 79.0, 66.0, 81.0, 100.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 110.0, 114.0, 110.0, 86.0, 87.0, 91.0, 90.0, 117.0, 87.0], "value": 97.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 116.0, 144.0, 138.0, 148.0, 151.0, 139.0, 172.0, 152.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 227.0, 195.0, 167.0, 167.0, 166.0, 164.0, 170.0, 169.0, 162.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 58.0, 75.0, 81.0, 59.0, 72.0, 64.0, 62.0, 82.0], "value": 68.6, "unit": "score"}]}]} 08:47:23 INFO - Return code: 0 08:47:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:47:23 ERROR - # TBPL SUCCESS # 08:47:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:23 INFO - 2016-05-30 08:47:23.963 screenresolution[2024:12693] starting screenresolution argv=screenresolution get 08:47:23 INFO - 2016-05-30 08:47:23.968 screenresolution[2024:12693] Display 0: 1600x1200x32@60 08:47:23 INFO - 2016-05-30 08:47:23.974 screenresolution[2025:12696] starting screenresolution argv=screenresolution list 08:47:23 INFO - Available Modes on Display 0 08:47:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:24 INFO - Intel Iris: 08:47:24 INFO - Chipset Model: Intel Iris 08:47:24 INFO - Type: GPU 08:47:24 INFO - Bus: Built-In 08:47:24 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:24 INFO - Vendor: Intel (0x8086) 08:47:24 INFO - Device ID: 0x0a2e 08:47:24 INFO - Revision ID: 0x0009 08:47:24 INFO - Displays: 08:47:24 INFO - Display: 08:47:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:24 INFO - Display Serial Number: 1600x1200 60 08:47:24 INFO - Main Display: Yes 08:47:24 INFO - Mirror: Off 08:47:24 INFO - Online: Yes 08:47:24 INFO - Rotation: Supported 08:47:24 INFO - Return code: 0 08:47:24 INFO - Running post-action listener: _resource_record_post_action 08:47:24 INFO - ##### 08:47:24 INFO - ##### Finished run-tests step (success) 08:47:24 INFO - ##### 08:47:24 INFO - Running post-run listener: _resource_record_post_run 08:47:24 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 458752; Write bytes: 698321920; Read time: 11; Write time: 1933 08:47:24 INFO - TinderboxPrint: CPU usage
54.3% 08:47:24 INFO - TinderboxPrint: I/O read bytes / time
458,752 / 11 08:47:24 INFO - TinderboxPrint: I/O write bytes / time
698,321,920 / 1,933 08:47:24 INFO - TinderboxPrint: CPU idle
2,211.7 (45.7%) 08:47:24 INFO - TinderboxPrint: CPU system
969.0 (20.0%) 08:47:24 INFO - TinderboxPrint: CPU user
1,656.9 (34.3%) 08:47:24 INFO - TinderboxPrint: Swap in / out
399,491,072 / 0 08:47:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378067456; Write bytes: 372307456; Read time: 28094; Write time: 654 08:47:24 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 450560; Write bytes: 296723968; Read time: 10; Write time: 1228 08:47:24 INFO - Running post-run listener: _upload_blobber_files 08:47:24 INFO - Blob upload gear active. 08:47:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:24 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 08:47:24 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:47:24 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:47:25 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:25 INFO - (blobuploader) - INFO - Done attempting. 08:47:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:47:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:26 INFO - (blobuploader) - INFO - Done attempting. 08:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:29 INFO - (blobuploader) - INFO - Done attempting. 08:47:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:29 INFO - Return code: 0 08:47:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef4da7ad75c196c4e3b5933d84948ef4dada0af4efe2b7884c34873056868ebece190ca7f9ec73032a7bdad981d97281d419506cdd87c5c7900f9a603fcf4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2714e3f25bfd9dddc4bb90db45bed192f0093b6d8da0e43cfa80d155a86f1cb1375fade84a363850ff310529a13b847fbe853a50458c7faccd29f8960e546b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487373c417ce19cc23fc02ec0a7a3d5a2af018a88105a1a6e9bf9e33c78e443ac4c2134ad97439bf9d31c54be21ffa585c9809ec4acf5fec8b77c8624e61906d"} 08:47:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:29 INFO - Contents: 08:47:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef4da7ad75c196c4e3b5933d84948ef4dada0af4efe2b7884c34873056868ebece190ca7f9ec73032a7bdad981d97281d419506cdd87c5c7900f9a603fcf4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2714e3f25bfd9dddc4bb90db45bed192f0093b6d8da0e43cfa80d155a86f1cb1375fade84a363850ff310529a13b847fbe853a50458c7faccd29f8960e546b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487373c417ce19cc23fc02ec0a7a3d5a2af018a88105a1a6e9bf9e33c78e443ac4c2134ad97439bf9d31c54be21ffa585c9809ec4acf5fec8b77c8624e61906d"} 08:47:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:29 INFO - Copying logs to upload dir... 08:47:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.389324 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-05-30 08:47:29.309808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:47:29.313330) ========= 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.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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/Firefox/sha512/ef4da7ad75c196c4e3b5933d84948ef4dada0af4efe2b7884c34873056868ebece190ca7f9ec73032a7bdad981d97281d419506cdd87c5c7900f9a603fcf4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2714e3f25bfd9dddc4bb90db45bed192f0093b6d8da0e43cfa80d155a86f1cb1375fade84a363850ff310529a13b847fbe853a50458c7faccd29f8960e546b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487373c417ce19cc23fc02ec0a7a3d5a2af018a88105a1a6e9bf9e33c78e443ac4c2134ad97439bf9d31c54be21ffa585c9809ec4acf5fec8b77c8624e61906d"} build_url:https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010585 build_url: 'https://queue.taskcluster.net/v1/task/KHlJ8A2TTVSm_YrPrykA6Q/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef4da7ad75c196c4e3b5933d84948ef4dada0af4efe2b7884c34873056868ebece190ca7f9ec73032a7bdad981d97281d419506cdd87c5c7900f9a603fcf4735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de2714e3f25bfd9dddc4bb90db45bed192f0093b6d8da0e43cfa80d155a86f1cb1375fade84a363850ff310529a13b847fbe853a50458c7faccd29f8960e546b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487373c417ce19cc23fc02ec0a7a3d5a2af018a88105a1a6e9bf9e33c78e443ac4c2134ad97439bf9d31c54be21ffa585c9809ec4acf5fec8b77c8624e61906d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:47:29.347804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:47:29.348522) ========= 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.fXuXm0uldR/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.X6ViNQbhsm/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005274 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:47:29.401683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:47:29.402355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:47:29.403053) ========= ========= Total master_lag: 2.67 =========