builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0123 starttime: 1462509828.76 results: success (0) buildid: 20160505194926 builduid: 959b9947972647ba9ffd3d478d6a377d revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.759699) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.760128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.760399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.781654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.781942) ========= 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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-05 21:43:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.5M=0s 2016-05-05 21:43:48 (28.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.919180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.919487) ========= 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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.020418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.968357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:48.969560) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 25d777f7efb357fc5478251913548521986abaa0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 25d777f7efb357fc5478251913548521986abaa0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-05 21:43:49,043 truncating revision to first 12 chars 2016-05-05 21:43:49,043 Setting DEBUG logging. 2016-05-05 21:43:49,043 attempt 1/10 2016-05-05 21:43:49,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/25d777f7efb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 21:43:49,718 unpacking tar archive at: fx-team-25d777f7efb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920794 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:49.906641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:49.906952) ========= script_repo_revision: 25d777f7efb357fc5478251913548521986abaa0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:49.907318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:49.907587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 21:43:49.920713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-05-05 21:43:49.920984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:43:50 INFO - MultiFileLogger online at 20160505 21:43:50 in /builds/slave/test 21:43:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:43:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:43:50 INFO - {'append_to_log': False, 21:43:50 INFO - 'base_work_dir': '/builds/slave/test', 21:43:50 INFO - 'blob_upload_branch': 'Fx-Team', 21:43:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:43:50 INFO - 'branch': 'Fx-Team', 21:43:50 INFO - 'buildbot_json_path': 'buildprops.json', 21:43:50 INFO - 'config_files': ('talos/mac_config.py',), 21:43:50 INFO - 'default_actions': ('clobber', 21:43:50 INFO - 'read-buildbot-config', 21:43:50 INFO - 'download-and-extract', 21:43:50 INFO - 'populate-webroot', 21:43:50 INFO - 'create-virtualenv', 21:43:50 INFO - 'install', 21:43:50 INFO - 'run-tests'), 21:43:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:43:50 INFO - 'download_minidump_stackwalk': True, 21:43:50 INFO - 'download_symbols': 'ondemand', 21:43:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:43:50 INFO - 'tooltool.py': '/tools/tooltool.py', 21:43:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:43:50 INFO - '/tools/misc-python/virtualenv.py')}, 21:43:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:43:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:43:50 INFO - 'installer_path': 'installer.exe', 21:43:50 INFO - 'log_level': 'info', 21:43:50 INFO - 'log_name': 'talos', 21:43:50 INFO - 'log_to_console': True, 21:43:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:43:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:43:50 INFO - 'opt_config_files': (), 21:43:50 INFO - 'pip_index': False, 21:43:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:43:50 INFO - 'cmd': ('bash', 21:43:50 INFO - '-c', 21:43:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:43:50 INFO - 'enabled': True, 21:43:50 INFO - 'halt_on_failure': False, 21:43:50 INFO - 'name': 'check_screen_resolution'},), 21:43:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:43:50 INFO - 'cmd': ('bash', 21:43:50 INFO - '-c', 21:43:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:43:50 INFO - 'enabled': True, 21:43:50 INFO - 'halt_on_failure': False, 21:43:50 INFO - 'name': 'check_screen_resolution'},), 21:43:50 INFO - 'run_cmd_checks_enabled': True, 21:43:50 INFO - 'sps_profile': False, 21:43:50 INFO - 'sps_profile_interval': 0, 21:43:50 INFO - 'suite': 'dromaeojs-e10s', 21:43:50 INFO - 'system_bits': '32', 21:43:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:43:50 INFO - 'title': 't-yosemite-r7-0123', 21:43:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:43:50 INFO - 'use_talos_json': True, 21:43:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:43:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:43:50 INFO - 'work_dir': 'build'} 21:43:50 INFO - ##### 21:43:50 INFO - ##### Running clobber step. 21:43:50 INFO - ##### 21:43:50 INFO - Running pre-action listener: _resource_record_pre_action 21:43:50 INFO - Running main action method: clobber 21:43:50 INFO - rmtree: /builds/slave/test/build 21:43:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:43:52 INFO - Running post-action listener: _resource_record_post_action 21:43:52 INFO - ##### 21:43:52 INFO - ##### Running read-buildbot-config step. 21:43:52 INFO - ##### 21:43:52 INFO - Running pre-action listener: _resource_record_pre_action 21:43:52 INFO - Running main action method: read_buildbot_config 21:43:52 INFO - Using buildbot properties: 21:43:52 INFO - { 21:43:52 INFO - "project": "", 21:43:52 INFO - "product": "firefox", 21:43:52 INFO - "script_repo_revision": "production", 21:43:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:43:52 INFO - "repository": "", 21:43:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:43:52 INFO - "buildid": "20160505194926", 21:43:52 INFO - "pgo_build": "False", 21:43:52 INFO - "basedir": "/builds/slave/test", 21:43:52 INFO - "buildnumber": 1, 21:43:52 INFO - "slavename": "t-yosemite-r7-0123", 21:43:52 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:43:52 INFO - "platform": "yosemite_r7", 21:43:52 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:43:52 INFO - "branch": "fx-team", 21:43:52 INFO - "repo_path": "integration/fx-team", 21:43:52 INFO - "revision": "25d777f7efb357fc5478251913548521986abaa0", 21:43:52 INFO - "stage_platform": "macosx64", 21:43:52 INFO - "builduid": "959b9947972647ba9ffd3d478d6a377d", 21:43:52 INFO - "slavebuilddir": "test" 21:43:52 INFO - } 21:43:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 21:43:52 INFO - Running post-action listener: _resource_record_post_action 21:43:52 INFO - ##### 21:43:52 INFO - ##### Running download-and-extract step. 21:43:52 INFO - ##### 21:43:52 INFO - Running pre-action listener: _resource_record_pre_action 21:43:52 INFO - Running main action method: download_and_extract 21:43:52 INFO - mkdir: /builds/slave/test/build/tests 21:43:52 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')]} 21:43:52 INFO - https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 21:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 21:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:52 INFO - Downloaded 1199 bytes. 21:43:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 21:43:52 INFO - Using the following test package requirements: 21:43:52 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 21:43:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 21:43:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 21:43:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'jsshell-mac.zip'], 21:43:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 21:43:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 21:43:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 21:43:52 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 21:43:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 21:43:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 21:43:52 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 21:43:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:43:52 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')]} 21:43:52 INFO - https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 21:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 21:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:54 INFO - Downloaded 18145047 bytes. 21:43:54 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'] 21:43:54 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 21:43:57 INFO - Return code: 0 21:43:57 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 21:43:57 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')]} 21:43:57 INFO - https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 21:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 21:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:43:58 INFO - Downloaded 18145047 bytes. 21:43:58 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'] 21:43:58 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 21:44:02 INFO - Return code: 0 21:44:02 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')]} 21:44:02 INFO - https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 21:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 21:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:44:03 INFO - Downloaded 10840152 bytes. 21:44:03 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'] 21:44:03 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 21:44:03 INFO - Return code: 0 21:44:03 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')]} 21:44:03 INFO - https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 21:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 21:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 21:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a-HM1tB0QAeVMMi0gOW_jw/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 21:44:10 INFO - Downloaded 110404381 bytes. 21:44:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 21:44:10 INFO - mkdir: /builds/slave/test/properties 21:44:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:44:10 INFO - Writing to file /builds/slave/test/properties/build_url 21:44:10 INFO - Contents: 21:44:10 INFO - build_url:https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 21:44:11 INFO - Running post-action listener: _resource_record_post_action 21:44:11 INFO - Running post-action listener: set_extra_try_arguments 21:44:11 INFO - ##### 21:44:11 INFO - ##### Running populate-webroot step. 21:44:11 INFO - ##### 21:44:11 INFO - Running pre-action listener: _resource_record_pre_action 21:44:11 INFO - Running main action method: populate_webroot 21:44:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:44:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:44:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:44:11 INFO - '--tppagecycles', 21:44:11 INFO - '7'], 21:44:11 INFO - 'tests': ['tsvgm']}}, 21:44:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:44:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:44:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:44:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:44:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:44:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:44:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['damp', 'tps']}, 21:44:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'tests': ['damp', 'tps']}, 21:44:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['dromaeo_dom']}, 21:44:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:44:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'other-e10s': {'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['a11yr', 21:44:11 INFO - 'ts_paint', 21:44:11 INFO - 'tpaint', 21:44:11 INFO - 'sessionrestore', 21:44:11 INFO - 'sessionrestore_no_auto_restore', 21:44:11 INFO - 'tabpaint']}, 21:44:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['tsvgx', 21:44:11 INFO - 'tsvgr_opacity', 21:44:11 INFO - 'tart', 21:44:11 INFO - 'tscrollx', 21:44:11 INFO - 'cart']}, 21:44:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:44:11 INFO - 'tsvgr_opacity', 21:44:11 INFO - 'tart', 21:44:11 INFO - 'tscrollx', 21:44:11 INFO - 'cart']}, 21:44:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'talos_options': ['--disable-e10s'], 21:44:11 INFO - 'tests': ['tp5o']}, 21:44:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'tests': ['tp5o']}, 21:44:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'talos_options': ['--disable-e10s', 21:44:11 INFO - '--xperf_path', 21:44:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:44:11 INFO - 'tests': ['tp5n']}, 21:44:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:44:11 INFO - 'talos_options': ['--xperf_path', 21:44:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:44:11 INFO - 'tests': ['tp5n']}}, 21:44:11 INFO - 'talos.zip': {'path': '', 21:44:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:44:11 INFO - Running post-action listener: _resource_record_post_action 21:44:11 INFO - ##### 21:44:11 INFO - ##### Running create-virtualenv step. 21:44:11 INFO - ##### 21:44:11 INFO - Running pre-action listener: _resource_record_pre_action 21:44:11 INFO - Running main action method: create_virtualenv 21:44:11 INFO - Creating virtualenv /builds/slave/test/build/venv 21:44:11 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 21:44:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:44:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:44:11 INFO - Using real prefix '/tools/python27' 21:44:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:44:12 INFO - Installing distribute.............................................................................................................................................................................................done. 21:44:14 INFO - Installing pip.................done. 21:44:14 INFO - Return code: 0 21:44:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:44:14 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')]} 21:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:14 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')]} 21:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:14 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 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:14 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 21:44:14 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 21:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:14 INFO - 'HOME': '/Users/cltbld', 21:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:14 INFO - 'LOGNAME': 'cltbld', 21:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:14 INFO - 'MOZ_NO_REMOTE': '1', 21:44:14 INFO - 'NO_EM_RESTART': '1', 21:44:14 INFO - 'PAGER': '/bin/cat', 21:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:14 INFO - 'PWD': '/builds/slave/test', 21:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:14 INFO - 'SHELL': '/bin/bash', 21:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:14 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:14 INFO - 'USER': 'cltbld', 21:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:14 INFO - 'XPC_FLAGS': '0x0', 21:44:14 INFO - 'XPC_SERVICE_NAME': '0', 21:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:15 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 21:44:15 INFO - Cleaning up... 21:44:15 INFO - Return code: 0 21:44:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:15 INFO - 'HOME': '/Users/cltbld', 21:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:15 INFO - 'LOGNAME': 'cltbld', 21:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:15 INFO - 'MOZ_NO_REMOTE': '1', 21:44:15 INFO - 'NO_EM_RESTART': '1', 21:44:15 INFO - 'PAGER': '/bin/cat', 21:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:15 INFO - 'PWD': '/builds/slave/test', 21:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:15 INFO - 'SHELL': '/bin/bash', 21:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:15 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:15 INFO - 'USER': 'cltbld', 21:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:15 INFO - 'XPC_FLAGS': '0x0', 21:44:15 INFO - 'XPC_SERVICE_NAME': '0', 21:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:15 INFO - Downloading/unpacking psutil>=0.7.1 21:44:15 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 21:44:15 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 21:44:15 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 21:44:15 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 21:44:15 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 21:44:15 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 21:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:44:18 INFO - Installing collected packages: psutil 21:44:18 INFO - Running setup.py install for psutil 21:44:18 INFO - building 'psutil._psutil_osx' extension 21:44:18 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 21:44:18 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 21:44:18 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 21:44:18 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 21:44:18 INFO - building 'psutil._psutil_posix' extension 21:44:18 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 21:44:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:44:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:44:19 INFO - ^ 21:44:19 INFO - 1 warning generated. 21:44:19 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 21:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:44:19 INFO - Successfully installed psutil 21:44:19 INFO - Cleaning up... 21:44:19 INFO - Return code: 0 21:44:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:19 INFO - 'HOME': '/Users/cltbld', 21:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:19 INFO - 'LOGNAME': 'cltbld', 21:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:19 INFO - 'MOZ_NO_REMOTE': '1', 21:44:19 INFO - 'NO_EM_RESTART': '1', 21:44:19 INFO - 'PAGER': '/bin/cat', 21:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:19 INFO - 'PWD': '/builds/slave/test', 21:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:19 INFO - 'SHELL': '/bin/bash', 21:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:19 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:19 INFO - 'USER': 'cltbld', 21:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:19 INFO - 'XPC_FLAGS': '0x0', 21:44:19 INFO - 'XPC_SERVICE_NAME': '0', 21:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:44:22 INFO - Installing collected packages: mozsystemmonitor 21:44:22 INFO - Running setup.py install for mozsystemmonitor 21:44:22 INFO - Successfully installed mozsystemmonitor 21:44:22 INFO - Cleaning up... 21:44:22 INFO - Return code: 0 21:44:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:44:22 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')]} 21:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:22 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')]} 21:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:22 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 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:22 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 21:44:22 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 21:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:22 INFO - 'HOME': '/Users/cltbld', 21:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:22 INFO - 'LOGNAME': 'cltbld', 21:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:22 INFO - 'MOZ_NO_REMOTE': '1', 21:44:22 INFO - 'NO_EM_RESTART': '1', 21:44:22 INFO - 'PAGER': '/bin/cat', 21:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:22 INFO - 'PWD': '/builds/slave/test', 21:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:22 INFO - 'SHELL': '/bin/bash', 21:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:22 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:22 INFO - 'USER': 'cltbld', 21:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:22 INFO - 'XPC_FLAGS': '0x0', 21:44:22 INFO - 'XPC_SERVICE_NAME': '0', 21:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:22 INFO - Downloading/unpacking blobuploader==1.2.4 21:44:22 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 21:44:22 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 21:44:22 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 21:44:22 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 21:44:22 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 21:44:22 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 21:44:24 INFO - Downloading blobuploader-1.2.4.tar.gz 21:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:44:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:44:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:25 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 21:44:26 INFO - Downloading docopt-0.6.1.tar.gz 21:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:44:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:44:26 INFO - Running setup.py install for blobuploader 21:44:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:44:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:44:26 INFO - Running setup.py install for requests 21:44:26 INFO - Running setup.py install for docopt 21:44:26 INFO - Successfully installed blobuploader requests docopt 21:44:26 INFO - Cleaning up... 21:44:27 INFO - Return code: 0 21:44:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:27 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')]} 21:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:27 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')]} 21:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:27 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 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:27 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 21:44:27 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 21:44:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:27 INFO - 'HOME': '/Users/cltbld', 21:44:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:27 INFO - 'LOGNAME': 'cltbld', 21:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:27 INFO - 'MOZ_NO_REMOTE': '1', 21:44:27 INFO - 'NO_EM_RESTART': '1', 21:44:27 INFO - 'PAGER': '/bin/cat', 21:44:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:27 INFO - 'PWD': '/builds/slave/test', 21:44:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:27 INFO - 'SHELL': '/bin/bash', 21:44:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:27 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:27 INFO - 'USER': 'cltbld', 21:44:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:27 INFO - 'XPC_FLAGS': '0x0', 21:44:27 INFO - 'XPC_SERVICE_NAME': '0', 21:44:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-gu0o8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-D4IrHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-mw2rjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-JdUGH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-_mwpwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-K83vWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:44:27 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NprYbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-gac8FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-nt3KYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-FQWyBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-b1fhhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7j7u7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ZiYsbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-aFJNoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-yvlxOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-9czCEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:44:28 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-1aMvVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:44:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:44:29 INFO - Running setup.py install for manifestparser 21:44:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:44:29 INFO - Running setup.py install for mozcrash 21:44:29 INFO - Running setup.py install for mozdebug 21:44:29 INFO - Running setup.py install for mozdevice 21:44:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:44:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:44:29 INFO - Running setup.py install for mozfile 21:44:29 INFO - Running setup.py install for mozhttpd 21:44:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:44:29 INFO - Running setup.py install for mozinfo 21:44:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Running setup.py install for mozInstall 21:44:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Running setup.py install for mozleak 21:44:30 INFO - Running setup.py install for mozlog 21:44:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Running setup.py install for moznetwork 21:44:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:44:30 INFO - Running setup.py install for mozprocess 21:44:30 INFO - Running setup.py install for mozprofile 21:44:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:44:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:44:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:44:31 INFO - Running setup.py install for mozrunner 21:44:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:44:31 INFO - Running setup.py install for mozscreenshot 21:44:31 INFO - Running setup.py install for moztest 21:44:31 INFO - Running setup.py install for mozversion 21:44:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:44:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:44:31 INFO - Cleaning up... 21:44:31 INFO - Return code: 0 21:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:31 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 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:31 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 21:44:31 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 21:44:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:31 INFO - 'HOME': '/Users/cltbld', 21:44:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:31 INFO - 'LOGNAME': 'cltbld', 21:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:31 INFO - 'MOZ_NO_REMOTE': '1', 21:44:31 INFO - 'NO_EM_RESTART': '1', 21:44:31 INFO - 'PAGER': '/bin/cat', 21:44:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:31 INFO - 'PWD': '/builds/slave/test', 21:44:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:31 INFO - 'SHELL': '/bin/bash', 21:44:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:31 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:31 INFO - 'USER': 'cltbld', 21:44:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:31 INFO - 'XPC_FLAGS': '0x0', 21:44:31 INFO - 'XPC_SERVICE_NAME': '0', 21:44:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:44:31 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-74ZV4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ItKPh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ElEfq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Npa70I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-CSTsLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-z0Z8KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-KwMWu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-tLyyd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-oZRztj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:44:32 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)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-JVE34A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:44:32 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-GSRD6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-56bqCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-qZDO5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-uUpR2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-45Wu2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-fe6xOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:44:33 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)) 21:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:44:33 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-yja1oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:44:33 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)) 21:44:33 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)) 21:44:33 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)) 21:44:33 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)) 21:44:33 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)) 21:44:33 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)) 21:44:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:36 INFO - Downloading blessings-1.6.tar.gz 21:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:44:36 INFO - Installing collected packages: blessings 21:44:36 INFO - Running setup.py install for blessings 21:44:36 INFO - Successfully installed blessings 21:44:36 INFO - Cleaning up... 21:44:36 INFO - Return code: 0 21:44:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:36 INFO - Reading from file tmpfile_stdout 21:44:36 INFO - Current package versions: 21:44:36 INFO - blessings == 1.6 21:44:36 INFO - blobuploader == 1.2.4 21:44:36 INFO - docopt == 0.6.1 21:44:36 INFO - manifestparser == 1.1 21:44:36 INFO - mozInstall == 1.12 21:44:36 INFO - mozcrash == 0.17 21:44:36 INFO - mozdebug == 0.1 21:44:36 INFO - mozdevice == 0.48 21:44:36 INFO - mozfile == 1.2 21:44:36 INFO - mozhttpd == 0.7 21:44:36 INFO - mozinfo == 0.9 21:44:36 INFO - mozleak == 0.1 21:44:36 INFO - mozlog == 3.1 21:44:36 INFO - moznetwork == 0.27 21:44:36 INFO - mozprocess == 0.22 21:44:36 INFO - mozprofile == 0.28 21:44:36 INFO - mozrunner == 6.11 21:44:36 INFO - mozscreenshot == 0.1 21:44:36 INFO - mozsystemmonitor == 0.0 21:44:36 INFO - moztest == 0.7 21:44:36 INFO - mozversion == 1.4 21:44:36 INFO - psutil == 3.1.1 21:44:36 INFO - requests == 1.2.3 21:44:36 INFO - wsgiref == 0.1.2 21:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:44: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')]} 21:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44: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')]} 21:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:36 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 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:36 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 21:44:36 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 21:44:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:36 INFO - 'HOME': '/Users/cltbld', 21:44:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:36 INFO - 'LOGNAME': 'cltbld', 21:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:36 INFO - 'MOZ_NO_REMOTE': '1', 21:44:36 INFO - 'NO_EM_RESTART': '1', 21:44:36 INFO - 'PAGER': '/bin/cat', 21:44:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:36 INFO - 'PWD': '/builds/slave/test', 21:44:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:36 INFO - 'SHELL': '/bin/bash', 21:44:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:36 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:36 INFO - 'USER': 'cltbld', 21:44:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:36 INFO - 'XPC_FLAGS': '0x0', 21:44:36 INFO - 'XPC_SERVICE_NAME': '0', 21:44:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 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)) 21:44:36 INFO - Cleaning up... 21:44:37 INFO - Return code: 0 21:44:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:44:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:37 INFO - 'HOME': '/Users/cltbld', 21:44:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:37 INFO - 'LOGNAME': 'cltbld', 21:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:37 INFO - 'MOZ_NO_REMOTE': '1', 21:44:37 INFO - 'NO_EM_RESTART': '1', 21:44:37 INFO - 'PAGER': '/bin/cat', 21:44:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:37 INFO - 'PWD': '/builds/slave/test', 21:44:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:37 INFO - 'SHELL': '/bin/bash', 21:44:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:37 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:37 INFO - 'USER': 'cltbld', 21:44:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:37 INFO - 'XPC_FLAGS': '0x0', 21:44:37 INFO - 'XPC_SERVICE_NAME': '0', 21:44:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:37 INFO - Downloading/unpacking jsonschema 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:44:39 INFO - Downloading/unpacking functools32 (from jsonschema) 21:44:39 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 21:44:39 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 21:44:39 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 21:44:39 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 21:44:39 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 21:44:39 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 21:44:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:44:40 INFO - warning: no files found matching '*.txt' 21:44:40 INFO - no previously-included directories found matching 'build' 21:44:40 INFO - no previously-included directories found matching 'dist' 21:44:40 INFO - no previously-included directories found matching '.git*' 21:44:40 INFO - Installing collected packages: jsonschema, functools32 21:44:40 INFO - Running setup.py install for functools32 21:44:40 INFO - warning: no files found matching '*.txt' 21:44:40 INFO - no previously-included directories found matching 'build' 21:44:40 INFO - no previously-included directories found matching 'dist' 21:44:40 INFO - no previously-included directories found matching '.git*' 21:44:40 INFO - Successfully installed jsonschema functools32 21:44:40 INFO - Cleaning up... 21:44:40 INFO - Return code: 0 21:44:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:44:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb63da44b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, '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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 21:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:44:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:44:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:44:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:44:40 INFO - 'HOME': '/Users/cltbld', 21:44:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:44:40 INFO - 'LOGNAME': 'cltbld', 21:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:44:40 INFO - 'MOZ_NO_REMOTE': '1', 21:44:40 INFO - 'NO_EM_RESTART': '1', 21:44:40 INFO - 'PAGER': '/bin/cat', 21:44:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:44:40 INFO - 'PWD': '/builds/slave/test', 21:44:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:44:40 INFO - 'SHELL': '/bin/bash', 21:44:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:44:40 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:44:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:44:40 INFO - 'USER': 'cltbld', 21:44:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:44:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:44:40 INFO - 'XPC_FLAGS': '0x0', 21:44:40 INFO - 'XPC_SERVICE_NAME': '0', 21:44:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:44:40 INFO - Downloading/unpacking flake8 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:44:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:44:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:44:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44: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 21:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:44:45 INFO - no previously-included directories found matching 'docs/_build' 21:44:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:44:45 INFO - Running setup.py install for pep8 21:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:44:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:44:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:44:45 INFO - no previously-included directories found matching 'docs/_build' 21:44:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:44:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:44:45 INFO - Cleaning up... 21:44:45 INFO - Return code: 0 21:44:45 INFO - Running post-action listener: _resource_record_post_action 21:44:45 INFO - Running post-action listener: _start_resource_monitoring 21:44:45 INFO - Starting resource monitoring. 21:44:45 INFO - ##### 21:44:45 INFO - ##### Running install step. 21:44:45 INFO - ##### 21:44:45 INFO - Running pre-action listener: _resource_record_pre_action 21:44:45 INFO - Running main action method: install 21:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:44:45 INFO - Reading from file tmpfile_stdout 21:44:45 INFO - Detecting whether we're running mozinstall >=1.0... 21:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:44:46 INFO - Reading from file tmpfile_stdout 21:44:46 INFO - Output received: 21:44:46 INFO - Usage: mozinstall [options] installer 21:44:46 INFO - Options: 21:44:46 INFO - -h, --help show this help message and exit 21:44:46 INFO - -d DEST, --destination=DEST 21:44:46 INFO - Directory to install application into. [default: 21:44:46 INFO - "/builds/slave/test"] 21:44:46 INFO - --app=APP Application being installed. [default: firefox] 21:44:46 INFO - mkdir: /builds/slave/test/build/application 21:44:46 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'] 21:44:46 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 21:45:19 INFO - Reading from file tmpfile_stdout 21:45:19 INFO - Output received: 21:45:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:45:19 INFO - Running post-action listener: _resource_record_post_action 21:45:19 INFO - ##### 21:45:19 INFO - ##### Running run-tests step. 21:45:19 INFO - ##### 21:45:19 INFO - Running pre-action listener: _resource_record_pre_action 21:45:19 INFO - Running main action method: run_tests 21:45:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:45:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:45:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:45:19 INFO - 2016-05-05 21:45:19.707 screenresolution[2258:81262] starting screenresolution argv=screenresolution get 21:45:19 INFO - 2016-05-05 21:45:19.710 screenresolution[2258:81262] Display 0: 1600x1200x32@60 21:45:19 INFO - 2016-05-05 21:45:19.716 screenresolution[2259:81265] starting screenresolution argv=screenresolution list 21:45:19 INFO - Available Modes on Display 0 21:45:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:45:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:45:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:45:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:45:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:45:19 INFO - Intel Iris: 21:45:19 INFO - Chipset Model: Intel Iris 21:45:19 INFO - Type: GPU 21:45:19 INFO - Bus: Built-In 21:45:19 INFO - VRAM (Dynamic, Max): 1536 MB 21:45:19 INFO - Vendor: Intel (0x8086) 21:45:19 INFO - Device ID: 0x0a2e 21:45:19 INFO - Revision ID: 0x0009 21:45:19 INFO - Displays: 21:45:19 INFO - Display: 21:45:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:45:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:45:19 INFO - Display Serial Number: 1600x1200 60 21:45:19 INFO - Main Display: Yes 21:45:19 INFO - Mirror: Off 21:45:19 INFO - Online: Yes 21:45:19 INFO - Rotation: Supported 21:45:19 INFO - Return code: 0 21:45:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:45:19 INFO - Python 2.7.3 21:45:19 INFO - Return code: 0 21:45:19 INFO - grabbing minidump binary from tooltool 21:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a7fe00>, '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 0x1038e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:45:19 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 21:45:19 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 21:45:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:45:20 INFO - Return code: 0 21:45:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:45:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:45:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:45:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:45:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:45:21 INFO - Return code: 0 21:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 21:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 21:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rzlm7HK8Iq/Render', 21:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:21 INFO - 'HOME': '/Users/cltbld', 21:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:21 INFO - 'LOGNAME': 'cltbld', 21:45:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:45:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:21 INFO - 'MOZ_NO_REMOTE': '1', 21:45:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:45:21 INFO - 'NO_EM_RESTART': '1', 21:45:21 INFO - 'PAGER': '/bin/cat', 21:45:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:21 INFO - 'PWD': '/builds/slave/test', 21:45:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:21 INFO - 'SHELL': '/bin/bash', 21:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KUENdq1FyL/Listeners', 21:45:21 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 21:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:21 INFO - 'USER': 'cltbld', 21:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:21 INFO - 'XPC_FLAGS': '0x0', 21:45:21 INFO - 'XPC_SERVICE_NAME': '0', 21:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 21:45:21 INFO - mozversion application_buildid: 20160505194926 21:45:21 INFO - mozversion application_changeset: 25d777f7efb357fc5478251913548521986abaa0 21:45:21 INFO - mozversion application_display_name: Nightly 21:45:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:45:21 INFO - mozversion application_name: Firefox 21:45:21 INFO - mozversion application_remotingname: firefox 21:45:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:45:21 INFO - mozversion application_vendor: Mozilla 21:45:21 INFO - mozversion application_version: 49.0a1 21:45:21 INFO - mozversion platform_buildid: 20160505194926 21:45:21 INFO - mozversion platform_changeset: 25d777f7efb357fc5478251913548521986abaa0 21:45:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:45:21 INFO - mozversion platform_version: 49.0a1 21:45:21 INFO - using testdate: 1462509921 21:45:21 INFO - actual date: 1462509921 21:45:21 INFO - starting webserver on 'localhost:53948' 21:45:21 INFO - SUITE-START | Running 2 tests 21:45:21 INFO - TEST-START | dromaeo_css 21:45:21 INFO - operating with platform_type : mac_ 21:45:21 INFO - Initialising browser for dromaeo_css test... 21:45:21 INFO - TEST-INFO | started process 2277 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmp0Fx0iD/profile http://localhost:53948/getInfo.html) 21:45:24 INFO - PROCESS | 2277 | __metrics Screen width/height:1600/1200 21:45:24 INFO - PROCESS | 2277 | colorDepth:24 21:45:24 INFO - PROCESS | 2277 | Browser inner width/height: 1024/689 21:45:24 INFO - PROCESS | 2277 | __metrics 21:45:24 ERROR - PROCESS | 2277 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:45:25 INFO - TEST-INFO | 2277: exit 0 21:45:25 INFO - Browser initialized. 21:45:25 INFO - Running cycle 1/1 for dromaeo_css test... 21:45:25 INFO - TEST-INFO | started process 2280 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmp0Fx0iD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:37 INFO - PROCESS | 2280 | RSS: Main: 250195968 21:45:37 INFO - PROCESS | 2280 | 21:46:26 INFO - PROCESS | 2280 | 1462509986667 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] 21:48:37 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53948/tests/dromaeo/cssquery-ext.html) 21:48:39 INFO - PROCESS | 2280 | RSS: Main: 262819840 21:48:39 INFO - PROCESS | 2280 | 21:51:41 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-ext.html (next: http://localhost:53948/tests/dromaeo/cssquery-jquery.html) 21:51:41 INFO - PROCESS | 2280 | RSS: Main: 274001920 21:51:41 INFO - PROCESS | 2280 | 21:54:43 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53948/tests/dromaeo/cssquery-mootools.html) 21:54:44 INFO - PROCESS | 2280 | RSS: Main: 275865600 21:54:44 INFO - PROCESS | 2280 | 21:57:46 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53948/tests/dromaeo/cssquery-prototype.html) 21:57:46 INFO - PROCESS | 2280 | RSS: Main: 277311488 21:57:46 INFO - PROCESS | 2280 | 22:00:49 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53948/tests/dromaeo/cssquery-yui.html) 22:00:50 INFO - PROCESS | 2280 | RSS: Main: 280489984 22:00:50 INFO - PROCESS | 2280 | 22:03:52 INFO - PROCESS | 2280 | Cycle 1(1): loaded http://localhost:53948/tests/dromaeo/cssquery-yui.html (next: http://localhost:53948/tests/dromaeo/cssquery-dojo.html) 22:03:53 INFO - PROCESS | 2280 | RSS: Main: 281415680 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | __start_tp_report 22:03:53 INFO - PROCESS | 2280 | _x_x_mozilla_page_load 22:03:53 INFO - PROCESS | 2280 | _x_x_mozilla_page_load_details 22:03:53 INFO - PROCESS | 2280 | |i|pagename|runs| 22:03:53 INFO - PROCESS | 2280 | |0;dojo.html;2975.8512074396276;3531.4879342495337;3537.2394935088932;3559.4126969050108;3566.554180727409;5234.42421333653;5966.343702192761;5985.371535988724;6037.788677396292;6094.664793436359;5890.793822216223;5987.072003839401;6039.607425517338;6066.454019138277;6120.387961203877;5305.840824775253;5372.865678358053;5399.676019438846;5482.259894914196;5488.670679759227;4935.860405835373;5504.064309067448;5506.201600767907;5565.41563135871;5598.664080155183;5321.467853214647;5329.680219186861;5358.410574836765;5378.220158077057;5433.185022246675;5373.570114390839;5378;5388.838334849961;5422.728863556846;5446.428125046892;5375.65058271215;5420.83737487876;5432.239486471897;5443.863903402407;5502.889942201134;5812.215350927613;5913.645181289136;5966.224390829208;6028.487578555828;6032.849178770522;5251.894962100775;5789.826305210809;6279.927157608468;6354.078658594478;6381.266154392211;6209.565330426872;6364.109024736541;6427.1423394083085;6465.224173099211;6501.47988160946;6126.785562505335;6154.876902461926;6174.320824709278;6183.907241391383;6197.318294987548;6545.05096760967;6579.013148027739;6582.572132811352;6583.967080164569;6587;6154.969225153935;6179.938200617937;6209.627422354673;6285.9057114143325;6294.874102517924;6454.741810327629;6464.191976003;6464.77373291942;6480.449161821204;6489.643069631215;5270.60470464709;6185.567010309235;6242.906356404657;6272.874542509125;6297.307296197415;6173.969130154321;6178.752849885954;6262.2172228471445;6384.680765961683;6384.776532821329;5048.813528820724;5132.538071573576;5146.948530514647;5159.406668233126;5173.508516690908;3680.1719613086843;3794.962050379516;4492.168948744493;4578.748168850745;4659.324397962277;5627.52166065889;5684.54523638108;5969;6074.362191969868;6098.634081955097;5393.7303134843105;6353.142325786052;6419.935800641933;6420.036994450777;6434.935650643433;6068.362821903725;6103.877922441527;6108.144859719643;6110.205673262448;6117.388261173847;5487.039768040577;5532.834014979557;5572.526335261548;5583;5601.943980560142;6689.899651505231;6693.431058360094;6693.966530167513;6709.362610552087;6712.261651218264;6397.7760778374395;6453.548251622341;6456.063870738622;6460.709268082854;6464.321246269262;6444.162258906312;6461.224653041665;6505.577137486048;6552.312007239171;6663.866722665616;5307.708076055854;6217.28723668401;6276;6288.591241569284;6312.526560508072;6347.492200624031;6366.586171898812;6378.138951241709;6389.2652344980925;6392.5844820088405;5457.454254574511;6066.848328791815;6182.381761823782;6211.627302361872;6265.028920517327;6223.937760622517;6230.59501132425;6235.345288744798;6239.1577137085915;6262.248530176408;6018.277806663228;6097.085437184281;6101.725422356093;6149.108379285068;6220.875582488416;6169.444749972524;6186.752529898754;6231.158793562811;6258.843528911813;6269.341719119427;6205.193324867739;6221.253449586078;6231.626102433868;6231.875362492816;6239.688015599111 22:03:53 INFO - PROCESS | 2280 | |1;ext.html;499.6427554298676;519.9886221299573;522.7072839210041;543.3045701502078;606.2058703098943;28643;36442.08894777632;38297.80851095741;38339;38421.61578384216;39509.40735888957;40144.19711605766;40280.194396112136;40484.797576012155;40500.78497645068;9341.626334946593;9601.80796384072;9632.373895696792;9642.903570964305;9663.5168241588;9560.760980975461;9692.176165025947;9700.17548508374;9710.563024663872;9720.270979676518;9689.127978481934;9702.369345992523;9720;9753.634491171242;9754.658586949457;9639.084286992724;9685.370450920738;9686.854697179548;9693.854592181124;9740.610375584969;9476.289278304155;9570.138687518087;9574.138327550554;9593.808123837483;9607.327487075907;31121.8443907779;37198;37664.058398540255;37676.62323376758;37934.81032594847;2389.557931782626;3062.6631070582216;3145.51244557094;3404.9489257661153;3896.1038961038835;26734.197974060808;27016.729832701618;27603.171904842886;27654;27684.861575691993;2666.879990400437;2672.2250547341246;2675.6789185297694;2727.686316073637;2801.6638003439516;431529;432260;432494.8375258135;433571;434323;34318.313633727186;34646.65353346434;34694.70400311967;34734.47898281528;34783.304333913686;35067.298654026774;35967.82016089903;36617.45073823895;37348;38143;17307.961522308702;17344.392946246822;17367.218475168647;17478.82521174772;17598.91200543989;13128.34358282082;13172.275524846034;13229.867701323055;13312.866871331356;13322.866771332356;17080.91459542719;18316.717829752055;19461.805381946;19477.80522194788;19497;8205.261526462527;8266.751997440086;8286.502809831309;8346.374021948379;8346.916530834735;953.9809203816023;1061.1457776489844;1071.3411252079916;1089.9782004360027;1148.7702459508132;27758.722412775613;28830.135095947157;29119.854400728284;29288.560671589516;29600.407991840475;1066.679996001212;1149.1036991146918;1155.7572909689059;1176.7940610393318;1280.750253700538;15109.622259443602;15116.848831511545;15180.620484487976;15508.991915525456;15519.922400387926;632440;667643;681710;682846;683953;50948.745256274226;52365.7381713089;58771.41228587745;59004.40995590075;59145.70427147837;1456.2791418248034;1463.9048461849945;1474.5944865161953;1490.3963894622696;1502.0086742749952;29120.854395727885;29195.85402072976;29356.412871742017;29745.405091898472;29785.80856765705;49329.013419732124;49515.25727114168;49695;49831.750841245565;49962.25056624226;472169;566230;585401;586563;588668;25887.741122588533;26246.737532625193;26335.736642634096;26430.07494737675;26459.470810584065;43447.34828977631;44762.880927975755;45241;45676;45872;32228.677713223504;33721.49417758785;37313.06717332089;37797;38327.42508862314;37265.62734372621;37357.62642373541;37707.81146094252;37728.2454350906;37994.240115198096;32327.51508727324;37549;37573.43639845459;38359.23281534298;38418;32749.67250327466;33143.17142071467;33184.33631327312;33311.83344083264;33409;24495.877520612285;24539.50920981606;24698.629520556846;25079.623805642565;25482.617760733232 22:03:53 INFO - PROCESS | 2280 | |2;jquery.html;393.814906993713;399.6363309388456;399.9600039995999;400.32744988419455;418.71945796316464;20257.39227823166;20667.689984650242;21653.891730541345;21731.34805955822;21829.781702182972;10025.548850301735;12443.315617641027;15892.602684932883;21408.645049044593;21442.57114857702;5309.681419114846;5427.728613569336;5470.370907345647;5581.7209139543065;5612.747426365803;5508.7521061552125;5538.169274608801;5544.63959842611;5555.944440555603;5577.358603760579;5531;5550.084236101038;5550.306211723535;5887.8233652990475;5895.292564892197;5766.567507436917;5890.852728681796;5895.43993320636;5948.43489868464;6109.877802443926;5858.531317494633;5858.8242352729485;5899.200743773147;5908.940910590882;5911.76352945886;13378.93310533441;13681.384337704827;13927.930360348133;13975.580732578039;14001.789973150411;2082.9270975515783;2164.5129845784572;2172.5220451500645;2186.6610675345187;2401.219603628828;7964.362850971908;8501.724741288794;9787.559559819825;10149.89850101497;10318.638847640297;1704.7442883567564;1726.1196789637374;1753.2636292757072;1768.6993211154136;1821.681205788995;118671.4066429671;120709.99999999913;136223.31888340495;136237;139490.90763638553;11568.24806387582;11589.420528973518;12028.097892658086;12102.515899364103;12283.201591896499;12416.937915310365;15535.922320388325;15551.455699050479;15625.921870390803;15663.530094097196;8936.8659470108;9022.954885225532;9030.909690903007;9084.364094513321;9178.944421391625;8911.866322005175;8949.910500895037;8975.192232699088;9055.864162037575;9094.681686140953;4726.62187025044;4760;4777.331173635694;4835.564799168092;4853.490383509751;1679.8908070975347;1954.7458830352248;2018.6164628720496;2044.2640649366217;2051.3333166720877;930.3580529434669;949.9762505937268;970.9853203402462;988.5106872098357;1043.8903915088958;16552.255148518347;20888.37334879956;20988.790112098683;21304.573908522052;21344.893275533832;846.9830603387898;947.7867479817124;962.167724917941;991.6182269826169;993.2401712689798;8356.623951922178;8962.68630597926;10402.559344043782;11006.229563930448;11015.118790496741;282065;585809;599913;617372;627806;131721.34139329242;133091;136702.31648841692;140114;148391.25804371125;962.0619895601873;969.486172328667;983.4148681534475;984.0454758883872;1008.7780688248573;17648.470545883643;18394.632107358044;18519.629607407507;18606.627867442847;18746.718799218295;49057.50942490529;50290;51820.22269665883;52100;53202.88166860706;78283.60858195672;79426.6028669853;80190.59904700439;80382.59808701153;82016;6296.622202667854;6976.825579360557;7369.299916507923;7491.70033198666;7497.362724168289;7259.20148783644;10633;11101;12718.809217861924;13122.278274694983;11258;11435.142364322875;11531.654050378502;11614.70963225926;11653.30080195191;8152.796180095545;10196.541155648161;10537;11392.544298227978;11619.0704743622;11521.675007374259;11585.189036767346;11675.474603643026;11895.98884094827;11909.761804763682;8382.287505562095;8464.830703385775;8551.444156129832;8552.444091134057;8666.826663466822;9418.199453046294;11124.110071194124;11463.942680286546;11895.226810257305;11939 22:03:53 INFO - PROCESS | 2280 | |3;mootools.html;1443.6174413780348;1624.0742776617328;1637.4350848957106;1998.4304473225143;2029;7863.92136078639;8402.20179082987;8436.957815210915;8929.821403571925;8956.373053886231;8552.401331906769;8569.657213711444;8717.12828717128;8721.86917196241;8750.86873696895;2429.866357350345;2470.703515578124;2471.1351027140536;2472;2480.293116461809;2201.52667176557;2428.162284012013;2481.6525686403916;2488.4525404411092;2494.663220465232;2221.2225720997603;2303.34354708908;2303.976960230393;2329.091654254842;2336.7663233676667;2020.6665900126388;2362.976370236293;2364.2552595932225;2370.7392186859433;2397.436602398435;2421.2494126820566;2437.4272046069336;2451.9754802452103;2461.040194324215;2461.8153638477006;8709.042005379402;8740.213380795696;8765.474071555727;8765.956170219108;8778.56107194644;4451.2655411857;5510.9448905510835;5521.116621340607;5521.365043020024;5554.389017208104;3612.223371975038;3614.963850361489;3648.671619554253;3727.7204209684382;3729.627037296276;1045.524286449671;1056.10758908722;1059.4067322299536;1063.080435423361;1063.4044934836515;10720.946395267974;10766.354018758899;11710;11713.882861171365;11733.296002239807;4407.994362565025;4602.537070285563;4805.13507568641;4922.9753851231235;4970.975145124251;9833.164181044549;9876.012398760211;9940.701778946643;9953.552090155961;9953.80092398148;5378.273933019071;5411.594130440154;5455.236266922634;5459.645123066988;5481.177823326533;4252.340887162495;4443.555644435531;4839.927401088987;4929.137400954819;5000.1749711297225;3951.9604803952166;4002.799860006988;4110.794460276974;4149.730267532601;4205.3902184183735;1360.3674291454522;1372.8056590766098;1375.0580852116332;1376.3393571085935;1381.2265131526378;826.6610689617228;837.5435387713588;891.585412783059;926.3284119013662;935.3452583191793;4898.2652602109965;5449.591280653967;5937.584369094122;5944.078667806497;6145;971.4608392342177;1001.1740314240781;1021.6117875207523;1028.454918892988;1028.9485525723685;3920.4511368408444;4028.8187031583648;4040.9797951010646;4071.89820254496;4118.258713431551;10469.424181670081;10747.462626868626;10912.727181820517;10948.562057517769;10956.835647465294;10744.785104297871;10883.074938630147;10902.400367979837;10935.56257749697;10960.616378426717;7965.522068676014;8100.878486822702;8314.792130196673;8327.333813294921;8355.206255405727;5960.493358064613;6017.398260173947;6075.756969721162;6125.509959203164;6217.191765070512;9498.287628428034;9855.35940163887;10034.297599167989;10071.647492337734;10093.747656308651;9967.651132210338;10161.695149145242;10189.84715229287;10272.589096436059;10327.586896524055;6820.556663816836;7272.454565907472;7328.083989501312;7454.6645400956;7545.811354715956;8331.041930178108;8375.664973401239;8381.11998240176;8428.4942903426;8457.40798144124;6380.266269379081;7314.926850731425;7456.962715186606;7460.738874139379;7617.314441700273;7099.183593886769;7317.487775855852;7363.7422690205585;7378.262173782578;7436.553806771611;6996.090508233897;7112.964435177791;7123.928760712327;7126.251743567058;7127.821804454723;3719.4606782017;4460.397846290709;4502.459704835441;4578.221702310681;4716.976415117902;4939;5046.571041461517;5148.613853961043;5149.613778966667;5154.304168937296 22:03:53 INFO - PROCESS | 2280 | |4;prototype.html;306.37499501017925;318.91070500259923;323.2500598611222;324.949632806915;326.9460539011063;4964.652474326798;5400;5487.725613719318;5664;5728.140778883169;4675.241607451603;5130.820421285256;5231.587471382734;5336.893262134755;5499.4225606311265;3266.1181481000117;3964.7224694271413;4028.03327201471;4229.534751177368;4262.46719160105;3603.9279214415697;3944.704147188958;4238.258304796664;4258.850940217093;4266.402703621496;4176.958230417703;4189.727667701605;4190.51809041961;4199.538050814408;4234.703570750034;3876.9224615507815;4227.91544169118;4235.348214196466;4239.618434340909;4243.766592837393;3651.908702282438;3654.524911761481;3671.430928206106;3673.981630091859;3678.5401824771902;5243.265942767977;5288.312519372495;5347.54545863602;5361.490658387447;5379.731013449312;4246.2356775780345;4377.657952995164;4761.833335833229;4802.151171798882;4857.149998750205;5058.822941197077;5133.793558513784;5180.5337519623035;5683.3464151622675;5715.2855893013375;3580.982095089534;3963.8901107689894;3972.304846651853;3976.920461590781;3985.3025720498795;5717.885012422579;5783.739731712083;6168.396216983571;6174.259088909314;6295.307516173218;3174.714275715197;3661.578918424362;3835.9424608630893;3952.4071389291835;4011.0318364410127;3308.5368048473233;3867.43922131295;4072.6538244249573;4103.179364127186;4124.8143833527565;4458.576435238647;4755.503360735642;4815.590674792612;4857.344258525054;4867.099586576494;4608.608268297232;5971.731272092767;6000.039993601003;6024.819255422344;6048.425399587032;1039.4958445154093;1094.6497120921229;1332.2073366347008;1334.652990222549;1337.411538922871;849.9545558962511;865.7489328094908;869.9869501957476;874.3529787956993;896.6099746610246;5012.523810238022;5182.274481572583;5220.530152286236;5237.476252374732;5268.631195816256;5705.800296989585;5799.346411760648;5803.88392232153;5821.7380217890295;5887.470127688529;4496.213162696515;5008.971366596535;5073.017739880413;5166.354205724285;5213.59233007086;2683.2889284339667;2692.909371704463;2822.7741780657498;2896.1022083153866;3028.318628308657;5253.684778913201;5364.168553874156;5402.459754024645;6006.9576344043235;6019;5825.7087145642545;5921.940780592225;6061.696915154224;6338.461230795342;6411.775587854496;5910.852228694231;5940.79207227745;6338.271098823602;6345.936540634627;6480.416762491304;5249.291345668286;5887.882242355215;6175;6194.4115309045565;6205.937940620536;5186.507281808223;5339.225812257123;6008.639481631116;6077.817665470043;6126.816195514141;5412.8646783829145;6219.595726277777;6332.796768613948;6394.872102558016;6451.838704032437;3503.8072905989397;4000.3399439093387;4018.7186896916937;4021.8994525137105;4038.555758866581;4457.3091170868565;6063.605865618721;6117.816465506042;6158.167243068238;6195.845103872439;4957.256411538298;5250.868728281824;5924.4667979882015;5928.436798504135;5990.161377407254;5200.817971370984;5651.773929042793;5966.850828729316;5969;6019.759209631566;4521.412216411845;5174.379074511083;5340.626156169186;5795.435232487289;5923.466887980103;4879;5762.423757624371;5941.702914854153;5967.375284154815;6021.6085954414575;5452.809151679672;5637.43625637433;5666.858328541819;5810.244668193108;5902.2327097477055 22:03:53 INFO - PROCESS | 2280 | |5;yui.html;579.3655946738322;645.7513857164993;646.334275696033;665.1486097794823;706.1032488739298;14979.325930333134;15097.169655668948;15266.08403495791;15317.84682153178;15564.688706225868;14292.285385730724;14394.208318542476;14406.639834004156;14416.92791536041;14427;721.9241979592146;778.8831675248701;893.5085702863431;901.8421776189174;929.1359036096428;915.4324318922278;915.4461550761794;920.6179435534245;921.1203300847675;925.3568769705058;965.5799727118691;981.6269817469388;981.8969008254138;983.1102851919024;983.6606370802061;922.077922077922;937.3532262738688;963.330485312708;973.3721749471587;974.5468357213894;718.2888939949464;724.8948902409173;728.7813655903208;731.2723839779453;733.3033618062861;11934.22427542207;14566.70866582673;14831.629209269746;14844.406223751037;14891.776623350659;10328.225383096298;12537.561185358469;12683.619491415273;12772.105952583323;12799.74400511994;10002.899971000343;10017.749556261078;10213.795724085478;10509.316894401916;10692.732681682943;3474.4788281757938;3518.700910422617;3528.6647768461953;3537.2925414916863;3578.5169002184894;81056;83839.5808020956;84731.15268847294;85002.14997850005;86954.69567956486;9432.411838822287;9490.952545237367;9521.714348569554;9632.229421646392;9745.220382369393;22101.226457073924;22293.108275669118;22393.55212895733;22458.182109041503;22476.55046899053;7470.962645186739;7490.063742032246;7585.6965721371635;7686.846263074707;7711.03612048494;4012.257732319472;4020.798960051986;4052.5339585947404;4066.3900414937402;4068.5727998559723;3541;3611.043073585502;3649.5802982656805;3654.506641603403;3669.7614655047337;654.8362909272682;658.3416583416583;658.887989041864;667.2760055339913;675.7499725101744;477.36748807829764;503.22000898607746;589.4164776870867;590.0735844723743;594.6877889108252;8226.424150309422;8311.875321870177;8335.458195217292;8359.038710548242;8410.831783364298;519.8778287102527;569.8233547600257;578.3406916115631;599.152199637508;605.1286147946943;3846.807659617008;3869.806509674505;3873.6126387361037;3927.19492504036;4037.3764992531974;94996.05003949872;95019;97958;99824;101686;82925;83792;85906.84558926485;87662;87934.56032719795;74333.628331858;76382.61808691033;76426.23573764191;77351;78304.60847695838;7641.88537171954;7652.311291983749;7803.531788092732;7858;7869.567173805267;38813.41779873361;46618.533814661416;46755.76622116868;46876.7656161717;47607;52685;53605.46394536005;54254.728726356116;61362.69318653378;61753;9151.359404841598;9400.61742817823;10687.89312106869;11134.33194008362;11508.251963622337;10255.435951022468;10739.892601073889;10781.51483183243;11008.064314533354;11189.72025699364;10298;10337.84493232587;10410.167186625204;10553.630622928467;10707.89292107069;9108.544572771467;9854.55654495535;10238.744031399274;10618.256722029384;10747.838782418426;10032.92736144723;10055.547500362354;10057.647982320585;10077.344972576759;10244.487775611338;8275.793105172419;8364;8500;8612.526311052952;8751;8654.48073115615;8762.123787621187;8771.473711577326;8853.291736660924;9236 22:03:53 INFO - PROCESS | 2280 | __end_tp_report 22:03:53 INFO - PROCESS | 2280 | __start_cc_report 22:03:53 INFO - PROCESS | 2280 | _x_x_mozilla_cycle_collect,418 22:03:53 INFO - PROCESS | 2280 | __end_cc_report 22:03:53 INFO - PROCESS | 2280 | __startTimestamp1462511033000__endTimestamp 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | ------- Summary: start ------- 22:03:53 INFO - PROCESS | 2280 | Number of tests: 6 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#0] dojo.html Cycles:165 Average:5896.08 Median:6154.88 stddev:687.62 (11.2%) stddev-sans-first:650.45 22:03:53 INFO - PROCESS | 2280 | Values: 2975.9 3531.5 3537.2 3559.4 3566.6 5234.4 5966.3 5985.4 6037.8 6094.7 5890.8 5987.1 6039.6 6066.5 6120.4 5305.8 5372.9 5399.7 5482.3 5488.7 4935.9 5504.1 5506.2 5565.4 5598.7 5321.5 5329.7 5358.4 5378.2 5433.2 5373.6 5378.0 5388.8 5422.7 5446.4 5375.7 5420.8 5432.2 5443.9 5502.9 5812.2 5913.6 5966.2 6028.5 6032.8 5251.9 5789.8 6279.9 6354.1 6381.3 6209.6 6364.1 6427.1 6465.2 6501.5 6126.8 6154.9 6174.3 6183.9 6197.3 6545.1 6579.0 6582.6 6584.0 6587.0 6155.0 6179.9 6209.6 6285.9 6294.9 6454.7 6464.2 6464.8 6480.4 6489.6 5270.6 6185.6 6242.9 6272.9 6297.3 6174.0 6178.8 6262.2 6384.7 6384.8 5048.8 5132.5 5146.9 5159.4 5173.5 3680.2 3795.0 4492.2 4578.7 4659.3 5627.5 5684.5 5969.0 6074.4 6098.6 5393.7 6353.1 6419.9 6420.0 6434.9 6068.4 6103.9 6108.1 6110.2 6117.4 5487.0 5532.8 5572.5 5583.0 5601.9 6689.9 6693.4 6694.0 6709.4 6712.3 6397.8 6453.5 6456.1 6460.7 6464.3 6444.2 6461.2 6505.6 6552.3 6663.9 5307.7 6217.3 6276.0 6288.6 6312.5 6347.5 6366.6 6378.1 6389.3 6392.6 5457.5 6066.8 6182.4 6211.6 6265.0 6223.9 6230.6 6235.3 6239.2 6262.2 6018.3 6097.1 6101.7 6149.1 6220.9 6169.4 6186.8 6231.2 6258.8 6269.3 6205.2 6221.3 6231.6 6231.9 6239.7 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#1] ext.html Cycles:180 Average:66904.34 Median:37352.81 stddev:150925.66 (404.1%) stddev-sans-first:151266.70 22:03:53 INFO - PROCESS | 2280 | Values: 499.6 520.0 522.7 543.3 606.2 28643.0 36442.1 38297.8 38339.0 38421.6 39509.4 40144.2 40280.2 40484.8 40500.8 9341.6 9601.8 9632.4 9642.9 9663.5 9560.8 9692.2 9700.2 9710.6 9720.3 9689.1 9702.4 9720.0 9753.6 9754.7 9639.1 9685.4 9686.9 9693.9 9740.6 9476.3 9570.1 9574.1 9593.8 9607.3 31121.8 37198.0 37664.1 37676.6 37934.8 2389.6 3062.7 3145.5 3404.9 3896.1 26734.2 27016.7 27603.2 27654.0 27684.9 2666.9 2672.2 2675.7 2727.7 2801.7 431529.0 432260.0 432494.8 433571.0 434323.0 34318.3 34646.7 34694.7 34734.5 34783.3 35067.3 35967.8 36617.5 37348.0 38143.0 17308.0 17344.4 17367.2 17478.8 17598.9 13128.3 13172.3 13229.9 13312.9 13322.9 17080.9 18316.7 19461.8 19477.8 19497.0 8205.3 8266.8 8286.5 8346.4 8346.9 954.0 1061.1 1071.3 1090.0 1148.8 27758.7 28830.1 29119.9 29288.6 29600.4 1066.7 1149.1 1155.8 1176.8 1280.8 15109.6 15116.8 15180.6 15509.0 15519.9 632440.0 667643.0 681710.0 682846.0 683953.0 50948.7 52365.7 58771.4 59004.4 59145.7 1456.3 1463.9 1474.6 1490.4 1502.0 29120.9 29195.9 29356.4 29745.4 29785.8 49329.0 49515.3 49695.0 49831.8 49962.3 472169.0 566230.0 585401.0 586563.0 588668.0 25887.7 26246.7 26335.7 26430.1 26459.5 43447.3 44762.9 45241.0 45676.0 45872.0 32228.7 33721.5 37313.1 37797.0 38327.4 37265.6 37357.6 37707.8 37728.2 37994.2 32327.5 37549.0 37573.4 38359.2 38418.0 32749.7 33143.2 33184.3 33311.8 33409.0 24495.9 24539.5 24698.6 25079.6 25482.6 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#2] jquery.html Cycles:180 Average:33616.65 Median:396.73 stddev:94458.15 (23809.4%) stddev-sans-first:94690.19 22:03:53 INFO - PROCESS | 2280 | Values: 393.8 399.6 400.0 400.3 418.7 20257.4 20667.7 21653.9 21731.3 21829.8 10025.5 12443.3 15892.6 21408.6 21442.6 5309.7 5427.7 5470.4 5581.7 5612.7 5508.8 5538.2 5544.6 5555.9 5577.4 5531.0 5550.1 5550.3 5887.8 5895.3 5766.6 5890.9 5895.4 5948.4 6109.9 5858.5 5858.8 5899.2 5908.9 5911.8 13378.9 13681.4 13927.9 13975.6 14001.8 2082.9 2164.5 2172.5 2186.7 2401.2 7964.4 8501.7 9787.6 10149.9 10318.6 1704.7 1726.1 1753.3 1768.7 1821.7 118671.4 120710.0 136223.3 136237.0 139490.9 11568.2 11589.4 12028.1 12102.5 12283.2 12416.9 15535.9 15551.5 15625.9 15663.5 8936.9 9023.0 9030.9 9084.4 9178.9 8911.9 8949.9 8975.2 9055.9 9094.7 4726.6 4760.0 4777.3 4835.6 4853.5 1679.9 1954.7 2018.6 2044.3 2051.3 930.4 950.0 971.0 988.5 1043.9 16552.3 20888.4 20988.8 21304.6 21344.9 847.0 947.8 962.2 991.6 993.2 8356.6 8962.7 10402.6 11006.2 11015.1 282065.0 585809.0 599913.0 617372.0 627806.0 131721.3 133091.0 136702.3 140114.0 148391.3 962.1 969.5 983.4 984.0 1008.8 17648.5 18394.6 18519.6 18606.6 18746.7 49057.5 50290.0 51820.2 52100.0 53202.9 78283.6 79426.6 80190.6 80382.6 82016.0 6296.6 6976.8 7369.3 7491.7 7497.4 7259.2 10633.0 11101.0 12718.8 13122.3 11258.0 11435.1 11531.7 11614.7 11653.3 8152.8 10196.5 10537.0 11392.5 11619.1 11521.7 11585.2 11675.5 11896.0 11909.8 8382.3 8464.8 8551.4 8552.4 8666.8 9418.2 11124.1 11463.9 11895.2 11939.0 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#3] mootools.html Cycles:180 Average:5714.59 Median:4761.06 stddev:3174.49 (66.7%) stddev-sans-first:3167.16 22:03:53 INFO - PROCESS | 2280 | Values: 1443.6 1624.1 1637.4 1998.4 2029.0 7863.9 8402.2 8437.0 8929.8 8956.4 8552.4 8569.7 8717.1 8721.9 8750.9 2429.9 2470.7 2471.1 2472.0 2480.3 2201.5 2428.2 2481.7 2488.5 2494.7 2221.2 2303.3 2304.0 2329.1 2336.8 2020.7 2363.0 2364.3 2370.7 2397.4 2421.2 2437.4 2452.0 2461.0 2461.8 8709.0 8740.2 8765.5 8766.0 8778.6 4451.3 5510.9 5521.1 5521.4 5554.4 3612.2 3615.0 3648.7 3727.7 3729.6 1045.5 1056.1 1059.4 1063.1 1063.4 10720.9 10766.4 11710.0 11713.9 11733.3 4408.0 4602.5 4805.1 4923.0 4971.0 9833.2 9876.0 9940.7 9953.6 9953.8 5378.3 5411.6 5455.2 5459.6 5481.2 4252.3 4443.6 4839.9 4929.1 5000.2 3952.0 4002.8 4110.8 4149.7 4205.4 1360.4 1372.8 1375.1 1376.3 1381.2 826.7 837.5 891.6 926.3 935.3 4898.3 5449.6 5937.6 5944.1 6145.0 971.5 1001.2 1021.6 1028.5 1028.9 3920.5 4028.8 4041.0 4071.9 4118.3 10469.4 10747.5 10912.7 10948.6 10956.8 10744.8 10883.1 10902.4 10935.6 10960.6 7965.5 8100.9 8314.8 8327.3 8355.2 5960.5 6017.4 6075.8 6125.5 6217.2 9498.3 9855.4 10034.3 10071.6 10093.7 9967.7 10161.7 10189.8 10272.6 10327.6 6820.6 7272.5 7328.1 7454.7 7545.8 8331.0 8375.7 8381.1 8428.5 8457.4 6380.3 7314.9 7457.0 7460.7 7617.3 7099.2 7317.5 7363.7 7378.3 7436.6 6996.1 7113.0 7123.9 7126.3 7127.8 3719.5 4460.4 4502.5 4578.2 4717.0 4939.0 5046.6 5148.6 5149.6 5154.3 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#4] prototype.html Cycles:180 Average:4689.65 Median:5217.06 stddev:1489.21 (28.5%) stddev-sans-first:1456.59 22:03:53 INFO - PROCESS | 2280 | Values: 306.4 318.9 323.3 324.9 326.9 4964.7 5400.0 5487.7 5664.0 5728.1 4675.2 5130.8 5231.6 5336.9 5499.4 3266.1 3964.7 4028.0 4229.5 4262.5 3603.9 3944.7 4238.3 4258.9 4266.4 4177.0 4189.7 4190.5 4199.5 4234.7 3876.9 4227.9 4235.3 4239.6 4243.8 3651.9 3654.5 3671.4 3674.0 3678.5 5243.3 5288.3 5347.5 5361.5 5379.7 4246.2 4377.7 4761.8 4802.2 4857.1 5058.8 5133.8 5180.5 5683.3 5715.3 3581.0 3963.9 3972.3 3976.9 3985.3 5717.9 5783.7 6168.4 6174.3 6295.3 3174.7 3661.6 3835.9 3952.4 4011.0 3308.5 3867.4 4072.7 4103.2 4124.8 4458.6 4755.5 4815.6 4857.3 4867.1 4608.6 5971.7 6000.0 6024.8 6048.4 1039.5 1094.6 1332.2 1334.7 1337.4 850.0 865.7 870.0 874.4 896.6 5012.5 5182.3 5220.5 5237.5 5268.6 5705.8 5799.3 5803.9 5821.7 5887.5 4496.2 5009.0 5073.0 5166.4 5213.6 2683.3 2692.9 2822.8 2896.1 3028.3 5253.7 5364.2 5402.5 6007.0 6019.0 5825.7 5921.9 6061.7 6338.5 6411.8 5910.9 5940.8 6338.3 6345.9 6480.4 5249.3 5887.9 6175.0 6194.4 6205.9 5186.5 5339.2 6008.6 6077.8 6126.8 5412.9 6219.6 6332.8 6394.9 6451.8 3503.8 4000.3 4018.7 4021.9 4038.6 4457.3 6063.6 6117.8 6158.2 6195.8 4957.3 5250.9 5924.5 5928.4 5990.2 5200.8 5651.8 5966.9 5969.0 6019.8 4521.4 5174.4 5340.6 5795.4 5923.5 4879.0 5762.4 5941.7 5967.4 6021.6 5452.8 5637.4 5666.9 5810.2 5902.2 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - PROCESS | 2280 | [#5] yui.html Cycles:180 Average:18322.20 Median:30983.91 stddev:26715.16 (86.2%) stddev-sans-first:26756.89 22:03:53 INFO - PROCESS | 2280 | Values: 579.4 645.8 646.3 665.1 706.1 14979.3 15097.2 15266.1 15317.8 15564.7 14292.3 14394.2 14406.6 14416.9 14427.0 721.9 778.9 893.5 901.8 929.1 915.4 915.4 920.6 921.1 925.4 965.6 981.6 981.9 983.1 983.7 922.1 937.4 963.3 973.4 974.5 718.3 724.9 728.8 731.3 733.3 11934.2 14566.7 14831.6 14844.4 14891.8 10328.2 12537.6 12683.6 12772.1 12799.7 10002.9 10017.7 10213.8 10509.3 10692.7 3474.5 3518.7 3528.7 3537.3 3578.5 81056.0 83839.6 84731.2 85002.1 86954.7 9432.4 9491.0 9521.7 9632.2 9745.2 22101.2 22293.1 22393.6 22458.2 22476.6 7471.0 7490.1 7585.7 7686.8 7711.0 4012.3 4020.8 4052.5 4066.4 4068.6 3541.0 3611.0 3649.6 3654.5 3669.8 654.8 658.3 658.9 667.3 675.7 477.4 503.2 589.4 590.1 594.7 8226.4 8311.9 8335.5 8359.0 8410.8 519.9 569.8 578.3 599.2 605.1 3846.8 3869.8 3873.6 3927.2 4037.4 94996.1 95019.0 97958.0 99824.0 101686.0 82925.0 83792.0 85906.8 87662.0 87934.6 74333.6 76382.6 76426.2 77351.0 78304.6 7641.9 7652.3 7803.5 7858.0 7869.6 38813.4 46618.5 46755.8 46876.8 47607.0 52685.0 53605.5 54254.7 61362.7 61753.0 9151.4 9400.6 10687.9 11134.3 11508.3 10255.4 10739.9 10781.5 11008.1 11189.7 10298.0 10337.8 10410.2 10553.6 10707.9 9108.5 9854.6 10238.7 10618.3 10747.8 10032.9 10055.5 10057.6 10077.3 10244.5 8275.8 8364.0 8500.0 8612.5 8751.0 8654.5 8762.1 8771.5 8853.3 9236.0 22:03:53 INFO - PROCESS | 2280 | -------- Summary: end -------- 22:03:53 INFO - PROCESS | 2280 | 22:03:53 INFO - TEST-INFO | 2280: exit 0 22:03:53 INFO - TEST-OK | dromaeo_css | took 1112212ms 22:03:53 INFO - TEST-START | kraken 22:03:53 INFO - operating with platform_type : mac_ 22:03:53 INFO - Initialising browser for kraken test... 22:03:53 INFO - TEST-INFO | started process 2285 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpPgGgHl/profile http://localhost:53948/getInfo.html) 22:03:56 INFO - PROCESS | 2285 | __metrics Screen width/height:1600/1200 22:03:56 INFO - PROCESS | 2285 | colorDepth:24 22:03:56 INFO - PROCESS | 2285 | Browser inner width/height: 1024/689 22:03:56 INFO - PROCESS | 2285 | __metrics 22:03:56 ERROR - PROCESS | 2285 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:03:57 INFO - TEST-INFO | 2285: exit 0 22:03:57 INFO - Browser initialized. 22:03:57 INFO - Running cycle 1/1 for kraken test... 22:03:57 INFO - TEST-INFO | started process 2288 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpPgGgHl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:04:09 INFO - PROCESS | 2288 | RSS: Main: 250445824 22:04:09 INFO - PROCESS | 2288 | 22:04:12 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53948/tests/kraken/driver.html?testName=audio-beat-detection) 22:04:13 INFO - PROCESS | 2288 | RSS: Main: 262025216 22:04:13 INFO - PROCESS | 2288 | 22:04:15 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53948/tests/kraken/driver.html?testName=audio-dft) 22:04:16 INFO - PROCESS | 2288 | RSS: Main: 267194368 22:04:16 INFO - PROCESS | 2288 | 22:04:19 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53948/tests/kraken/driver.html?testName=audio-fft) 22:04:20 INFO - PROCESS | 2288 | RSS: Main: 267046912 22:04:20 INFO - PROCESS | 2288 | 22:04:22 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53948/tests/kraken/driver.html?testName=audio-oscillator) 22:04:22 INFO - PROCESS | 2288 | RSS: Main: 267718656 22:04:22 INFO - PROCESS | 2288 | 22:04:25 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53948/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:04:25 INFO - PROCESS | 2288 | RSS: Main: 268201984 22:04:25 INFO - PROCESS | 2288 | 22:04:28 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53948/tests/kraken/driver.html?testName=imaging-darkroom) 22:04:29 INFO - PROCESS | 2288 | RSS: Main: 268914688 22:04:29 INFO - PROCESS | 2288 | 22:04:31 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53948/tests/kraken/driver.html?testName=imaging-desaturate) 22:04:32 INFO - PROCESS | 2288 | RSS: Main: 269090816 22:04:32 INFO - PROCESS | 2288 | 22:04:35 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53948/tests/kraken/driver.html?testName=json-parse-financial) 22:04:36 INFO - PROCESS | 2288 | RSS: Main: 269160448 22:04:36 INFO - PROCESS | 2288 | 22:04:37 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53948/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:04:38 INFO - PROCESS | 2288 | RSS: Main: 268296192 22:04:38 INFO - PROCESS | 2288 | 22:04:40 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:04:40 INFO - PROCESS | 2288 | RSS: Main: 268431360 22:04:40 INFO - PROCESS | 2288 | 22:04:43 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:04:43 INFO - PROCESS | 2288 | RSS: Main: 268705792 22:04:43 INFO - PROCESS | 2288 | 22:04:46 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:04:47 INFO - PROCESS | 2288 | RSS: Main: 268754944 22:04:47 INFO - PROCESS | 2288 | 22:04:50 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:04:51 INFO - PROCESS | 2288 | RSS: Main: 268804096 22:04:51 INFO - PROCESS | 2288 | 22:04:52 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:53948/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53948/tests/kraken/driver.html?testName=ai-astar) 22:04:53 INFO - PROCESS | 2288 | RSS: Main: 270606336 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | __start_tp_report 22:04:53 INFO - PROCESS | 2288 | _x_x_mozilla_page_load 22:04:53 INFO - PROCESS | 2288 | _x_x_mozilla_page_load_details 22:04:53 INFO - PROCESS | 2288 | |i|pagename|runs| 22:04:53 INFO - PROCESS | 2288 | |0;ai-astar;113;116;109;114;117;116;112;164;117;117 22:04:53 INFO - PROCESS | 2288 | |1;audio-beat-detection;175;147;146;163;123;149;170;125;169;120 22:04:53 INFO - PROCESS | 2288 | |2;audio-dft;197;197;205;230;197;194;197;199;199;198 22:04:53 INFO - PROCESS | 2288 | |3;audio-fft;75;84;75;143;60;59;60;59;137;83 22:04:53 INFO - PROCESS | 2288 | |4;audio-oscillator;79;95;135;79;81;99;124;80;82;129 22:04:53 INFO - PROCESS | 2288 | |5;imaging-gaussian-blur;98;117;88;92;122;86;88;85;88;86 22:04:53 INFO - PROCESS | 2288 | |6;imaging-darkroom;104;94;95;94;93;96;95;95;93;95 22:04:53 INFO - PROCESS | 2288 | |7;imaging-desaturate;90;91;89;92;98;110;120;88;92;90 22:04:53 INFO - PROCESS | 2288 | |8;json-parse-financial;59;60;60;61;61;62;62;81;63;61 22:04:53 INFO - PROCESS | 2288 | |9;json-stringify-tinderbox;69;70;101;66;87;109;102;94;69;71 22:04:53 INFO - PROCESS | 2288 | |10;stanford-crypto-aes;86;86;89;88;86;89;97;113;109;114 22:04:53 INFO - PROCESS | 2288 | |11;stanford-crypto-ccm;138;138;159;132;129;126;142;169;192;140 22:04:53 INFO - PROCESS | 2288 | |12;stanford-crypto-pbkdf2;178;236;214;169;165;168;196;228;168;163 22:04:53 INFO - PROCESS | 2288 | |13;stanford-crypto-sha256-iterative;68;65;68;70;62;86;83;72;88;87 22:04:53 INFO - PROCESS | 2288 | __end_tp_report 22:04:53 INFO - PROCESS | 2288 | __start_cc_report 22:04:53 INFO - PROCESS | 2288 | _x_x_mozilla_cycle_collect,1069 22:04:53 INFO - PROCESS | 2288 | __end_cc_report 22:04:53 INFO - PROCESS | 2288 | __startTimestamp1462511093077__endTimestamp 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | ------- Summary: start ------- 22:04:53 INFO - PROCESS | 2288 | Number of tests: 14 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#0] ai-astar Cycles:10 Average:119.50 Median:116.50 stddev:15.86 (13.6%) stddev-sans-first:16.64 22:04:53 INFO - PROCESS | 2288 | Values: 113.0 116.0 109.0 114.0 117.0 116.0 112.0 164.0 117.0 117.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:156.00 stddev:20.60 (13.2%) stddev-sans-first:19.52 22:04:53 INFO - PROCESS | 2288 | Values: 175.0 147.0 146.0 163.0 123.0 149.0 170.0 125.0 169.0 120.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#2] audio-dft Cycles:10 Average:201.30 Median:198.50 stddev:10.47 (5.3%) stddev-sans-first:10.99 22:04:53 INFO - PROCESS | 2288 | Values: 197.0 197.0 205.0 230.0 197.0 194.0 197.0 199.0 199.0 198.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#3] audio-fft Cycles:10 Average:83.50 Median:67.50 stddev:31.36 (46.5%) stddev-sans-first:33.11 22:04:53 INFO - PROCESS | 2288 | Values: 75.0 84.0 75.0 143.0 60.0 59.0 60.0 59.0 137.0 83.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:80.50 stddev:22.62 (28.1%) stddev-sans-first:22.89 22:04:53 INFO - PROCESS | 2288 | Values: 79.0 95.0 135.0 79.0 81.0 99.0 124.0 80.0 82.0 129.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:88.00 stddev:13.50 (15.3%) stddev-sans-first:14.27 22:04:53 INFO - PROCESS | 2288 | Values: 98.0 117.0 88.0 92.0 122.0 86.0 88.0 85.0 88.0 86.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.00 stddev:3.17 (3.3%) stddev-sans-first:1.01 22:04:53 INFO - PROCESS | 2288 | Values: 104.0 94.0 95.0 94.0 93.0 96.0 95.0 95.0 93.0 95.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:90.50 stddev:10.64 (11.8%) stddev-sans-first:11.06 22:04:53 INFO - PROCESS | 2288 | Values: 90.0 91.0 89.0 92.0 98.0 110.0 120.0 88.0 92.0 90.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:61.50 stddev:6.43 (10.5%) stddev-sans-first:6.65 22:04:53 INFO - PROCESS | 2288 | Values: 59.0 60.0 60.0 61.0 61.0 62.0 62.0 81.0 63.0 61.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#9] json-stringify-tinderbox Cycles:10 Average:83.80 Median:69.50 stddev:16.62 (23.9%) stddev-sans-first:16.74 22:04:53 INFO - PROCESS | 2288 | Values: 69.0 70.0 101.0 66.0 87.0 109.0 102.0 94.0 69.0 71.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#10] stanford-crypto-aes Cycles:10 Average:95.70 Median:87.00 stddev:11.76 (13.5%) stddev-sans-first:11.94 22:04:53 INFO - PROCESS | 2288 | Values: 86.0 86.0 89.0 88.0 86.0 89.0 97.0 113.0 109.0 114.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:141.00 stddev:20.75 (14.7%) stddev-sans-first:21.78 22:04:53 INFO - PROCESS | 2288 | Values: 138.0 138.0 159.0 132.0 129.0 126.0 142.0 169.0 192.0 140.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.50 Median:187.00 stddev:28.00 (15.0%) stddev-sans-first:29.44 22:04:53 INFO - PROCESS | 2288 | Values: 178.0 236.0 214.0 169.0 165.0 168.0 196.0 228.0 168.0 163.0 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - PROCESS | 2288 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:77.50 stddev:9.99 (12.9%) stddev-sans-first:10.28 22:04:53 INFO - PROCESS | 2288 | Values: 68.0 65.0 68.0 70.0 62.0 86.0 83.0 72.0 88.0 87.0 22:04:53 INFO - PROCESS | 2288 | -------- Summary: end -------- 22:04:53 INFO - PROCESS | 2288 | 22:04:53 INFO - TEST-INFO | 2288: exit 0 22:04:53 INFO - TEST-OK | kraken | took 60297ms 22:04:53 INFO - SUITE-END | took 1172s 22:04:54 INFO - Completed test suite (00:19:32) 22:04:54 INFO - javascript benchmark 22:04:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.8512074396276, 3531.4879342495337, 3537.2394935088932, 3559.4126969050108, 3566.554180727409, 5234.42421333653, 5966.343702192761, 5985.371535988724, 6037.788677396292, 6094.664793436359, 5890.793822216223, 5987.072003839401, 6039.607425517338, 6066.454019138277, 6120.387961203877, 5305.840824775253, 5372.865678358053, 5399.676019438846, 5482.259894914196, 5488.670679759227, 4935.860405835373, 5504.064309067448, 5506.201600767907, 5565.41563135871, 5598.664080155183, 5321.467853214647, 5329.680219186861, 5358.410574836765, 5378.220158077057, 5433.185022246675, 5373.570114390839, 5378.0, 5388.838334849961, 5422.728863556846, 5446.428125046892, 5375.65058271215, 5420.83737487876, 5432.239486471897, 5443.863903402407, 5502.889942201134, 5812.215350927613, 5913.645181289136, 5966.224390829208, 6028.487578555828, 6032.849178770522, 5251.894962100775, 5789.826305210809, 6279.927157608468, 6354.078658594478, 6381.266154392211, 6209.565330426872, 6364.109024736541, 6427.1423394083085, 6465.224173099211, 6501.47988160946, 6126.785562505335, 6154.876902461926, 6174.320824709278, 6183.907241391383, 6197.318294987548, 6545.05096760967, 6579.013148027739, 6582.572132811352, 6583.967080164569, 6587.0, 6154.969225153935, 6179.938200617937, 6209.627422354673, 6285.9057114143325, 6294.874102517924, 6454.741810327629, 6464.191976003, 6464.77373291942, 6480.449161821204, 6489.643069631215, 5270.60470464709, 6185.567010309235, 6242.906356404657, 6272.874542509125, 6297.307296197415, 6173.969130154321, 6178.752849885954, 6262.2172228471445, 6384.680765961683, 6384.776532821329, 5048.813528820724, 5132.538071573576, 5146.948530514647, 5159.406668233126, 5173.508516690908, 3680.1719613086843, 3794.962050379516, 4492.168948744493, 4578.748168850745, 4659.324397962277, 5627.52166065889, 5684.54523638108, 5969.0, 6074.362191969868, 6098.634081955097, 5393.7303134843105, 6353.142325786052, 6419.935800641933, 6420.036994450777, 6434.935650643433, 6068.362821903725, 6103.877922441527, 6108.144859719643, 6110.205673262448, 6117.388261173847, 5487.039768040577, 5532.834014979557, 5572.526335261548, 5583.0, 5601.943980560142, 6689.899651505231, 6693.431058360094, 6693.966530167513, 6709.362610552087, 6712.261651218264, 6397.7760778374395, 6453.548251622341, 6456.063870738622, 6460.709268082854, 6464.321246269262, 6444.162258906312, 6461.224653041665, 6505.577137486048, 6552.312007239171, 6663.866722665616, 5307.708076055854, 6217.28723668401, 6276.0, 6288.591241569284, 6312.526560508072, 6347.492200624031, 6366.586171898812, 6378.138951241709, 6389.2652344980925, 6392.5844820088405, 5457.454254574511, 6066.848328791815, 6182.381761823782, 6211.627302361872, 6265.028920517327, 6223.937760622517, 6230.59501132425, 6235.345288744798, 6239.1577137085915, 6262.248530176408, 6018.277806663228, 6097.085437184281, 6101.725422356093, 6149.108379285068, 6220.875582488416, 6169.444749972524, 6186.752529898754, 6231.158793562811, 6258.843528911813, 6269.341719119427, 6205.193324867739, 6221.253449586078, 6231.626102433868, 6231.875362492816, 6239.688015599111], "value": 5851.705660200808, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.6427554298676, 519.9886221299573, 522.7072839210041, 543.3045701502078, 606.2058703098943, 28643.0, 36442.08894777632, 38297.80851095741, 38339.0, 38421.61578384216, 39509.40735888957, 40144.19711605766, 40280.194396112136, 40484.797576012155, 40500.78497645068, 9341.626334946593, 9601.80796384072, 9632.373895696792, 9642.903570964305, 9663.5168241588, 9560.760980975461, 9692.176165025947, 9700.17548508374, 9710.563024663872, 9720.270979676518, 9689.127978481934, 9702.369345992523, 9720.0, 9753.634491171242, 9754.658586949457, 9639.084286992724, 9685.370450920738, 9686.854697179548, 9693.854592181124, 9740.610375584969, 9476.289278304155, 9570.138687518087, 9574.138327550554, 9593.808123837483, 9607.327487075907, 31121.8443907779, 37198.0, 37664.058398540255, 37676.62323376758, 37934.81032594847, 2389.557931782626, 3062.6631070582216, 3145.51244557094, 3404.9489257661153, 3896.1038961038835, 26734.197974060808, 27016.729832701618, 27603.171904842886, 27654.0, 27684.861575691993, 2666.879990400437, 2672.2250547341246, 2675.6789185297694, 2727.686316073637, 2801.6638003439516, 431529.0, 432260.0, 432494.8375258135, 433571.0, 434323.0, 34318.313633727186, 34646.65353346434, 34694.70400311967, 34734.47898281528, 34783.304333913686, 35067.298654026774, 35967.82016089903, 36617.45073823895, 37348.0, 38143.0, 17307.961522308702, 17344.392946246822, 17367.218475168647, 17478.82521174772, 17598.91200543989, 13128.34358282082, 13172.275524846034, 13229.867701323055, 13312.866871331356, 13322.866771332356, 17080.91459542719, 18316.717829752055, 19461.805381946, 19477.80522194788, 19497.0, 8205.261526462527, 8266.751997440086, 8286.502809831309, 8346.374021948379, 8346.916530834735, 953.9809203816023, 1061.1457776489844, 1071.3411252079916, 1089.9782004360027, 1148.7702459508132, 27758.722412775613, 28830.135095947157, 29119.854400728284, 29288.560671589516, 29600.407991840475, 1066.679996001212, 1149.1036991146918, 1155.7572909689059, 1176.7940610393318, 1280.750253700538, 15109.622259443602, 15116.848831511545, 15180.620484487976, 15508.991915525456, 15519.922400387926, 632440.0, 667643.0, 681710.0, 682846.0, 683953.0, 50948.745256274226, 52365.7381713089, 58771.41228587745, 59004.40995590075, 59145.70427147837, 1456.2791418248034, 1463.9048461849945, 1474.5944865161953, 1490.3963894622696, 1502.0086742749952, 29120.854395727885, 29195.85402072976, 29356.412871742017, 29745.405091898472, 29785.80856765705, 49329.013419732124, 49515.25727114168, 49695.0, 49831.750841245565, 49962.25056624226, 472169.0, 566230.0, 585401.0, 586563.0, 588668.0, 25887.741122588533, 26246.737532625193, 26335.736642634096, 26430.07494737675, 26459.470810584065, 43447.34828977631, 44762.880927975755, 45241.0, 45676.0, 45872.0, 32228.677713223504, 33721.49417758785, 37313.06717332089, 37797.0, 38327.42508862314, 37265.62734372621, 37357.62642373541, 37707.81146094252, 37728.2454350906, 37994.240115198096, 32327.51508727324, 37549.0, 37573.43639845459, 38359.23281534298, 38418.0, 32749.67250327466, 33143.17142071467, 33184.33631327312, 33311.83344083264, 33409.0, 24495.877520612285, 24539.50920981606, 24698.629520556846, 25079.623805642565, 25482.617760733232], "value": 19107.969709243953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.814906993713, 399.6363309388456, 399.9600039995999, 400.32744988419455, 418.71945796316464, 20257.39227823166, 20667.689984650242, 21653.891730541345, 21731.34805955822, 21829.781702182972, 10025.548850301735, 12443.315617641027, 15892.602684932883, 21408.645049044593, 21442.57114857702, 5309.681419114846, 5427.728613569336, 5470.370907345647, 5581.7209139543065, 5612.747426365803, 5508.7521061552125, 5538.169274608801, 5544.63959842611, 5555.944440555603, 5577.358603760579, 5531.0, 5550.084236101038, 5550.306211723535, 5887.8233652990475, 5895.292564892197, 5766.567507436917, 5890.852728681796, 5895.43993320636, 5948.43489868464, 6109.877802443926, 5858.531317494633, 5858.8242352729485, 5899.200743773147, 5908.940910590882, 5911.76352945886, 13378.93310533441, 13681.384337704827, 13927.930360348133, 13975.580732578039, 14001.789973150411, 2082.9270975515783, 2164.5129845784572, 2172.5220451500645, 2186.6610675345187, 2401.219603628828, 7964.362850971908, 8501.724741288794, 9787.559559819825, 10149.89850101497, 10318.638847640297, 1704.7442883567564, 1726.1196789637374, 1753.2636292757072, 1768.6993211154136, 1821.681205788995, 118671.4066429671, 120709.99999999913, 136223.31888340495, 136237.0, 139490.90763638553, 11568.24806387582, 11589.420528973518, 12028.097892658086, 12102.515899364103, 12283.201591896499, 12416.937915310365, 15535.922320388325, 15551.455699050479, 15625.921870390803, 15663.530094097196, 8936.8659470108, 9022.954885225532, 9030.909690903007, 9084.364094513321, 9178.944421391625, 8911.866322005175, 8949.910500895037, 8975.192232699088, 9055.864162037575, 9094.681686140953, 4726.62187025044, 4760.0, 4777.331173635694, 4835.564799168092, 4853.490383509751, 1679.8908070975347, 1954.7458830352248, 2018.6164628720496, 2044.2640649366217, 2051.3333166720877, 930.3580529434669, 949.9762505937268, 970.9853203402462, 988.5106872098357, 1043.8903915088958, 16552.255148518347, 20888.37334879956, 20988.790112098683, 21304.573908522052, 21344.893275533832, 846.9830603387898, 947.7867479817124, 962.167724917941, 991.6182269826169, 993.2401712689798, 8356.623951922178, 8962.68630597926, 10402.559344043782, 11006.229563930448, 11015.118790496741, 282065.0, 585809.0, 599913.0, 617372.0, 627806.0, 131721.34139329242, 133091.0, 136702.31648841692, 140114.0, 148391.25804371125, 962.0619895601873, 969.486172328667, 983.4148681534475, 984.0454758883872, 1008.7780688248573, 17648.470545883643, 18394.632107358044, 18519.629607407507, 18606.627867442847, 18746.718799218295, 49057.50942490529, 50290.0, 51820.22269665883, 52100.0, 53202.88166860706, 78283.60858195672, 79426.6028669853, 80190.59904700439, 80382.59808701153, 82016.0, 6296.622202667854, 6976.825579360557, 7369.299916507923, 7491.70033198666, 7497.362724168289, 7259.20148783644, 10633.0, 11101.0, 12718.809217861924, 13122.278274694983, 11258.0, 11435.142364322875, 11531.654050378502, 11614.70963225926, 11653.30080195191, 8152.796180095545, 10196.541155648161, 10537.0, 11392.544298227978, 11619.0704743622, 11521.675007374259, 11585.189036767346, 11675.474603643026, 11895.98884094827, 11909.761804763682, 8382.287505562095, 8464.830703385775, 8551.444156129832, 8552.444091134057, 8666.826663466822, 9418.199453046294, 11124.110071194124, 11463.942680286546, 11895.226810257305, 11939.0], "value": 9320.847147765136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.6174413780348, 1624.0742776617328, 1637.4350848957106, 1998.4304473225143, 2029.0, 7863.92136078639, 8402.20179082987, 8436.957815210915, 8929.821403571925, 8956.373053886231, 8552.401331906769, 8569.657213711444, 8717.12828717128, 8721.86917196241, 8750.86873696895, 2429.866357350345, 2470.703515578124, 2471.1351027140536, 2472.0, 2480.293116461809, 2201.52667176557, 2428.162284012013, 2481.6525686403916, 2488.4525404411092, 2494.663220465232, 2221.2225720997603, 2303.34354708908, 2303.976960230393, 2329.091654254842, 2336.7663233676667, 2020.6665900126388, 2362.976370236293, 2364.2552595932225, 2370.7392186859433, 2397.436602398435, 2421.2494126820566, 2437.4272046069336, 2451.9754802452103, 2461.040194324215, 2461.8153638477006, 8709.042005379402, 8740.213380795696, 8765.474071555727, 8765.956170219108, 8778.56107194644, 4451.2655411857, 5510.9448905510835, 5521.116621340607, 5521.365043020024, 5554.389017208104, 3612.223371975038, 3614.963850361489, 3648.671619554253, 3727.7204209684382, 3729.627037296276, 1045.524286449671, 1056.10758908722, 1059.4067322299536, 1063.080435423361, 1063.4044934836515, 10720.946395267974, 10766.354018758899, 11710.0, 11713.882861171365, 11733.296002239807, 4407.994362565025, 4602.537070285563, 4805.13507568641, 4922.9753851231235, 4970.975145124251, 9833.164181044549, 9876.012398760211, 9940.701778946643, 9953.552090155961, 9953.80092398148, 5378.273933019071, 5411.594130440154, 5455.236266922634, 5459.645123066988, 5481.177823326533, 4252.340887162495, 4443.555644435531, 4839.927401088987, 4929.137400954819, 5000.1749711297225, 3951.9604803952166, 4002.799860006988, 4110.794460276974, 4149.730267532601, 4205.3902184183735, 1360.3674291454522, 1372.8056590766098, 1375.0580852116332, 1376.3393571085935, 1381.2265131526378, 826.6610689617228, 837.5435387713588, 891.585412783059, 926.3284119013662, 935.3452583191793, 4898.2652602109965, 5449.591280653967, 5937.584369094122, 5944.078667806497, 6145.0, 971.4608392342177, 1001.1740314240781, 1021.6117875207523, 1028.454918892988, 1028.9485525723685, 3920.4511368408444, 4028.8187031583648, 4040.9797951010646, 4071.89820254496, 4118.258713431551, 10469.424181670081, 10747.462626868626, 10912.727181820517, 10948.562057517769, 10956.835647465294, 10744.785104297871, 10883.074938630147, 10902.400367979837, 10935.56257749697, 10960.616378426717, 7965.522068676014, 8100.878486822702, 8314.792130196673, 8327.333813294921, 8355.206255405727, 5960.493358064613, 6017.398260173947, 6075.756969721162, 6125.509959203164, 6217.191765070512, 9498.287628428034, 9855.35940163887, 10034.297599167989, 10071.647492337734, 10093.747656308651, 9967.651132210338, 10161.695149145242, 10189.84715229287, 10272.589096436059, 10327.586896524055, 6820.556663816836, 7272.454565907472, 7328.083989501312, 7454.6645400956, 7545.811354715956, 8331.041930178108, 8375.664973401239, 8381.11998240176, 8428.4942903426, 8457.40798144124, 6380.266269379081, 7314.926850731425, 7456.962715186606, 7460.738874139379, 7617.314441700273, 7099.183593886769, 7317.487775855852, 7363.7422690205585, 7378.262173782578, 7436.553806771611, 6996.090508233897, 7112.964435177791, 7123.928760712327, 7126.251743567058, 7127.821804454723, 3719.4606782017, 4460.397846290709, 4502.459704835441, 4578.221702310681, 4716.976415117902, 4939.0, 5046.571041461517, 5148.613853961043, 5149.613778966667, 5154.304168937296], "value": 4621.453371139552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.37499501017925, 318.91070500259923, 323.2500598611222, 324.949632806915, 326.9460539011063, 4964.652474326798, 5400.0, 5487.725613719318, 5664.0, 5728.140778883169, 4675.241607451603, 5130.820421285256, 5231.587471382734, 5336.893262134755, 5499.4225606311265, 3266.1181481000117, 3964.7224694271413, 4028.03327201471, 4229.534751177368, 4262.46719160105, 3603.9279214415697, 3944.704147188958, 4238.258304796664, 4258.850940217093, 4266.402703621496, 4176.958230417703, 4189.727667701605, 4190.51809041961, 4199.538050814408, 4234.703570750034, 3876.9224615507815, 4227.91544169118, 4235.348214196466, 4239.618434340909, 4243.766592837393, 3651.908702282438, 3654.524911761481, 3671.430928206106, 3673.981630091859, 3678.5401824771902, 5243.265942767977, 5288.312519372495, 5347.54545863602, 5361.490658387447, 5379.731013449312, 4246.2356775780345, 4377.657952995164, 4761.833335833229, 4802.151171798882, 4857.149998750205, 5058.822941197077, 5133.793558513784, 5180.5337519623035, 5683.3464151622675, 5715.2855893013375, 3580.982095089534, 3963.8901107689894, 3972.304846651853, 3976.920461590781, 3985.3025720498795, 5717.885012422579, 5783.739731712083, 6168.396216983571, 6174.259088909314, 6295.307516173218, 3174.714275715197, 3661.578918424362, 3835.9424608630893, 3952.4071389291835, 4011.0318364410127, 3308.5368048473233, 3867.43922131295, 4072.6538244249573, 4103.179364127186, 4124.8143833527565, 4458.576435238647, 4755.503360735642, 4815.590674792612, 4857.344258525054, 4867.099586576494, 4608.608268297232, 5971.731272092767, 6000.039993601003, 6024.819255422344, 6048.425399587032, 1039.4958445154093, 1094.6497120921229, 1332.2073366347008, 1334.652990222549, 1337.411538922871, 849.9545558962511, 865.7489328094908, 869.9869501957476, 874.3529787956993, 896.6099746610246, 5012.523810238022, 5182.274481572583, 5220.530152286236, 5237.476252374732, 5268.631195816256, 5705.800296989585, 5799.346411760648, 5803.88392232153, 5821.7380217890295, 5887.470127688529, 4496.213162696515, 5008.971366596535, 5073.017739880413, 5166.354205724285, 5213.59233007086, 2683.2889284339667, 2692.909371704463, 2822.7741780657498, 2896.1022083153866, 3028.318628308657, 5253.684778913201, 5364.168553874156, 5402.459754024645, 6006.9576344043235, 6019.0, 5825.7087145642545, 5921.940780592225, 6061.696915154224, 6338.461230795342, 6411.775587854496, 5910.852228694231, 5940.79207227745, 6338.271098823602, 6345.936540634627, 6480.416762491304, 5249.291345668286, 5887.882242355215, 6175.0, 6194.4115309045565, 6205.937940620536, 5186.507281808223, 5339.225812257123, 6008.639481631116, 6077.817665470043, 6126.816195514141, 5412.8646783829145, 6219.595726277777, 6332.796768613948, 6394.872102558016, 6451.838704032437, 3503.8072905989397, 4000.3399439093387, 4018.7186896916937, 4021.8994525137105, 4038.555758866581, 4457.3091170868565, 6063.605865618721, 6117.816465506042, 6158.167243068238, 6195.845103872439, 4957.256411538298, 5250.868728281824, 5924.4667979882015, 5928.436798504135, 5990.161377407254, 5200.817971370984, 5651.773929042793, 5966.850828729316, 5969.0, 6019.759209631566, 4521.412216411845, 5174.379074511083, 5340.626156169186, 5795.435232487289, 5923.466887980103, 4879.0, 5762.423757624371, 5941.702914854153, 5967.375284154815, 6021.6085954414575, 5452.809151679672, 5637.43625637433, 5666.858328541819, 5810.244668193108, 5902.2327097477055], "value": 4208.822557347635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3655946738322, 645.7513857164993, 646.334275696033, 665.1486097794823, 706.1032488739298, 14979.325930333134, 15097.169655668948, 15266.08403495791, 15317.84682153178, 15564.688706225868, 14292.285385730724, 14394.208318542476, 14406.639834004156, 14416.92791536041, 14427.0, 721.9241979592146, 778.8831675248701, 893.5085702863431, 901.8421776189174, 929.1359036096428, 915.4324318922278, 915.4461550761794, 920.6179435534245, 921.1203300847675, 925.3568769705058, 965.5799727118691, 981.6269817469388, 981.8969008254138, 983.1102851919024, 983.6606370802061, 922.077922077922, 937.3532262738688, 963.330485312708, 973.3721749471587, 974.5468357213894, 718.2888939949464, 724.8948902409173, 728.7813655903208, 731.2723839779453, 733.3033618062861, 11934.22427542207, 14566.70866582673, 14831.629209269746, 14844.406223751037, 14891.776623350659, 10328.225383096298, 12537.561185358469, 12683.619491415273, 12772.105952583323, 12799.74400511994, 10002.899971000343, 10017.749556261078, 10213.795724085478, 10509.316894401916, 10692.732681682943, 3474.4788281757938, 3518.700910422617, 3528.6647768461953, 3537.2925414916863, 3578.5169002184894, 81056.0, 83839.5808020956, 84731.15268847294, 85002.14997850005, 86954.69567956486, 9432.411838822287, 9490.952545237367, 9521.714348569554, 9632.229421646392, 9745.220382369393, 22101.226457073924, 22293.108275669118, 22393.55212895733, 22458.182109041503, 22476.55046899053, 7470.962645186739, 7490.063742032246, 7585.6965721371635, 7686.846263074707, 7711.03612048494, 4012.257732319472, 4020.798960051986, 4052.5339585947404, 4066.3900414937402, 4068.5727998559723, 3541.0, 3611.043073585502, 3649.5802982656805, 3654.506641603403, 3669.7614655047337, 654.8362909272682, 658.3416583416583, 658.887989041864, 667.2760055339913, 675.7499725101744, 477.36748807829764, 503.22000898607746, 589.4164776870867, 590.0735844723743, 594.6877889108252, 8226.424150309422, 8311.875321870177, 8335.458195217292, 8359.038710548242, 8410.831783364298, 519.8778287102527, 569.8233547600257, 578.3406916115631, 599.152199637508, 605.1286147946943, 3846.807659617008, 3869.806509674505, 3873.6126387361037, 3927.19492504036, 4037.3764992531974, 94996.05003949872, 95019.0, 97958.0, 99824.0, 101686.0, 82925.0, 83792.0, 85906.84558926485, 87662.0, 87934.56032719795, 74333.628331858, 76382.61808691033, 76426.23573764191, 77351.0, 78304.60847695838, 7641.88537171954, 7652.311291983749, 7803.531788092732, 7858.0, 7869.567173805267, 38813.41779873361, 46618.533814661416, 46755.76622116868, 46876.7656161717, 47607.0, 52685.0, 53605.46394536005, 54254.728726356116, 61362.69318653378, 61753.0, 9151.359404841598, 9400.61742817823, 10687.89312106869, 11134.33194008362, 11508.251963622337, 10255.435951022468, 10739.892601073889, 10781.51483183243, 11008.064314533354, 11189.72025699364, 10298.0, 10337.84493232587, 10410.167186625204, 10553.630622928467, 10707.89292107069, 9108.544572771467, 9854.55654495535, 10238.744031399274, 10618.256722029384, 10747.838782418426, 10032.92736144723, 10055.547500362354, 10057.647982320585, 10077.344972576759, 10244.487775611338, 8275.793105172419, 8364.0, 8500.0, 8612.526311052952, 8751.0, 8654.48073115615, 8762.123787621187, 8771.473711577326, 8853.291736660924, 9236.0], "value": 6760.334540602739, "unit": "score"}], "name": "dromaeo_css", "value": 7180.427513379127, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 114.0, 117.0, 116.0, 112.0, 164.0, 117.0, 117.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 147.0, 146.0, 163.0, 123.0, 149.0, 170.0, 125.0, 169.0, 120.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 205.0, 230.0, 197.0, 194.0, 197.0, 199.0, 199.0, 198.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 75.0, 143.0, 60.0, 59.0, 60.0, 59.0, 137.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 95.0, 135.0, 79.0, 81.0, 99.0, 124.0, 80.0, 82.0, 129.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 117.0, 88.0, 92.0, 122.0, 86.0, 88.0, 85.0, 88.0, 86.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 94.0, 95.0, 94.0, 93.0, 96.0, 95.0, 95.0, 93.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 89.0, 92.0, 98.0, 110.0, 120.0, 88.0, 92.0, 90.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 61.0, 61.0, 62.0, 62.0, 81.0, 63.0, 61.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 101.0, 66.0, 87.0, 109.0, 102.0, 94.0, 69.0, 71.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 89.0, 88.0, 86.0, 89.0, 97.0, 113.0, 109.0, 114.0], "value": 95.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 159.0, 132.0, 129.0, 126.0, 142.0, 169.0, 192.0, 140.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 236.0, 214.0, 169.0, 165.0, 168.0, 196.0, 228.0, 168.0, 163.0], "value": 188.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 70.0, 62.0, 86.0, 83.0, 72.0, 88.0, 87.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1590.1000000000001, "alertThreshold": 2.0}]} 22:04:54 INFO - Return code: 0 22:04:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:04:54 ERROR - # TBPL SUCCESS # 22:04:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:04:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:04:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:04:54 INFO - 2016-05-05 22:04:54.394 screenresolution[2293:84073] starting screenresolution argv=screenresolution get 22:04:54 INFO - 2016-05-05 22:04:54.396 screenresolution[2293:84073] Display 0: 1600x1200x32@60 22:04:54 INFO - 2016-05-05 22:04:54.402 screenresolution[2294:84076] starting screenresolution argv=screenresolution list 22:04:54 INFO - Available Modes on Display 0 22:04:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:04:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:04:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:04:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:04:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:04:54 INFO - Intel Iris: 22:04:54 INFO - Chipset Model: Intel Iris 22:04:54 INFO - Type: GPU 22:04:54 INFO - Bus: Built-In 22:04:54 INFO - VRAM (Dynamic, Max): 1536 MB 22:04:54 INFO - Vendor: Intel (0x8086) 22:04:54 INFO - Device ID: 0x0a2e 22:04:54 INFO - Revision ID: 0x0009 22:04:54 INFO - Displays: 22:04:54 INFO - Display: 22:04:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:04:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:04:54 INFO - Display Serial Number: 1600x1200 60 22:04:54 INFO - Main Display: Yes 22:04:54 INFO - Mirror: Off 22:04:54 INFO - Online: Yes 22:04:54 INFO - Rotation: Supported 22:04:54 INFO - Return code: 0 22:04:54 INFO - Running post-action listener: _resource_record_post_action 22:04:54 INFO - Running post-run listener: _resource_record_post_run 22:04:55 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 4096; Write bytes: 697671680; Read time: 0; Write time: 1895 22:04:55 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 375618048; Write bytes: 370099712; Read time: 28197; Write time: 641 22:04:55 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 4096; Write bytes: 298449408; Read time: 0; Write time: 1200 22:04:55 INFO - Running post-run listener: _upload_blobber_files 22:04:55 INFO - Blob upload gear active. 22:04:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:04:55 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 22:04:55 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:04:55 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:04:56 INFO - (blobuploader) - INFO - Open directory for files ... 22:04:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:04:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:04:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:57 INFO - (blobuploader) - INFO - Done attempting. 22:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:04:58 INFO - (blobuploader) - INFO - Done attempting. 22:04:58 INFO - (blobuploader) - INFO - Iteration through files over. 22:04:58 INFO - Return code: 0 22:04:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:04:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:04:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766513e6eb787197733f11bce6eb913a89745f2a45c99769e5a6810616f764cc011fbc174f68e5bfae7f5aa02d932a24378982e65e5560a0b7946dd72fd1e6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80302727df5899a1c37f0a186126dbe8f86ebf072b82cf1c96596c74b7eb3530f81e1c0dc25f76662e1b16dd8c208725976934a6cd20cebae8d55037c75db229"} 22:04:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:04:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:04:58 INFO - Contents: 22:04:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766513e6eb787197733f11bce6eb913a89745f2a45c99769e5a6810616f764cc011fbc174f68e5bfae7f5aa02d932a24378982e65e5560a0b7946dd72fd1e6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80302727df5899a1c37f0a186126dbe8f86ebf072b82cf1c96596c74b7eb3530f81e1c0dc25f76662e1b16dd8c208725976934a6cd20cebae8d55037c75db229"} 22:04:58 INFO - Running post-run listener: copy_logs_to_upload_dir 22:04:58 INFO - Copying logs to upload dir... 22:04:58 INFO - mkdir: /builds/slave/test/build/upload/logs 22:04:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.801266 ========= master_lag: 90.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-05-05 22:06:29.205854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 22:06:29.208983) ========= 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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/Fx-Team/sha512/766513e6eb787197733f11bce6eb913a89745f2a45c99769e5a6810616f764cc011fbc174f68e5bfae7f5aa02d932a24378982e65e5560a0b7946dd72fd1e6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80302727df5899a1c37f0a186126dbe8f86ebf072b82cf1c96596c74b7eb3530f81e1c0dc25f76662e1b16dd8c208725976934a6cd20cebae8d55037c75db229"} build_url:https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/a-HM1tB0QAeVMMi0gOW_jw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/766513e6eb787197733f11bce6eb913a89745f2a45c99769e5a6810616f764cc011fbc174f68e5bfae7f5aa02d932a24378982e65e5560a0b7946dd72fd1e6e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80302727df5899a1c37f0a186126dbe8f86ebf072b82cf1c96596c74b7eb3530f81e1c0dc25f76662e1b16dd8c208725976934a6cd20cebae8d55037c75db229"}' ========= master_lag: 0.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 22:06:29.664404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:06:29.664788) ========= 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.rzlm7HK8Iq/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.KUENdq1FyL/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005338 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:06:29.692608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 22:06:29.693015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 22:06:29.697070) ========= ========= Total master_lag: 91.01 =========