builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0077 starttime: 1461629837.92 results: success (0) buildid: 20160425152612 builduid: db395646daad42cdb5966a0548f0356a revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:17.919292) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:17.919767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:17.920068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:17.938210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:17.938521) ========= 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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 17:17:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.77M=0.001s 2016-04-25 17:17:18 (9.77 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:18.076346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:18.076666) ========= 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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.020231 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:18.125836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 17:17:18.126193) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 17:17:18,213 truncating revision to first 12 chars 2016-04-25 17:17:18,213 Setting DEBUG logging. 2016-04-25 17:17:18,213 attempt 1/10 2016-04-25 17:17:18,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/79de998e7307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 17:17:19,753 unpacking tar archive at: mozilla-central-79de998e7307/testing/mozharness/ program finished with exit code 0 elapsedTime=1.787904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 17:17:19.930508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:19.930840) ========= script_repo_revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:19.931224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:19.931490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 17:17:19.945031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 17:17:19.945319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:20 INFO - MultiFileLogger online at 20160425 17:17:20 in /builds/slave/test 17:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:20 INFO - {'append_to_log': False, 17:17:20 INFO - 'base_work_dir': '/builds/slave/test', 17:17:20 INFO - 'blob_upload_branch': 'Firefox', 17:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:20 INFO - 'branch': 'Firefox', 17:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:20 INFO - 'config_files': ('talos/mac_config.py',), 17:17:20 INFO - 'default_actions': ('clobber', 17:17:20 INFO - 'read-buildbot-config', 17:17:20 INFO - 'download-and-extract', 17:17:20 INFO - 'populate-webroot', 17:17:20 INFO - 'create-virtualenv', 17:17:20 INFO - 'install', 17:17:20 INFO - 'run-tests'), 17:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:20 INFO - 'download_minidump_stackwalk': True, 17:17:20 INFO - 'download_symbols': 'ondemand', 17:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:20 INFO - 'installer_path': 'installer.exe', 17:17:20 INFO - 'log_level': 'info', 17:17:20 INFO - 'log_name': 'talos', 17:17:20 INFO - 'log_to_console': True, 17:17:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:17:20 INFO - 'opt_config_files': (), 17:17:20 INFO - 'pip_index': False, 17:17:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:20 INFO - 'cmd': ('bash', 17:17:20 INFO - '-c', 17:17:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:20 INFO - 'enabled': True, 17:17:20 INFO - 'halt_on_failure': False, 17:17:20 INFO - 'name': 'check_screen_resolution'},), 17:17:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:20 INFO - 'cmd': ('bash', 17:17:20 INFO - '-c', 17:17:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:20 INFO - 'enabled': True, 17:17:20 INFO - 'halt_on_failure': False, 17:17:20 INFO - 'name': 'check_screen_resolution'},), 17:17:20 INFO - 'run_cmd_checks_enabled': True, 17:17:20 INFO - 'sps_profile': False, 17:17:20 INFO - 'sps_profile_interval': 0, 17:17:20 INFO - 'suite': 'dromaeojs-e10s', 17:17:20 INFO - 'system_bits': '32', 17:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:20 INFO - 'title': 't-yosemite-r7-0077', 17:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:20 INFO - 'use_talos_json': True, 17:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:20 INFO - 'work_dir': 'build'} 17:17:20 INFO - ##### 17:17:20 INFO - ##### Running clobber step. 17:17:20 INFO - ##### 17:17:20 INFO - Running pre-action listener: _resource_record_pre_action 17:17:20 INFO - Running main action method: clobber 17:17:20 INFO - rmtree: /builds/slave/test/build 17:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:21 INFO - Running post-action listener: _resource_record_post_action 17:17:21 INFO - ##### 17:17:21 INFO - ##### Running read-buildbot-config step. 17:17:21 INFO - ##### 17:17:21 INFO - Running pre-action listener: _resource_record_pre_action 17:17:21 INFO - Running main action method: read_buildbot_config 17:17:21 INFO - Using buildbot properties: 17:17:21 INFO - { 17:17:21 INFO - "project": "", 17:17:21 INFO - "product": "firefox", 17:17:21 INFO - "script_repo_revision": "production", 17:17:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:17:21 INFO - "repository": "", 17:17:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:17:21 INFO - "buildid": "20160425152612", 17:17:21 INFO - "pgo_build": "False", 17:17:21 INFO - "basedir": "/builds/slave/test", 17:17:21 INFO - "buildnumber": 207, 17:17:21 INFO - "slavename": "t-yosemite-r7-0077", 17:17:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:17:21 INFO - "platform": "yosemite_r7", 17:17:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:17:21 INFO - "branch": "mozilla-central", 17:17:21 INFO - "repo_path": "mozilla-central", 17:17:21 INFO - "revision": "79de998e7307650fec99ea6188ae60ac64ebeedb", 17:17:21 INFO - "stage_platform": "macosx64", 17:17:21 INFO - "builduid": "db395646daad42cdb5966a0548f0356a", 17:17:21 INFO - "slavebuilddir": "test" 17:17:21 INFO - } 17:17:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:17:21 INFO - Running post-action listener: _resource_record_post_action 17:17:21 INFO - ##### 17:17:21 INFO - ##### Running download-and-extract step. 17:17:21 INFO - ##### 17:17:21 INFO - Running pre-action listener: _resource_record_pre_action 17:17:21 INFO - Running main action method: download_and_extract 17:17:21 INFO - mkdir: /builds/slave/test/build/tests 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:21 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:17:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:17:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:17:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:22 INFO - Downloaded 1199 bytes. 17:17:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:17:22 INFO - Using the following test package requirements: 17:17:22 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:17:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:17:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:17:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'jsshell-mac.zip'], 17:17:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:17:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:17:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:17:22 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:17:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:17:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:22 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:17:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:17: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')]} 17:17:22 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:23 INFO - Downloaded 18111452 bytes. 17:17:23 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'] 17:17:23 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 17:17:27 INFO - Return code: 0 17:17:27 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 17:17: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')]} 17:17:27 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:28 INFO - Downloaded 18111452 bytes. 17:17:28 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'] 17:17:28 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 17:17:31 INFO - Return code: 0 17:17: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')]} 17:17:31 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:33 INFO - Downloaded 10840145 bytes. 17:17:33 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'] 17:17:33 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 17:17:33 INFO - Return code: 0 17:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:33 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:17:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/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 17:17:37 INFO - Downloaded 110160085 bytes. 17:17:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:37 INFO - mkdir: /builds/slave/test/properties 17:17:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:37 INFO - Contents: 17:17:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:39 INFO - Running post-action listener: _resource_record_post_action 17:17:39 INFO - Running post-action listener: set_extra_try_arguments 17:17:39 INFO - ##### 17:17:39 INFO - ##### Running populate-webroot step. 17:17:39 INFO - ##### 17:17:39 INFO - Running pre-action listener: _resource_record_pre_action 17:17:39 INFO - Running main action method: populate_webroot 17:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:39 INFO - '--tppagecycles', 17:17:39 INFO - '7'], 17:17:39 INFO - 'tests': ['tsvgm']}}, 17:17:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['damp', 'tps']}, 17:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'tests': ['damp', 'tps']}, 17:17:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['dromaeo_dom']}, 17:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['a11yr', 17:17:39 INFO - 'ts_paint', 17:17:39 INFO - 'tpaint', 17:17:39 INFO - 'sessionrestore', 17:17:39 INFO - 'sessionrestore_no_auto_restore', 17:17:39 INFO - 'tabpaint']}, 17:17:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['tsvgx', 17:17:39 INFO - 'tsvgr_opacity', 17:17:39 INFO - 'tart', 17:17:39 INFO - 'tscrollx', 17:17:39 INFO - 'cart']}, 17:17:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:39 INFO - 'tsvgr_opacity', 17:17:39 INFO - 'tart', 17:17:39 INFO - 'tscrollx', 17:17:39 INFO - 'cart']}, 17:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'talos_options': ['--disable-e10s'], 17:17:39 INFO - 'tests': ['tp5o']}, 17:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'tests': ['tp5o']}, 17:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'talos_options': ['--disable-e10s', 17:17:39 INFO - '--xperf_path', 17:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:39 INFO - 'tests': ['tp5n']}, 17:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:39 INFO - 'talos_options': ['--xperf_path', 17:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:39 INFO - 'tests': ['tp5n']}}, 17:17:39 INFO - 'talos.zip': {'path': '', 17:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:39 INFO - Running post-action listener: _resource_record_post_action 17:17:39 INFO - ##### 17:17:39 INFO - ##### Running create-virtualenv step. 17:17:39 INFO - ##### 17:17:39 INFO - Running pre-action listener: _resource_record_pre_action 17:17:39 INFO - Running main action method: create_virtualenv 17:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:39 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 17:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:39 INFO - Using real prefix '/tools/python27' 17:17:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:39 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:42 INFO - Installing pip.................done. 17:17:42 INFO - Return code: 0 17:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:42 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 17:17:42 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 17:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:42 INFO - 'HOME': '/Users/cltbld', 17:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:42 INFO - 'LOGNAME': 'cltbld', 17:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:42 INFO - 'MOZ_NO_REMOTE': '1', 17:17:42 INFO - 'NO_EM_RESTART': '1', 17:17:42 INFO - 'PAGER': '/bin/cat', 17:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:42 INFO - 'PWD': '/builds/slave/test', 17:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:42 INFO - 'SHELL': '/bin/bash', 17:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:42 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:42 INFO - 'USER': 'cltbld', 17:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:42 INFO - 'XPC_FLAGS': '0x0', 17:17:42 INFO - 'XPC_SERVICE_NAME': '0', 17:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:43 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 17:17:43 INFO - Cleaning up... 17:17:43 INFO - Return code: 0 17:17:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:43 INFO - 'HOME': '/Users/cltbld', 17:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:43 INFO - 'LOGNAME': 'cltbld', 17:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:43 INFO - 'MOZ_NO_REMOTE': '1', 17:17:43 INFO - 'NO_EM_RESTART': '1', 17:17:43 INFO - 'PAGER': '/bin/cat', 17:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:43 INFO - 'PWD': '/builds/slave/test', 17:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:43 INFO - 'SHELL': '/bin/bash', 17:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:43 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:43 INFO - 'USER': 'cltbld', 17:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:43 INFO - 'XPC_FLAGS': '0x0', 17:17:43 INFO - 'XPC_SERVICE_NAME': '0', 17:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:43 INFO - Downloading/unpacking psutil>=0.7.1 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:46 INFO - Installing collected packages: psutil 17:17:46 INFO - Running setup.py install for psutil 17:17:46 INFO - building 'psutil._psutil_osx' extension 17:17:46 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 17:17:46 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 17:17:46 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 17:17:46 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 17:17:46 INFO - building 'psutil._psutil_posix' extension 17:17:46 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 17:17:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:46 INFO - ^ 17:17:46 INFO - 1 warning generated. 17:17:46 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 17:17:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:46 INFO - Successfully installed psutil 17:17:46 INFO - Cleaning up... 17:17:46 INFO - Return code: 0 17:17:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17:46 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')]} 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 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')]} 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:46 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:46 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 17:17:46 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 17:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:46 INFO - 'HOME': '/Users/cltbld', 17:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:46 INFO - 'LOGNAME': 'cltbld', 17:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:46 INFO - 'MOZ_NO_REMOTE': '1', 17:17:46 INFO - 'NO_EM_RESTART': '1', 17:17:46 INFO - 'PAGER': '/bin/cat', 17:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:46 INFO - 'PWD': '/builds/slave/test', 17:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:46 INFO - 'SHELL': '/bin/bash', 17:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:46 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:46 INFO - 'USER': 'cltbld', 17:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:46 INFO - 'XPC_FLAGS': '0x0', 17:17:46 INFO - 'XPC_SERVICE_NAME': '0', 17:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:49 INFO - Installing collected packages: mozsystemmonitor 17:17:49 INFO - Running setup.py install for mozsystemmonitor 17:17:49 INFO - Successfully installed mozsystemmonitor 17:17:49 INFO - Cleaning up... 17:17:49 INFO - Return code: 0 17:17:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:49 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')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:49 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 17:17:49 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 17:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:49 INFO - 'HOME': '/Users/cltbld', 17:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PAGER': '/bin/cat', 17:17:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:49 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - 'XPC_FLAGS': '0x0', 17:17:49 INFO - 'XPC_SERVICE_NAME': '0', 17:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 INFO - Downloading docopt-0.6.1.tar.gz 17:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:53 INFO - Running setup.py install for blobuploader 17:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:53 INFO - Running setup.py install for requests 17:17:54 INFO - Running setup.py install for docopt 17:17:54 INFO - Successfully installed blobuploader requests docopt 17:17:54 INFO - Cleaning up... 17:17:54 INFO - Return code: 0 17:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:54 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')]} 17:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:54 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')]} 17:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:54 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:54 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 17:17:54 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 17:17:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:54 INFO - 'HOME': '/Users/cltbld', 17:17:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:54 INFO - 'LOGNAME': 'cltbld', 17:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:54 INFO - 'MOZ_NO_REMOTE': '1', 17:17:54 INFO - 'NO_EM_RESTART': '1', 17:17:54 INFO - 'PAGER': '/bin/cat', 17:17:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:54 INFO - 'PWD': '/builds/slave/test', 17:17:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:54 INFO - 'SHELL': '/bin/bash', 17:17:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:54 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:54 INFO - 'USER': 'cltbld', 17:17:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:54 INFO - 'XPC_FLAGS': '0x0', 17:17:54 INFO - 'XPC_SERVICE_NAME': '0', 17:17:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-C5W8tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-vDA3Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-9hpskn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-mp0m7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-rysuax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-KNFNCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Mrkdeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-u1CA31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-5gVxf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-4IFf7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-siVWQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-vwSvhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ybhCgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-onAFQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-HT281b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-eQH5Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:56 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-5Aii4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:56 INFO - Running setup.py install for manifestparser 17:17:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Running setup.py install for mozcrash 17:17:57 INFO - Running setup.py install for mozdebug 17:17:57 INFO - Running setup.py install for mozdevice 17:17:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Running setup.py install for mozfile 17:17:57 INFO - Running setup.py install for mozhttpd 17:17:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Running setup.py install for mozinfo 17:17:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Running setup.py install for mozInstall 17:17:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:57 INFO - Running setup.py install for mozleak 17:17:58 INFO - Running setup.py install for mozlog 17:17:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Running setup.py install for moznetwork 17:17:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Running setup.py install for mozprocess 17:17:58 INFO - Running setup.py install for mozprofile 17:17:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Running setup.py install for mozrunner 17:17:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:58 INFO - Running setup.py install for mozscreenshot 17:17:58 INFO - Running setup.py install for moztest 17:17:59 INFO - Running setup.py install for mozversion 17:17:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:59 INFO - Cleaning up... 17:17:59 INFO - Return code: 0 17:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:59 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:17:59 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 17:17:59 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 17:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:59 INFO - 'HOME': '/Users/cltbld', 17:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:59 INFO - 'LOGNAME': 'cltbld', 17:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:59 INFO - 'MOZ_NO_REMOTE': '1', 17:17:59 INFO - 'NO_EM_RESTART': '1', 17:17:59 INFO - 'PAGER': '/bin/cat', 17:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:59 INFO - 'PWD': '/builds/slave/test', 17:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:59 INFO - 'SHELL': '/bin/bash', 17:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:17:59 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:59 INFO - 'USER': 'cltbld', 17:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:59 INFO - 'XPC_FLAGS': '0x0', 17:17:59 INFO - 'XPC_SERVICE_NAME': '0', 17:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-R3GXSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:59 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)) 17:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-2bENWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:59 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)) 17:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_zKOeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:59 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)) 17:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-v7y7rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:59 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)) 17:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-kUXu4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-zblOTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-dr6Vr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8PpeGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-zYui3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-SfF4oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-khphyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-5NCnOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-2kQ5_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:00 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)) 17:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:00 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-GTothq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:01 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)) 17:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:01 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-fHLh0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:01 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)) 17:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:01 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-PJa2aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:01 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)) 17:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:01 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-pD2Uu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:01 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)) 17:18:01 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)) 17:18:01 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)) 17:18:01 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)) 17:18:01 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)) 17:18:01 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)) 17:18:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:03 INFO - Downloading blessings-1.6.tar.gz 17:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:03 INFO - Installing collected packages: blessings 17:18:03 INFO - Running setup.py install for blessings 17:18:04 INFO - Successfully installed blessings 17:18:04 INFO - Cleaning up... 17:18:04 INFO - Return code: 0 17:18:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:04 INFO - Reading from file tmpfile_stdout 17:18:04 INFO - Current package versions: 17:18:04 INFO - blessings == 1.6 17:18:04 INFO - blobuploader == 1.2.4 17:18:04 INFO - docopt == 0.6.1 17:18:04 INFO - manifestparser == 1.1 17:18:04 INFO - mozInstall == 1.12 17:18:04 INFO - mozcrash == 0.17 17:18:04 INFO - mozdebug == 0.1 17:18:04 INFO - mozdevice == 0.48 17:18:04 INFO - mozfile == 1.2 17:18:04 INFO - mozhttpd == 0.7 17:18:04 INFO - mozinfo == 0.9 17:18:04 INFO - mozleak == 0.1 17:18:04 INFO - mozlog == 3.1 17:18:04 INFO - moznetwork == 0.27 17:18:04 INFO - mozprocess == 0.22 17:18:04 INFO - mozprofile == 0.28 17:18:04 INFO - mozrunner == 6.11 17:18:04 INFO - mozscreenshot == 0.1 17:18:04 INFO - mozsystemmonitor == 0.0 17:18:04 INFO - moztest == 0.7 17:18:04 INFO - mozversion == 1.4 17:18:04 INFO - psutil == 3.1.1 17:18:04 INFO - requests == 1.2.3 17:18:04 INFO - wsgiref == 0.1.2 17:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:04 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:18:04 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 17:18:04 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 17:18:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:18:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:04 INFO - 'HOME': '/Users/cltbld', 17:18:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:04 INFO - 'LOGNAME': 'cltbld', 17:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:04 INFO - 'MOZ_NO_REMOTE': '1', 17:18:04 INFO - 'NO_EM_RESTART': '1', 17:18:04 INFO - 'PAGER': '/bin/cat', 17:18:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:04 INFO - 'PWD': '/builds/slave/test', 17:18:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:04 INFO - 'SHELL': '/bin/bash', 17:18:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:18:04 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:18:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:04 INFO - 'USER': 'cltbld', 17:18:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:04 INFO - 'XPC_FLAGS': '0x0', 17:18:04 INFO - 'XPC_SERVICE_NAME': '0', 17:18:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 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)) 17:18:04 INFO - Cleaning up... 17:18:04 INFO - Return code: 0 17:18:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:04 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:18:04 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 17:18:04 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 17:18:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:18:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:04 INFO - 'HOME': '/Users/cltbld', 17:18:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:04 INFO - 'LOGNAME': 'cltbld', 17:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:04 INFO - 'MOZ_NO_REMOTE': '1', 17:18:04 INFO - 'NO_EM_RESTART': '1', 17:18:04 INFO - 'PAGER': '/bin/cat', 17:18:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:04 INFO - 'PWD': '/builds/slave/test', 17:18:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:04 INFO - 'SHELL': '/bin/bash', 17:18:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:18:04 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:18:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:04 INFO - 'USER': 'cltbld', 17:18:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:04 INFO - 'XPC_FLAGS': '0x0', 17:18:04 INFO - 'XPC_SERVICE_NAME': '0', 17:18:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:04 INFO - Downloading/unpacking jsonschema 17:18:04 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 17:18:04 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 17:18:04 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 17:18:04 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 17:18:04 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 17:18:04 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 17:18:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:07 INFO - Downloading/unpacking functools32 (from jsonschema) 17:18:07 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 17:18:07 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 17:18:07 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 17:18:07 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 17:18:07 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 17:18:07 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 17:18:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:07 INFO - warning: no files found matching '*.txt' 17:18:07 INFO - no previously-included directories found matching 'build' 17:18:07 INFO - no previously-included directories found matching 'dist' 17:18:07 INFO - no previously-included directories found matching '.git*' 17:18:07 INFO - Installing collected packages: jsonschema, functools32 17:18:07 INFO - Running setup.py install for functools32 17:18:08 INFO - warning: no files found matching '*.txt' 17:18:08 INFO - no previously-included directories found matching 'build' 17:18:08 INFO - no previously-included directories found matching 'dist' 17:18:08 INFO - no previously-included directories found matching '.git*' 17:18:08 INFO - Successfully installed jsonschema functools32 17:18:08 INFO - Cleaning up... 17:18:08 INFO - Return code: 0 17:18:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:08 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 0x10da03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d0469000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, '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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 17:18:08 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 17:18:08 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 17:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:08 INFO - 'HOME': '/Users/cltbld', 17:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:08 INFO - 'LOGNAME': 'cltbld', 17:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:08 INFO - 'MOZ_NO_REMOTE': '1', 17:18:08 INFO - 'NO_EM_RESTART': '1', 17:18:08 INFO - 'PAGER': '/bin/cat', 17:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:08 INFO - 'PWD': '/builds/slave/test', 17:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:08 INFO - 'SHELL': '/bin/bash', 17:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:18:08 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:08 INFO - 'USER': 'cltbld', 17:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:08 INFO - 'XPC_FLAGS': '0x0', 17:18:08 INFO - 'XPC_SERVICE_NAME': '0', 17:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:08 INFO - Downloading/unpacking flake8 17:18:08 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 17:18:08 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 17:18:08 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 17:18:08 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 17:18:08 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 17:18:08 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 17:18:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:12 INFO - no previously-included directories found matching 'docs/_build' 17:18:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:12 INFO - Running setup.py install for pep8 17:18:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:12 INFO - no previously-included directories found matching 'docs/_build' 17:18:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:18:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:12 INFO - Cleaning up... 17:18:12 INFO - Return code: 0 17:18:12 INFO - Running post-action listener: _resource_record_post_action 17:18:12 INFO - Running post-action listener: _start_resource_monitoring 17:18:12 INFO - Starting resource monitoring. 17:18:12 INFO - ##### 17:18:12 INFO - ##### Running install step. 17:18:12 INFO - ##### 17:18:12 INFO - Running pre-action listener: _resource_record_pre_action 17:18:12 INFO - Running main action method: install 17:18:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:12 INFO - Reading from file tmpfile_stdout 17:18:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:12 INFO - Reading from file tmpfile_stdout 17:18:12 INFO - Output received: 17:18:12 INFO - Usage: mozinstall [options] installer 17:18:12 INFO - Options: 17:18:12 INFO - -h, --help show this help message and exit 17:18:12 INFO - -d DEST, --destination=DEST 17:18:12 INFO - Directory to install application into. [default: 17:18:12 INFO - "/builds/slave/test"] 17:18:12 INFO - --app=APP Application being installed. [default: firefox] 17:18:12 INFO - mkdir: /builds/slave/test/build/application 17:18:12 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'] 17:18:12 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 17:18:46 INFO - Reading from file tmpfile_stdout 17:18:46 INFO - Output received: 17:18:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:18:46 INFO - Running post-action listener: _resource_record_post_action 17:18:46 INFO - ##### 17:18:46 INFO - ##### Running run-tests step. 17:18:46 INFO - ##### 17:18:46 INFO - Running pre-action listener: _resource_record_pre_action 17:18:46 INFO - Running main action method: run_tests 17:18:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:46 INFO - 2016-04-25 17:18:46.613 screenresolution[1917:10618] starting screenresolution argv=screenresolution get 17:18:46 INFO - 2016-04-25 17:18:46.616 screenresolution[1917:10618] Display 0: 1600x1200x32@60 17:18:46 INFO - 2016-04-25 17:18:46.621 screenresolution[1918:10620] starting screenresolution argv=screenresolution list 17:18:46 INFO - Available Modes on Display 0 17:18:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:46 INFO - Intel Iris: 17:18:46 INFO - Chipset Model: Intel Iris 17:18:46 INFO - Type: GPU 17:18:46 INFO - Bus: Built-In 17:18:46 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:46 INFO - Vendor: Intel (0x8086) 17:18:46 INFO - Device ID: 0x0a2e 17:18:46 INFO - Revision ID: 0x0009 17:18:46 INFO - Displays: 17:18:46 INFO - Display: 17:18:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:46 INFO - Display Serial Number: 1600x1200 60 17:18:46 INFO - Main Display: Yes 17:18:46 INFO - Mirror: Off 17:18:46 INFO - Online: Yes 17:18:46 INFO - Rotation: Supported 17:18:46 INFO - Return code: 0 17:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:46 INFO - Python 2.7.3 17:18:46 INFO - Return code: 0 17:18:46 INFO - grabbing minidump binary from tooltool 17:18:46 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')]} 17:18:46 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 0x10d8a2e00>, '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 0x10d70bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d89db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:46 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 17:18:46 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 17:18:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:46 INFO - Return code: 0 17:18:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:18:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:18:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:48 INFO - Return code: 0 17:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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 17:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --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 17:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Oc5Wg1TJnK/Render', 17:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:48 INFO - 'HOME': '/Users/cltbld', 17:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:48 INFO - 'LOGNAME': 'cltbld', 17:18:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:48 INFO - 'MOZ_NO_REMOTE': '1', 17:18:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:48 INFO - 'NO_EM_RESTART': '1', 17:18:48 INFO - 'PAGER': '/bin/cat', 17:18:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:48 INFO - 'PWD': '/builds/slave/test', 17:18:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:48 INFO - 'SHELL': '/bin/bash', 17:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zUdrg4ALS1/Listeners', 17:18:48 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 17:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:48 INFO - 'USER': 'cltbld', 17:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:48 INFO - 'XPC_FLAGS': '0x0', 17:18:48 INFO - 'XPC_SERVICE_NAME': '0', 17:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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 17:18:48 INFO - mozversion application_buildid: 20160425152612 17:18:48 INFO - mozversion application_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 17:18:48 INFO - mozversion application_display_name: Nightly 17:18:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:48 INFO - mozversion application_name: Firefox 17:18:48 INFO - mozversion application_remotingname: firefox 17:18:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:18:48 INFO - mozversion application_vendor: Mozilla 17:18:48 INFO - mozversion application_version: 49.0a1 17:18:48 INFO - mozversion platform_buildid: 20160425152612 17:18:48 INFO - mozversion platform_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 17:18:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:18:48 INFO - mozversion platform_version: 49.0a1 17:18:48 INFO - using testdate: 1461629928 17:18:48 INFO - actual date: 1461629928 17:18:48 INFO - starting webserver on 'localhost:50275' 17:18:48 INFO - SUITE-START | Running 2 tests 17:18:48 INFO - TEST-START | dromaeo_css 17:18:48 INFO - operating with platform_type : mac_ 17:18:48 INFO - Initialising browser for dromaeo_css test... 17:18:48 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpMjlAHu/profile http://localhost:50275/getInfo.html) 17:18:51 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 17:18:51 INFO - PROCESS | 1936 | colorDepth:24 17:18:51 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 17:18:51 INFO - PROCESS | 1936 | __metrics 17:18:51 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:18:51 INFO - TEST-INFO | 1936: exit 0 17:18:51 INFO - Browser initialized. 17:18:51 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:51 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpMjlAHu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:03 INFO - PROCESS | 1939 | RSS: Main: 249954304 17:19:03 INFO - PROCESS | 1939 | 17:19:53 INFO - PROCESS | 1939 | 1461629993339 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] 17:22:04 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50275/tests/dromaeo/cssquery-ext.html) 17:22:05 INFO - PROCESS | 1939 | RSS: Main: 261730304 17:22:05 INFO - PROCESS | 1939 | 17:25:08 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-ext.html (next: http://localhost:50275/tests/dromaeo/cssquery-jquery.html) 17:25:08 INFO - PROCESS | 1939 | RSS: Main: 273666048 17:25:08 INFO - PROCESS | 1939 | 17:28:10 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50275/tests/dromaeo/cssquery-mootools.html) 17:28:11 INFO - PROCESS | 1939 | RSS: Main: 275767296 17:28:11 INFO - PROCESS | 1939 | 17:31:12 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50275/tests/dromaeo/cssquery-prototype.html) 17:31:13 INFO - PROCESS | 1939 | RSS: Main: 277356544 17:31:13 INFO - PROCESS | 1939 | 17:34:16 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50275/tests/dromaeo/cssquery-yui.html) 17:34:16 INFO - PROCESS | 1939 | RSS: Main: 280203264 17:34:16 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50275/tests/dromaeo/cssquery-yui.html (next: http://localhost:50275/tests/dromaeo/cssquery-dojo.html) 17:37:19 INFO - PROCESS | 1939 | RSS: Main: 281448448 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | __start_tp_report 17:37:19 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 17:37:19 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 17:37:19 INFO - PROCESS | 1939 | |i|pagename|runs| 17:37:19 INFO - PROCESS | 1939 | |0;dojo.html;3504.491848681941;3507.649235076492;3523.911902202446;3537.92924141517;3552.8630838131808;4806.783694733736;5761.049426844576;5823.67969761663;5827.094748659961;5830.300363956326;5812.854678633036;5993.34073251943;6002.579819412643;6051;6073.878522429549;5267.367915850094;5274.367075950891;5336.439673834249;5370.113931201347;5433.266509021271;5454.59090568207;5478.616496845222;5481.287432633752;5484.067708489546;5529.585281103913;5259.894802103975;5317.069512835238;5344.599155063386;5366.9463305366835;5376.569874410038;4617;5346.705931173784;5350.3312085989255;5355.758990845382;5374.220737993008;4304.397384366192;4718.631596836914;4783.4499032611;5284.603654725911;5311.990721762852;5514.641548299388;5684.147377893308;5747.59766816323;5814.982378083861;5826.621269617462;6203.720832562501;6286.277078135981;6296.559240853142;6310.810675679737;6352.205974253218;6323.05154226865;6327.4938004959495;6327.968360158216;6334.3032266450655;6340.968295158541;5901.704914754245;6009.819705408845;6088.786892458787;6093.39066093396;6124.020156774984;6407.167068281094;6460.160179176771;6465.418112369909;6471.255805582418;6477.676116194266;6115.510759139258;6310.368963103745;6323.462505686976;6328.050792381179;6339.11252424661;6173.32093469718;6243.937560624336;6286.497080233662;6359.618422894641;6363.522735794834;6214.533909956771;6297.275813281532;6310.274318453345;6314.810555683337;6336.461400780985;4822.831200907952;6261.780837670751;6277.96861015692;6284.717187726564;6297.622142671363;5055.16589762685;5070.721110338966;5075.7969681212335;5076.543111120017;5108.6168537359845;4427.667924905645;4431;4436.689431739812;4439.778011099432;4485.910281794346;4436.778161091933;4916.950830491649;4940.912999140183;5862.94137058624;6060.787872424444;6342.968285158637;6359.8092057238355;6378.075179099097;6388.425041746173;6427.421532062137;5956.821295361146;6104.328523862371;6111.449969502677;6117.84705382369;6163.84590385244;5465.453454654503;5528.419515950767;5534.418886016991;5586.329640443091;5654.943450565442;6560.40956313934;6616.338366163442;6627.834304142242;6628.072069910217;6633.2040155181685;6363.5863668861375;6394.648294343856;6406.5515413920575;6407.455366293917;6411.134496842867;6426.742930282923;6455.644939528371;6544.214694236722;6603.141591593062;6618.205815302194;6275.090111933835;6302.495800336053;6304.085907543472;6314.905276420765;6321.241451025906;5729.68486733217;6183.412575805291;6354.301026887131;6367.108604795425;6368.872622547616;4848.660593758403;6173.104899789595;6203.379662033761;6286.025666021774;6313.46335561464;6281.246250449793;6288.182536270256;6288.213973253343;6296;6301.464375528131;6056.36408177135;6129.448349648553;6159.907601386072;6221.09794079865;6231.189945307081;6112.26032301701;6201;6287.1512345832725;6310.7791227306825;6311.337309582428;5960.970195148997;6196.938030619636;6221.906671399842;6242.126102345766;6277.529185311028 17:37:19 INFO - PROCESS | 1939 | |1;ext.html;489.3784893185654;513.3916309173629;569.2173261765073;596.427429667519;609.7987664070854;37897.621023789754;38667.61332386675;38760.80619596898;38781.80609096954;38805.805970970105;39301;39952.801415957496;39955.60044399555;40157.79921100398;40226.79886600563;9326.347155699104;9455.101765332316;9514.524273786317;9550.235981121494;9559.904400956006;9021.278297736199;9312.83589551306;9424.151826335628;9551.474668893208;9555.235581153525;8154.34765218784;9625.133737963582;9656.75858103546;9688.66089686861;9694.321397502177;9531.618735250617;9598.80802383952;9607.951960240223;9625.855612165824;9645.22838172948;9506.714798556055;9608.663696770649;9611.471369074698;9622.326437149331;9627.807443851083;35179;35350;35561.46657800135;35751.28497430037;35837.82081089604;3169.714725674677;3248.3828072666356;3372.1232479555247;3473.270613171237;3476.026712520498;27945.301367465774;28552.857235713895;28673.56989645157;29080.418391632047;29531.852340738373;2686.502996945552;2723.6050772637855;2724.278066312429;2738.87675054623;2844.1894060192744;435505;443220;443522;446230.99999999674;449204;35235.64764352324;68726.31273687299;68806.62386752237;69605.65197173982;69901.65049174824;31087.844560777503;31664;37345.879623611334;37901.62098379036;37934.05164870845;12993.220406775623;15240.542783716506;15497.767533487007;15514.5345639631;15521.45674901373;10984.340939543494;12908.16096953695;12974.962003039924;13023.544175953795;13108.475660973645;8296.253337199681;8424.031236407769;8532;8547.786305342415;8601.22588966996;3568.7680300780366;3576.678098971105;3606.0804494853646;3622.185008373095;3639.381305178073;912.8037471943564;966.9129778319985;1000.5197505197546;1004.2919741582167;1108.9650491348305;23936.40158996004;26841.926322947253;27460.038898638453;27921.022764203157;28312;1017.7862648843677;1092.191778084212;1096.2052511928948;1157.288267715349;1218.4516967364543;14676.853231467549;14789.334479948428;14858.331375088146;15023;15428.30572624212;550314;559378;561238;561755;564047;57372.85254294891;58695.358708858206;59306.110408343906;59400.702996485605;59783.70108149431;1436.3033928544648;1449.9057561258485;1489.7318482673222;1491.3065424577408;1493.4399600149943;28465.28836779097;28633.570496442153;29058.854705726335;29123.980660676774;29250.561241581818;49343;51290.48709513006;52026.21960670668;52816.73591632171;53035;544650.55349446;547321;554803;557325;560417.1979140078;36883;37453.25093498169;42122.7893860541;43060.138797223255;43808.80955952253;45644.77177614091;45684.54315456936;45710;45935.08129837451;45958.310625339975;37987.810060949516;38056;38138.61861381351;38571.421428679154;39105.80447097746;30097.3980520384;34882.47676284909;35122.297554049284;37565;37904.620953791215;32443.290284956358;34467;37034;37399.25201496009;38307.80846095863;28673.996410125546;32055.519167212045;32346.676533234368;32932.50601240935;32944.83527582347;20090.89954550218;21584.892075539523;24352.878235608707;24527.386815329046;24918.875405622857 17:37:19 INFO - PROCESS | 1939 | |2;jquery.html;387.1675896821833;391.4324229866694;396.1127075351212;399.1757021750086;403.8102092016751;20188.798112018892;20428.897855510702;21273.82993935335;21297.041633126508;21329.68005479915;19984.800151998475;20181.19275228989;21311.147554097817;21514.784852151475;21547.67678484824;4154.5637708040595;5320.813771517997;5357.4374690657305;5361.410244873061;5369.463053694639;4734.857954261378;5295.364556253255;5323.201519772027;5432.293801805759;5433.891322173554;5367.490088441611;5388.245645609618;5413;5416.783328666848;5442.700651464168;5417.052015897222;5443.646162999412;5556.111022236463;5915.319738230072;5924.496417804492;4915.213565829486;5437.13005919051;5738.454846789548;5739.483446489794;5867.706614669292;24129.03483860661;24355;24777.380565485826;25053.747312634478;25626.48747025068;2114.407965769587;2170.370592528165;2193.5283913958415;2199.285232299509;2211.7788221177916;9981.101700846959;10006.69979900604;10029.650894245106;10289.691309260734;10323.84514232287;1683.5117815833394;1766.8498177654915;1784.5003399048287;1784.5895444047812;1797.3170195325824;97133;127252;129170.3541482296;129689;130740.99999999905;9672.468014259282;11587.826182607268;11844.88155118455;11922.642320730392;11987.580434684744;15454.459093931659;15467.613309667347;15489.690206195814;15525.45660901863;15537.30082146306;8721.30229581632;8910.821783564292;8939.329550283755;8982.191602755653;9039.548022598843;8816.515091669891;8828.690995815115;8875.600597973107;8948.821023579492;8960.148785865333;3905.4727611772614;4654.208784506574;4691.272852707768;4699.2481203007355;4765.237561990065;1979.0104947526238;2012.9899350503447;2016.1935225909754;2029.1883246701439;2065.1223230127134;878.767126711422;943.4433684126261;977.7164622259465;986.3490096536395;1078.8813230544633;20467.692984605244;20633.58732825335;20728.792712072987;21025;21131.788682112983;814.470594113819;931.7158266728577;1012.3875055591409;1034.2656713733184;1043.9530221140067;10759.78480430387;11079.446027698583;11088.889111108947;11106.833397499044;11111.444427778579;435757;536715;549053;549284;550991;60028.69985650044;91251;132484;135126.32436837754;135827.32086339704;975.2636759246724;978.105033893979;1000.429755039635;1002.2533212756397;1008.3344992305043;18271.725924110884;18512.81487185165;18519.259229631203;18644.813551864307;18804.05979701037;45114.19543218234;52129.47870521246;54233.457665422844;54910.76338549249;55227.44772552384;49635.751821240665;59078.93223737148;71761;74907;80942.59528702318;7859.096203936392;7898.249666281694;8009.519428834288;8087.433879628369;8323.417360784686;7389.778306650809;11365.147613929154;12350.258984460961;12909.54816581415;13106.541271055466;9552.85670714926;10004.599816007569;10455.16358691318;10644.89355106439;11272.718182045515;10551.525181366704;10715.981981711724;10861.891381086403;10969.451527423438;11219.831702524632;11156.442177891235;11229.045531129945;11701.531938722355;11781.646550603497;11858.16992810495;7986.84026319482;8057.194280571896;8131.105578386255;8143.79640508992;8192.877106843283;8154.02151741771;10281.948590257001;11068.446577670924;11269.985701286596;11573.421328933351 17:37:19 INFO - PROCESS | 1939 | |3;mootools.html;1435.9282035898202;1615.5234205909255;1851.45403588004;1921.1546919355492;1952.8828270303784;7859.68561257549;8421.91578084219;8426.620802063906;8790.120987901206;8895.066018068099;8474.23731864132;8490.490570565755;8510.914890851089;8601.053884072748;8616.138386161381;2428.611422172453;2438.146648672959;2460.9138680146198;2462.0398044762555;2464.0143942423083;2056.6812144117685;2348.7181538215355;2399.0044131685418;2453.1659235859806;2462.9507409851794;2400.9159679411223;2419.0565679385054;2421.927342179729;2426.8543887366727;2434.3914021494625;2384.8688322142275;2389.9842566909083;2408.157144999254;2419.7822196002357;2421.406755344934;2368.609179485383;2380.488195038075;2395.137750409851;2400.099962514057;2412.372783076395;8611.397202195849;8686.913130868737;8687.913120868774;8748.212660860552;8783.077776833468;5221.895562088737;5386.569074474032;5478.58910581708;5479.0959491683825;5486.61593688442;3514;3570.785752854837;3598.47822065799;3618.565772107364;3622.0118402318194;1038.1383451735041;1038.8961103889626;1039.77644806367;1040.5577629507504;1043.2332235806675;11370.602028928948;11474.770504589946;11483.023942964857;11511.942440287829;11549.480273387633;3927.03787572041;4030.7581545107387;4865.440474345495;4910.042541704333;4924.507549245047;9815.705528834147;9867.358621689711;9925.60297588103;9945.900540994497;9948.751281218027;5324.254604355393;5346.572274218053;5396.703181325065;5431.619786614899;5528.226048353234;4428.977855110704;4725.149473094876;4950.752462376867;4962.503749625009;5018.121828679967;4013.8394464221105;4104.798821086206;4112.300908845504;4120.75275483472;4129.504459464823;1357.6402253402857;1389.3261768042491;1390.0894913831457;1391.4712409284407;1395.7627203375248;926;931.9161275485238;935.1163150822543;963.3160456076124;976.8925418203992;5679.858003549862;5824.417558244142;5836.358000619928;5887;6072.240969878765;453.75270477589135;464.37077759635883;479.69779039205076;480.4498848818084;1000.4147573669485;3490.842912068963;3781.205946751158;3902.31709450845;3991.720579559403;4015.5181378234215;10024;10226.693199204035;10390.480475976323;10527.894721052844;10552.050315471644;10168.949155254177;10263.332883362558;10344.275900687031;10422.687319380431;10463.790724185474;6847.589144651337;7824.178461261599;7925.603719813987;8110.878336824952;8140.837183256302;5660.462256085665;5830.7959221427045;5877.294724633071;5933.910991335047;5937.732802024006;9677.080677335642;9772.364796288219;9842.311038227255;9905.158061564847;9932.950335248277;9650.420974741539;9757.902420975699;9868.506574671093;9989;10004.099631033241;6438.935610643834;6720.126383570105;6948.965255173692;7008.684609192701;7023.648817558999;8118.350531957311;8141.51150930946;8165.591720413837;8224.342052635895;8230.794230144054;7237.8914316286355;7381.1511676157925;7388.187299397169;7506;7506.962465187639;7277.490575659653;7364.631768411665;7552.282533159341;7654.69381224767;7664.73173438927;6792.966035169792;6851.45188384918;6866.896996545156;6883.105196324445;6907.376766459777;4911.10244955478;5042.520960508746;5119.590432765295;5136.486351364983;5341.439148889466;4039.8788036358956;4969.229769385751;5089.949100508948;5215.869603259949;5462.808801691922 17:37:19 INFO - PROCESS | 1939 | |4;prototype.html;316.81624657698524;322.1655911190018;330.86434561829657;331.75947438107374;332.0768264225454;4833.806647734091;4910.6071514278865;5296.443873393296;5435.891282174354;5667.773289068437;4100.712950093487;4616.838410655628;4725.6928299660585;5400.324959380077;5492.725363731807;4217;4218.535961044283;4243.490781106264;4244.0663054128045;4272.700910936236;3242.913623935984;4171.749695018293;4238.512571054322;4244.469441319835;4307.956920430803;3417.333619944112;3755.5309182073383;3875.379939209727;4105.460452330376;4137.524184718751;3498.667626575484;4131.566185550504;4145.585441455845;4148.854790082332;4182.728122672017;2951.5720220567896;3437.570303712036;3625.981870090659;3638.745287829853;3689.4465830125428;5060.873478163038;5267.631265811395;5288.762005709752;5344.545713614348;5361.973190134064;4720.197566413718;4768.47546769855;4787;4793.209120495114;4800.759962001921;4893.877653058702;5632.464915832989;5829.68832012798;5855.092460668603;6003.6397816131175;3407.30150319184;3702.629737026303;3833.367494363427;3961.841526338943;3975.185087057146;5293.168155037037;5605.803796867131;6053.1828203192445;6155.169052177944;6155.599886007395;4021.3565829467143;4032.931273212601;4038.656714179269;4060.127072679388;4075.347944328893;3413.4026545354463;3887.969688032617;4107.322291821816;4282.593153650399;4291.570842915684;4428.180786554498;4535.229011068126;4879.829205977774;4924.581410580141;4961.925571116436;4995.675281106716;5359.008583412081;5678.914816277759;5686.516646085046;5991.352378095971;1521.5283262188757;1556.167450414023;1565.6946895355297;1566.3577933047395;1576.3694522191215;875.7766769473743;935.2845073518764;1009.6264382178641;1021.4892553723139;1046.5709059285657;4900.166971614834;5874.647521148745;5887.558433117533;5889.5582831286965;6023.849403764853;6517.869642607121;6528.249251336157;6549.347514256734;6567.8358041048405;6568.67156642166;4788.7366194859615;4910.116179087799;4983.576396006308;5852.385499522574;5874.9118763218585;3037.255872311298;3155.3689262147204;3468.757186996886;3483.320752453247;3485.8387799564434;5713.5714821388565;6471.935280647133;6845.863082738318;6854.34883686049;6857.417119544794;6326.873462530723;6385.808425747235;6621.569597976116;6755.594664320157;6762.459003279824;6468.741250350027;6521.67391630426;6613.636250006296;6759;6846.8972965405555;5598.692071936082;6030.517558595389;6515.706793194223;6557.409833115043;6591.769288074895;6448.355164483514;6466.642005178777;6500.837479063061;6509.544331896911;6510.632767118958;5757.3954734753925;6546.116274302908;6706.362895524917;6770.187577490536;6790.287019862843;4440.067585807016;4460.553944605514;4460.843870464518;4479.894449608679;4498.617617502418;5135.639055650181;5212.4005739338945;5577.3028371453565;6561.179852518435;6617.139771829631;5142.331496905378;5401.837944861661;5838.357780644211;5849.94150058494;5862.882742345215;5379.435159308373;5847.707614619337;5888.705564721832;5895;5927.199828023162;4866.756662166807;5756.42435756421;5786;5787.421257874179;5854.326752423355;4773.522647735337;5134.717590532557;5842.267763111893;5903.675297858659;5913.9596839090445;5122.259591118734;5450.727463626724;5794.565407594363;5819.476247137609;5853.297604287342 17:37:19 INFO - PROCESS | 1939 | |5;yui.html;674.6390680985672;680.3434685528467;759.2483441393023;766.3600893254132;774.1639029847765;14295.714085718293;14652.194129322883;14894.553163405102;14942.850571494295;14962.551123466286;11678.240914340562;13476.73046539071;13717.0398072135;13833.100848444845;13839.584812455643;711.7295427737479;888.5557221389305;906.3700727994063;911.8951320598117;925.1165137293868;913.2100732866089;917.2891009467683;922.2483675804232;923.1414784250644;923.4274749655223;960.5293406230967;962.5187406296851;962.8170647576937;967.1150896929302;968.2447690801151;957.2629075611775;959.491469521155;963.8313295173351;964.7491652170417;965.2615748951987;702.2836706559281;703.0157779109237;710.0449894891362;711.5872793779596;715.1596873673413;14364.856351436561;14383.568492945229;14605.561833145022;14780.408783648641;14829.48096816617;12509.56216532417;12689.746205075939;12711.427985740664;12726.87273127266;12880.935595321964;9628.229741620653;9708.514574271258;9928.205743540499;10041.648542300984;10139.188864890792;3471.09751464621;3472.305538892206;3496.493008513751;3589.892303230881;3595.7482976191413;81509;82289;82348;82351;82595.5870220645;9242.630294788134;9442.150206481312;9474.147326740489;9717.076877696607;9733.56198971048;18974.43076707701;21958.780412195672;22057.558848823253;22067.448313792283;22168.667469987962;7439.702411903571;7474.289942455458;7497.812554686177;7530.548167109991;7599.924000759922;3944.861929832442;3998.34027385484;4058.127502586958;4061.7156799023783;4064.4106604542176;3548.964510354915;3560.501529785832;3593.7664051836546;3625.3836847735947;3628.4920111184456;642.922849258092;659.1891972873296;660.428729149292;663.1445435388295;664.833791552112;470.79285114550174;476;496.9875753106129;580.9651420914759;610.3377835049022;8019;8050;8052.516848989079;8207.669215746022;8256.587170641444;482.45723560993883;530.9177077552986;587.8412828536271;599.9250093738283;615.9661218633019;3034.514477683604;3498.7201023918024;3847.6729477994686;3849.230153969161;4014.3070458728175;81621.77567336494;82940.281760379;91879;91962.54018729998;92777.60833587502;77640.83538746924;78652;79847.20152798513;80188.19811801807;81611;71244;71767.89972852262;72564.27435725681;72966;73090.63454682799;6338.366163383625;7596.164421913474;7747.6513556891205;7805.648745806338;7858.842823143391;44734.77632611816;44845;45387.41144059942;45658.315125272486;46521;60323.69838150781;60374.79250415055;61225.38774612197;64379.034314486256;64522.35477645163;10834.07910327631;10848.945755271174;10850.891491084989;10977;11187.216894817284;11795.35125568102;11831;11883.702907427383;12158.088143389105;12550.497980080694;11040.668779936615;11386.487608057823;11458.484368203617;11622.012128969132;11687.76624467489;11363.090952723596;11400.372979485875;11432;11444.656660300205;11805.76388472243;11286.887131128911;11425.485853136795;11490.310581365145;11507.309561426342;11690.76618467609;9661.46861922601;9909.851352229867;9999.450030248407;10141.290109692545;10146.695599132037;9310.581023853807;9587.328886978125;9747.074027967332;9837.158508007777;9911.058449447291 17:37:19 INFO - PROCESS | 1939 | __end_tp_report 17:37:19 INFO - PROCESS | 1939 | __start_cc_report 17:37:19 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,417 17:37:19 INFO - PROCESS | 1939 | __end_cc_report 17:37:19 INFO - PROCESS | 1939 | __startTimestamp1461631039839__endTimestamp 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | ------- Summary: start ------- 17:37:19 INFO - PROCESS | 1939 | Number of tests: 6 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#0] dojo.html Cycles:165 Average:5840.29 Median:6159.91 stddev:701.04 (11.4%) stddev-sans-first:678.82 17:37:19 INFO - PROCESS | 1939 | Values: 3504.5 3507.6 3523.9 3537.9 3552.9 4806.8 5761.0 5823.7 5827.1 5830.3 5812.9 5993.3 6002.6 6051.0 6073.9 5267.4 5274.4 5336.4 5370.1 5433.3 5454.6 5478.6 5481.3 5484.1 5529.6 5259.9 5317.1 5344.6 5366.9 5376.6 4617.0 5346.7 5350.3 5355.8 5374.2 4304.4 4718.6 4783.4 5284.6 5312.0 5514.6 5684.1 5747.6 5815.0 5826.6 6203.7 6286.3 6296.6 6310.8 6352.2 6323.1 6327.5 6328.0 6334.3 6341.0 5901.7 6009.8 6088.8 6093.4 6124.0 6407.2 6460.2 6465.4 6471.3 6477.7 6115.5 6310.4 6323.5 6328.1 6339.1 6173.3 6243.9 6286.5 6359.6 6363.5 6214.5 6297.3 6310.3 6314.8 6336.5 4822.8 6261.8 6278.0 6284.7 6297.6 5055.2 5070.7 5075.8 5076.5 5108.6 4427.7 4431.0 4436.7 4439.8 4485.9 4436.8 4917.0 4940.9 5862.9 6060.8 6343.0 6359.8 6378.1 6388.4 6427.4 5956.8 6104.3 6111.4 6117.8 6163.8 5465.5 5528.4 5534.4 5586.3 5654.9 6560.4 6616.3 6627.8 6628.1 6633.2 6363.6 6394.6 6406.6 6407.5 6411.1 6426.7 6455.6 6544.2 6603.1 6618.2 6275.1 6302.5 6304.1 6314.9 6321.2 5729.7 6183.4 6354.3 6367.1 6368.9 4848.7 6173.1 6203.4 6286.0 6313.5 6281.2 6288.2 6288.2 6296.0 6301.5 6056.4 6129.4 6159.9 6221.1 6231.2 6112.3 6201.0 6287.2 6310.8 6311.3 5961.0 6196.9 6221.9 6242.1 6277.5 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#1] ext.html Cycles:180 Average:64600.90 Median:37960.93 stddev:139215.12 (366.7%) stddev-sans-first:139522.43 17:37:19 INFO - PROCESS | 1939 | Values: 489.4 513.4 569.2 596.4 609.8 37897.6 38667.6 38760.8 38781.8 38805.8 39301.0 39952.8 39955.6 40157.8 40226.8 9326.3 9455.1 9514.5 9550.2 9559.9 9021.3 9312.8 9424.2 9551.5 9555.2 8154.3 9625.1 9656.8 9688.7 9694.3 9531.6 9598.8 9608.0 9625.9 9645.2 9506.7 9608.7 9611.5 9622.3 9627.8 35179.0 35350.0 35561.5 35751.3 35837.8 3169.7 3248.4 3372.1 3473.3 3476.0 27945.3 28552.9 28673.6 29080.4 29531.9 2686.5 2723.6 2724.3 2738.9 2844.2 435505.0 443220.0 443522.0 446231.0 449204.0 35235.6 68726.3 68806.6 69605.7 69901.7 31087.8 31664.0 37345.9 37901.6 37934.1 12993.2 15240.5 15497.8 15514.5 15521.5 10984.3 12908.2 12975.0 13023.5 13108.5 8296.3 8424.0 8532.0 8547.8 8601.2 3568.8 3576.7 3606.1 3622.2 3639.4 912.8 966.9 1000.5 1004.3 1109.0 23936.4 26841.9 27460.0 27921.0 28312.0 1017.8 1092.2 1096.2 1157.3 1218.5 14676.9 14789.3 14858.3 15023.0 15428.3 550314.0 559378.0 561238.0 561755.0 564047.0 57372.9 58695.4 59306.1 59400.7 59783.7 1436.3 1449.9 1489.7 1491.3 1493.4 28465.3 28633.6 29058.9 29124.0 29250.6 49343.0 51290.5 52026.2 52816.7 53035.0 544650.6 547321.0 554803.0 557325.0 560417.2 36883.0 37453.3 42122.8 43060.1 43808.8 45644.8 45684.5 45710.0 45935.1 45958.3 37987.8 38056.0 38138.6 38571.4 39105.8 30097.4 34882.5 35122.3 37565.0 37904.6 32443.3 34467.0 37034.0 37399.3 38307.8 28674.0 32055.5 32346.7 32932.5 32944.8 20090.9 21584.9 24352.9 24527.4 24918.9 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#2] jquery.html Cycles:180 Average:32253.01 Median:24566.19 stddev:88330.06 (359.6%) stddev-sans-first:88545.44 17:37:19 INFO - PROCESS | 1939 | Values: 387.2 391.4 396.1 399.2 403.8 20188.8 20428.9 21273.8 21297.0 21329.7 19984.8 20181.2 21311.1 21514.8 21547.7 4154.6 5320.8 5357.4 5361.4 5369.5 4734.9 5295.4 5323.2 5432.3 5433.9 5367.5 5388.2 5413.0 5416.8 5442.7 5417.1 5443.6 5556.1 5915.3 5924.5 4915.2 5437.1 5738.5 5739.5 5867.7 24129.0 24355.0 24777.4 25053.7 25626.5 2114.4 2170.4 2193.5 2199.3 2211.8 9981.1 10006.7 10029.7 10289.7 10323.8 1683.5 1766.8 1784.5 1784.6 1797.3 97133.0 127252.0 129170.4 129689.0 130741.0 9672.5 11587.8 11844.9 11922.6 11987.6 15454.5 15467.6 15489.7 15525.5 15537.3 8721.3 8910.8 8939.3 8982.2 9039.5 8816.5 8828.7 8875.6 8948.8 8960.1 3905.5 4654.2 4691.3 4699.2 4765.2 1979.0 2013.0 2016.2 2029.2 2065.1 878.8 943.4 977.7 986.3 1078.9 20467.7 20633.6 20728.8 21025.0 21131.8 814.5 931.7 1012.4 1034.3 1044.0 10759.8 11079.4 11088.9 11106.8 11111.4 435757.0 536715.0 549053.0 549284.0 550991.0 60028.7 91251.0 132484.0 135126.3 135827.3 975.3 978.1 1000.4 1002.3 1008.3 18271.7 18512.8 18519.3 18644.8 18804.1 45114.2 52129.5 54233.5 54910.8 55227.4 49635.8 59078.9 71761.0 74907.0 80942.6 7859.1 7898.2 8009.5 8087.4 8323.4 7389.8 11365.1 12350.3 12909.5 13106.5 9552.9 10004.6 10455.2 10644.9 11272.7 10551.5 10716.0 10861.9 10969.5 11219.8 11156.4 11229.0 11701.5 11781.6 11858.2 7986.8 8057.2 8131.1 8143.8 8192.9 8154.0 10281.9 11068.4 11270.0 11573.4 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#3] mootools.html Cycles:180 Average:5643.54 Median:5104.77 stddev:3110.44 (60.9%) stddev-sans-first:3103.09 17:37:19 INFO - PROCESS | 1939 | Values: 1435.9 1615.5 1851.5 1921.2 1952.9 7859.7 8421.9 8426.6 8790.1 8895.1 8474.2 8490.5 8510.9 8601.1 8616.1 2428.6 2438.1 2460.9 2462.0 2464.0 2056.7 2348.7 2399.0 2453.2 2463.0 2400.9 2419.1 2421.9 2426.9 2434.4 2384.9 2390.0 2408.2 2419.8 2421.4 2368.6 2380.5 2395.1 2400.1 2412.4 8611.4 8686.9 8687.9 8748.2 8783.1 5221.9 5386.6 5478.6 5479.1 5486.6 3514.0 3570.8 3598.5 3618.6 3622.0 1038.1 1038.9 1039.8 1040.6 1043.2 11370.6 11474.8 11483.0 11511.9 11549.5 3927.0 4030.8 4865.4 4910.0 4924.5 9815.7 9867.4 9925.6 9945.9 9948.8 5324.3 5346.6 5396.7 5431.6 5528.2 4429.0 4725.1 4950.8 4962.5 5018.1 4013.8 4104.8 4112.3 4120.8 4129.5 1357.6 1389.3 1390.1 1391.5 1395.8 926.0 931.9 935.1 963.3 976.9 5679.9 5824.4 5836.4 5887.0 6072.2 453.8 464.4 479.7 480.4 1000.4 3490.8 3781.2 3902.3 3991.7 4015.5 10024.0 10226.7 10390.5 10527.9 10552.1 10168.9 10263.3 10344.3 10422.7 10463.8 6847.6 7824.2 7925.6 8110.9 8140.8 5660.5 5830.8 5877.3 5933.9 5937.7 9677.1 9772.4 9842.3 9905.2 9933.0 9650.4 9757.9 9868.5 9989.0 10004.1 6438.9 6720.1 6949.0 7008.7 7023.6 8118.4 8141.5 8165.6 8224.3 8230.8 7237.9 7381.2 7388.2 7506.0 7507.0 7277.5 7364.6 7552.3 7654.7 7664.7 6793.0 6851.5 6866.9 6883.1 6907.4 4911.1 5042.5 5119.6 5136.5 5341.4 4039.9 4969.2 5089.9 5215.9 5462.8 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#4] prototype.html Cycles:180 Average:4848.48 Median:5177.37 stddev:1549.69 (29.9%) stddev-sans-first:1516.25 17:37:19 INFO - PROCESS | 1939 | Values: 316.8 322.2 330.9 331.8 332.1 4833.8 4910.6 5296.4 5435.9 5667.8 4100.7 4616.8 4725.7 5400.3 5492.7 4217.0 4218.5 4243.5 4244.1 4272.7 3242.9 4171.7 4238.5 4244.5 4308.0 3417.3 3755.5 3875.4 4105.5 4137.5 3498.7 4131.6 4145.6 4148.9 4182.7 2951.6 3437.6 3626.0 3638.7 3689.4 5060.9 5267.6 5288.8 5344.5 5362.0 4720.2 4768.5 4787.0 4793.2 4800.8 4893.9 5632.5 5829.7 5855.1 6003.6 3407.3 3702.6 3833.4 3961.8 3975.2 5293.2 5605.8 6053.2 6155.2 6155.6 4021.4 4032.9 4038.7 4060.1 4075.3 3413.4 3888.0 4107.3 4282.6 4291.6 4428.2 4535.2 4879.8 4924.6 4961.9 4995.7 5359.0 5678.9 5686.5 5991.4 1521.5 1556.2 1565.7 1566.4 1576.4 875.8 935.3 1009.6 1021.5 1046.6 4900.2 5874.6 5887.6 5889.6 6023.8 6517.9 6528.2 6549.3 6567.8 6568.7 4788.7 4910.1 4983.6 5852.4 5874.9 3037.3 3155.4 3468.8 3483.3 3485.8 5713.6 6471.9 6845.9 6854.3 6857.4 6326.9 6385.8 6621.6 6755.6 6762.5 6468.7 6521.7 6613.6 6759.0 6846.9 5598.7 6030.5 6515.7 6557.4 6591.8 6448.4 6466.6 6500.8 6509.5 6510.6 5757.4 6546.1 6706.4 6770.2 6790.3 4440.1 4460.6 4460.8 4479.9 4498.6 5135.6 5212.4 5577.3 6561.2 6617.1 5142.3 5401.8 5838.4 5849.9 5862.9 5379.4 5847.7 5888.7 5895.0 5927.2 4866.8 5756.4 5786.0 5787.4 5854.3 4773.5 5134.7 5842.3 5903.7 5914.0 5122.3 5450.7 5794.6 5819.5 5853.3 17:37:19 INFO - PROCESS | 1939 | 17:37:19 INFO - PROCESS | 1939 | [#5] yui.html Cycles:180 Average:18000.16 Median:30920.68 stddev:25300.88 (81.8%) stddev-sans-first:25338.41 17:37:19 INFO - PROCESS | 1939 | Values: 674.6 680.3 759.2 766.4 774.2 14295.7 14652.2 14894.6 14942.9 14962.6 11678.2 13476.7 13717.0 13833.1 13839.6 711.7 888.6 906.4 911.9 925.1 913.2 917.3 922.2 923.1 923.4 960.5 962.5 962.8 967.1 968.2 957.3 959.5 963.8 964.7 965.3 702.3 703.0 710.0 711.6 715.2 14364.9 14383.6 14605.6 14780.4 14829.5 12509.6 12689.7 12711.4 12726.9 12880.9 9628.2 9708.5 9928.2 10041.6 10139.2 3471.1 3472.3 3496.5 3589.9 3595.7 81509.0 82289.0 82348.0 82351.0 82595.6 9242.6 9442.2 9474.1 9717.1 9733.6 18974.4 21958.8 22057.6 22067.4 22168.7 7439.7 7474.3 7497.8 7530.5 7599.9 3944.9 3998.3 4058.1 4061.7 4064.4 3549.0 3560.5 3593.8 3625.4 3628.5 642.9 659.2 660.4 663.1 664.8 470.8 476.0 497.0 581.0 610.3 8019.0 8050.0 8052.5 8207.7 8256.6 482.5 530.9 587.8 599.9 616.0 3034.5 3498.7 3847.7 3849.2 4014.3 81621.8 82940.3 91879.0 91962.5 92777.6 77640.8 78652.0 79847.2 80188.2 81611.0 71244.0 71767.9 72564.3 72966.0 73090.6 6338.4 7596.2 7747.7 7805.6 7858.8 44734.8 44845.0 45387.4 45658.3 46521.0 60323.7 60374.8 61225.4 64379.0 64522.4 10834.1 10848.9 10850.9 10977.0 11187.2 11795.4 11831.0 11883.7 12158.1 12550.5 11040.7 11386.5 11458.5 11622.0 11687.8 11363.1 11400.4 11432.0 11444.7 11805.8 11286.9 11425.5 11490.3 11507.3 11690.8 9661.5 9909.9 9999.5 10141.3 10146.7 9310.6 9587.3 9747.1 9837.2 9911.1 17:37:19 INFO - PROCESS | 1939 | -------- Summary: end -------- 17:37:19 INFO - PROCESS | 1939 | 17:37:20 INFO - TEST-INFO | 1939: exit 0 17:37:20 INFO - TEST-OK | dromaeo_css | took 1112156ms 17:37:20 INFO - TEST-START | kraken 17:37:20 INFO - operating with platform_type : mac_ 17:37:20 INFO - Initialising browser for kraken test... 17:37:20 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpVWoPB5/profile http://localhost:50275/getInfo.html) 17:37:23 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 17:37:23 INFO - PROCESS | 1946 | colorDepth:24 17:37:23 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 17:37:23 INFO - PROCESS | 1946 | __metrics 17:37:23 ERROR - PROCESS | 1946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:37:24 INFO - TEST-INFO | 1946: exit 0 17:37:24 INFO - Browser initialized. 17:37:24 INFO - Running cycle 1/1 for kraken test... 17:37:24 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpVWoPB5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:35 INFO - PROCESS | 1949 | RSS: Main: 249438208 17:37:35 INFO - PROCESS | 1949 | 17:37:38 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50275/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:39 INFO - PROCESS | 1949 | RSS: Main: 261906432 17:37:39 INFO - PROCESS | 1949 | 17:37:42 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50275/tests/kraken/driver.html?testName=audio-dft) 17:37:42 INFO - PROCESS | 1949 | RSS: Main: 271151104 17:37:42 INFO - PROCESS | 1949 | 17:37:46 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50275/tests/kraken/driver.html?testName=audio-fft) 17:37:46 INFO - PROCESS | 1949 | RSS: Main: 273821696 17:37:46 INFO - PROCESS | 1949 | 17:37:48 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50275/tests/kraken/driver.html?testName=audio-oscillator) 17:37:49 INFO - PROCESS | 1949 | RSS: Main: 276365312 17:37:49 INFO - PROCESS | 1949 | 17:37:51 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:52 INFO - PROCESS | 1949 | RSS: Main: 276803584 17:37:52 INFO - PROCESS | 1949 | 17:37:55 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50275/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:55 INFO - PROCESS | 1949 | RSS: Main: 276783104 17:37:55 INFO - PROCESS | 1949 | 17:37:59 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50275/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:59 INFO - PROCESS | 1949 | RSS: Main: 276910080 17:37:59 INFO - PROCESS | 1949 | 17:38:02 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50275/tests/kraken/driver.html?testName=json-parse-financial) 17:38:03 INFO - PROCESS | 1949 | RSS: Main: 277377024 17:38:03 INFO - PROCESS | 1949 | 17:38:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:05 INFO - PROCESS | 1949 | RSS: Main: 276787200 17:38:05 INFO - PROCESS | 1949 | 17:38:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:07 INFO - PROCESS | 1949 | RSS: Main: 276738048 17:38:07 INFO - PROCESS | 1949 | 17:38:10 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:10 INFO - PROCESS | 1949 | RSS: Main: 276996096 17:38:10 INFO - PROCESS | 1949 | 17:38:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:14 INFO - PROCESS | 1949 | RSS: Main: 277262336 17:38:14 INFO - PROCESS | 1949 | 17:38:17 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:17 INFO - PROCESS | 1949 | RSS: Main: 277241856 17:38:17 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:50275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50275/tests/kraken/driver.html?testName=ai-astar) 17:38:19 INFO - PROCESS | 1949 | RSS: Main: 279113728 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | __start_tp_report 17:38:19 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 17:38:19 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 17:38:19 INFO - PROCESS | 1949 | |i|pagename|runs| 17:38:19 INFO - PROCESS | 1949 | |0;ai-astar;116;113;117;116;125;147;115;117;115;118 17:38:19 INFO - PROCESS | 1949 | |1;audio-beat-detection;160;127;179;183;141;171;162;120;173;123 17:38:19 INFO - PROCESS | 1949 | |2;audio-dft;198;196;207;241;195;198;202;194;205;195 17:38:19 INFO - PROCESS | 1949 | |3;audio-fft;54;71;63;130;51;59;75;92;67;73 17:38:19 INFO - PROCESS | 1949 | |4;audio-oscillator;79;83;130;76;71;124;161;119;115;125 17:38:19 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;89;85;90;98;89;110;134;74;132;129 17:38:19 INFO - PROCESS | 1949 | |6;imaging-darkroom;94;132;149;106;149;151;94;152;152;95 17:38:19 INFO - PROCESS | 1949 | |7;imaging-desaturate;95;91;90;88;91;100;90;119;130;89 17:38:19 INFO - PROCESS | 1949 | |8;json-parse-financial;59;61;60;62;61;61;62;73;63;61 17:38:19 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;63;83;67;68;76;78;73;67;67;67 17:38:19 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;85;82;83;82;84;84;82;86;83;83 17:38:19 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;135;137;135;137;135;139;157;156;189;156 17:38:19 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;174;180;170;170;168;185;171;172;172;190 17:38:19 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;68;68;70;68;69;85;100;87;72;71 17:38:19 INFO - PROCESS | 1949 | __end_tp_report 17:38:19 INFO - PROCESS | 1949 | __start_cc_report 17:38:19 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1085 17:38:19 INFO - PROCESS | 1949 | __end_cc_report 17:38:19 INFO - PROCESS | 1949 | __startTimestamp1461631099844__endTimestamp 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | ------- Summary: start ------- 17:38:19 INFO - PROCESS | 1949 | Number of tests: 14 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:119.90 Median:117.00 stddev:10.04 (8.6%) stddev-sans-first:10.55 17:38:19 INFO - PROCESS | 1949 | Values: 116.0 113.0 117.0 116.0 125.0 147.0 115.0 117.0 115.0 118.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:166.50 stddev:24.11 (14.5%) stddev-sans-first:25.47 17:38:19 INFO - PROCESS | 1949 | Values: 160.0 127.0 179.0 183.0 141.0 171.0 162.0 120.0 173.0 123.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:203.10 Median:200.00 stddev:14.04 (7.0%) stddev-sans-first:14.76 17:38:19 INFO - PROCESS | 1949 | Values: 198.0 196.0 207.0 241.0 195.0 198.0 202.0 194.0 205.0 195.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:73.50 Median:69.00 stddev:23.08 (33.4%) stddev-sans-first:23.37 17:38:19 INFO - PROCESS | 1949 | Values: 54.0 71.0 63.0 130.0 51.0 59.0 75.0 92.0 67.0 73.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:116.00 stddev:29.56 (25.5%) stddev-sans-first:29.39 17:38:19 INFO - PROCESS | 1949 | Values: 79.0 83.0 130.0 76.0 71.0 124.0 161.0 119.0 115.0 125.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:87.00 stddev:21.80 (25.1%) stddev-sans-first:22.53 17:38:19 INFO - PROCESS | 1949 | Values: 89.0 85.0 90.0 98.0 89.0 110.0 134.0 74.0 132.0 129.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:127.40 Median:152.00 stddev:26.79 (17.6%) stddev-sans-first:25.55 17:38:19 INFO - PROCESS | 1949 | Values: 94.0 132.0 149.0 106.0 149.0 151.0 94.0 152.0 152.0 95.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:90.00 stddev:14.47 (16.1%) stddev-sans-first:15.30 17:38:19 INFO - PROCESS | 1949 | Values: 95.0 91.0 90.0 88.0 91.0 100.0 90.0 119.0 130.0 89.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:61.50 stddev:3.92 (6.4%) stddev-sans-first:3.97 17:38:19 INFO - PROCESS | 1949 | Values: 59.0 61.0 60.0 62.0 61.0 61.0 62.0 73.0 63.0 61.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.50 stddev:6.31 (9.0%) stddev-sans-first:6.02 17:38:19 INFO - PROCESS | 1949 | Values: 63.0 83.0 67.0 68.0 76.0 78.0 73.0 67.0 67.0 67.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:1.35 (1.6%) stddev-sans-first:1.30 17:38:19 INFO - PROCESS | 1949 | Values: 85.0 82.0 83.0 82.0 84.0 84.0 82.0 86.0 83.0 83.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:147.50 stddev:17.38 (11.8%) stddev-sans-first:17.83 17:38:19 INFO - PROCESS | 1949 | Values: 135.0 137.0 135.0 137.0 135.0 139.0 157.0 156.0 189.0 156.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:173.00 stddev:7.33 (4.2%) stddev-sans-first:7.76 17:38:19 INFO - PROCESS | 1949 | Values: 174.0 180.0 170.0 170.0 168.0 185.0 171.0 172.0 172.0 190.0 17:38:19 INFO - PROCESS | 1949 | 17:38:19 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:70.50 stddev:11.03 (15.7%) stddev-sans-first:11.34 17:38:19 INFO - PROCESS | 1949 | Values: 68.0 68.0 70.0 68.0 69.0 85.0 100.0 87.0 72.0 71.0 17:38:19 INFO - PROCESS | 1949 | -------- Summary: end -------- 17:38:19 INFO - PROCESS | 1949 | 17:38:20 INFO - TEST-INFO | 1949: exit 0 17:38:20 INFO - TEST-OK | kraken | took 60389ms 17:38:20 INFO - SUITE-END | took 1172s 17:38:21 INFO - Completed test suite (00:19:32) 17:38:21 INFO - javascript benchmark 17:38:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3504.491848681941, 3507.649235076492, 3523.911902202446, 3537.92924141517, 3552.8630838131808, 4806.783694733736, 5761.049426844576, 5823.67969761663, 5827.094748659961, 5830.300363956326, 5812.854678633036, 5993.34073251943, 6002.579819412643, 6051.0, 6073.878522429549, 5267.367915850094, 5274.367075950891, 5336.439673834249, 5370.113931201347, 5433.266509021271, 5454.59090568207, 5478.616496845222, 5481.287432633752, 5484.067708489546, 5529.585281103913, 5259.894802103975, 5317.069512835238, 5344.599155063386, 5366.9463305366835, 5376.569874410038, 4617.0, 5346.705931173784, 5350.3312085989255, 5355.758990845382, 5374.220737993008, 4304.397384366192, 4718.631596836914, 4783.4499032611, 5284.603654725911, 5311.990721762852, 5514.641548299388, 5684.147377893308, 5747.59766816323, 5814.982378083861, 5826.621269617462, 6203.720832562501, 6286.277078135981, 6296.559240853142, 6310.810675679737, 6352.205974253218, 6323.05154226865, 6327.4938004959495, 6327.968360158216, 6334.3032266450655, 6340.968295158541, 5901.704914754245, 6009.819705408845, 6088.786892458787, 6093.39066093396, 6124.020156774984, 6407.167068281094, 6460.160179176771, 6465.418112369909, 6471.255805582418, 6477.676116194266, 6115.510759139258, 6310.368963103745, 6323.462505686976, 6328.050792381179, 6339.11252424661, 6173.32093469718, 6243.937560624336, 6286.497080233662, 6359.618422894641, 6363.522735794834, 6214.533909956771, 6297.275813281532, 6310.274318453345, 6314.810555683337, 6336.461400780985, 4822.831200907952, 6261.780837670751, 6277.96861015692, 6284.717187726564, 6297.622142671363, 5055.16589762685, 5070.721110338966, 5075.7969681212335, 5076.543111120017, 5108.6168537359845, 4427.667924905645, 4431.0, 4436.689431739812, 4439.778011099432, 4485.910281794346, 4436.778161091933, 4916.950830491649, 4940.912999140183, 5862.94137058624, 6060.787872424444, 6342.968285158637, 6359.8092057238355, 6378.075179099097, 6388.425041746173, 6427.421532062137, 5956.821295361146, 6104.328523862371, 6111.449969502677, 6117.84705382369, 6163.84590385244, 5465.453454654503, 5528.419515950767, 5534.418886016991, 5586.329640443091, 5654.943450565442, 6560.40956313934, 6616.338366163442, 6627.834304142242, 6628.072069910217, 6633.2040155181685, 6363.5863668861375, 6394.648294343856, 6406.5515413920575, 6407.455366293917, 6411.134496842867, 6426.742930282923, 6455.644939528371, 6544.214694236722, 6603.141591593062, 6618.205815302194, 6275.090111933835, 6302.495800336053, 6304.085907543472, 6314.905276420765, 6321.241451025906, 5729.68486733217, 6183.412575805291, 6354.301026887131, 6367.108604795425, 6368.872622547616, 4848.660593758403, 6173.104899789595, 6203.379662033761, 6286.025666021774, 6313.46335561464, 6281.246250449793, 6288.182536270256, 6288.213973253343, 6296.0, 6301.464375528131, 6056.36408177135, 6129.448349648553, 6159.907601386072, 6221.09794079865, 6231.189945307081, 6112.26032301701, 6201.0, 6287.1512345832725, 6310.7791227306825, 6311.337309582428, 5960.970195148997, 6196.938030619636, 6221.906671399842, 6242.126102345766, 6277.529185311028], "value": 5796.3930637659105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.3784893185654, 513.3916309173629, 569.2173261765073, 596.427429667519, 609.7987664070854, 37897.621023789754, 38667.61332386675, 38760.80619596898, 38781.80609096954, 38805.805970970105, 39301.0, 39952.801415957496, 39955.60044399555, 40157.79921100398, 40226.79886600563, 9326.347155699104, 9455.101765332316, 9514.524273786317, 9550.235981121494, 9559.904400956006, 9021.278297736199, 9312.83589551306, 9424.151826335628, 9551.474668893208, 9555.235581153525, 8154.34765218784, 9625.133737963582, 9656.75858103546, 9688.66089686861, 9694.321397502177, 9531.618735250617, 9598.80802383952, 9607.951960240223, 9625.855612165824, 9645.22838172948, 9506.714798556055, 9608.663696770649, 9611.471369074698, 9622.326437149331, 9627.807443851083, 35179.0, 35350.0, 35561.46657800135, 35751.28497430037, 35837.82081089604, 3169.714725674677, 3248.3828072666356, 3372.1232479555247, 3473.270613171237, 3476.026712520498, 27945.301367465774, 28552.857235713895, 28673.56989645157, 29080.418391632047, 29531.852340738373, 2686.502996945552, 2723.6050772637855, 2724.278066312429, 2738.87675054623, 2844.1894060192744, 435505.0, 443220.0, 443522.0, 446230.99999999674, 449204.0, 35235.64764352324, 68726.31273687299, 68806.62386752237, 69605.65197173982, 69901.65049174824, 31087.844560777503, 31664.0, 37345.879623611334, 37901.62098379036, 37934.05164870845, 12993.220406775623, 15240.542783716506, 15497.767533487007, 15514.5345639631, 15521.45674901373, 10984.340939543494, 12908.16096953695, 12974.962003039924, 13023.544175953795, 13108.475660973645, 8296.253337199681, 8424.031236407769, 8532.0, 8547.786305342415, 8601.22588966996, 3568.7680300780366, 3576.678098971105, 3606.0804494853646, 3622.185008373095, 3639.381305178073, 912.8037471943564, 966.9129778319985, 1000.5197505197546, 1004.2919741582167, 1108.9650491348305, 23936.40158996004, 26841.926322947253, 27460.038898638453, 27921.022764203157, 28312.0, 1017.7862648843677, 1092.191778084212, 1096.2052511928948, 1157.288267715349, 1218.4516967364543, 14676.853231467549, 14789.334479948428, 14858.331375088146, 15023.0, 15428.30572624212, 550314.0, 559378.0, 561238.0, 561755.0, 564047.0, 57372.85254294891, 58695.358708858206, 59306.110408343906, 59400.702996485605, 59783.70108149431, 1436.3033928544648, 1449.9057561258485, 1489.7318482673222, 1491.3065424577408, 1493.4399600149943, 28465.28836779097, 28633.570496442153, 29058.854705726335, 29123.980660676774, 29250.561241581818, 49343.0, 51290.48709513006, 52026.21960670668, 52816.73591632171, 53035.0, 544650.55349446, 547321.0, 554803.0, 557325.0, 560417.1979140078, 36883.0, 37453.25093498169, 42122.7893860541, 43060.138797223255, 43808.80955952253, 45644.77177614091, 45684.54315456936, 45710.0, 45935.08129837451, 45958.310625339975, 37987.810060949516, 38056.0, 38138.61861381351, 38571.421428679154, 39105.80447097746, 30097.3980520384, 34882.47676284909, 35122.297554049284, 37565.0, 37904.620953791215, 32443.290284956358, 34467.0, 37034.0, 37399.25201496009, 38307.80846095863, 28673.996410125546, 32055.519167212045, 32346.676533234368, 32932.50601240935, 32944.83527582347, 20090.89954550218, 21584.892075539523, 24352.878235608707, 24527.386815329046, 24918.875405622857], "value": 18497.357321728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1675896821833, 391.4324229866694, 396.1127075351212, 399.1757021750086, 403.8102092016751, 20188.798112018892, 20428.897855510702, 21273.82993935335, 21297.041633126508, 21329.68005479915, 19984.800151998475, 20181.19275228989, 21311.147554097817, 21514.784852151475, 21547.67678484824, 4154.5637708040595, 5320.813771517997, 5357.4374690657305, 5361.410244873061, 5369.463053694639, 4734.857954261378, 5295.364556253255, 5323.201519772027, 5432.293801805759, 5433.891322173554, 5367.490088441611, 5388.245645609618, 5413.0, 5416.783328666848, 5442.700651464168, 5417.052015897222, 5443.646162999412, 5556.111022236463, 5915.319738230072, 5924.496417804492, 4915.213565829486, 5437.13005919051, 5738.454846789548, 5739.483446489794, 5867.706614669292, 24129.03483860661, 24355.0, 24777.380565485826, 25053.747312634478, 25626.48747025068, 2114.407965769587, 2170.370592528165, 2193.5283913958415, 2199.285232299509, 2211.7788221177916, 9981.101700846959, 10006.69979900604, 10029.650894245106, 10289.691309260734, 10323.84514232287, 1683.5117815833394, 1766.8498177654915, 1784.5003399048287, 1784.5895444047812, 1797.3170195325824, 97133.0, 127252.0, 129170.3541482296, 129689.0, 130740.99999999905, 9672.468014259282, 11587.826182607268, 11844.88155118455, 11922.642320730392, 11987.580434684744, 15454.459093931659, 15467.613309667347, 15489.690206195814, 15525.45660901863, 15537.30082146306, 8721.30229581632, 8910.821783564292, 8939.329550283755, 8982.191602755653, 9039.548022598843, 8816.515091669891, 8828.690995815115, 8875.600597973107, 8948.821023579492, 8960.148785865333, 3905.4727611772614, 4654.208784506574, 4691.272852707768, 4699.2481203007355, 4765.237561990065, 1979.0104947526238, 2012.9899350503447, 2016.1935225909754, 2029.1883246701439, 2065.1223230127134, 878.767126711422, 943.4433684126261, 977.7164622259465, 986.3490096536395, 1078.8813230544633, 20467.692984605244, 20633.58732825335, 20728.792712072987, 21025.0, 21131.788682112983, 814.470594113819, 931.7158266728577, 1012.3875055591409, 1034.2656713733184, 1043.9530221140067, 10759.78480430387, 11079.446027698583, 11088.889111108947, 11106.833397499044, 11111.444427778579, 435757.0, 536715.0, 549053.0, 549284.0, 550991.0, 60028.69985650044, 91251.0, 132484.0, 135126.32436837754, 135827.32086339704, 975.2636759246724, 978.105033893979, 1000.429755039635, 1002.2533212756397, 1008.3344992305043, 18271.725924110884, 18512.81487185165, 18519.259229631203, 18644.813551864307, 18804.05979701037, 45114.19543218234, 52129.47870521246, 54233.457665422844, 54910.76338549249, 55227.44772552384, 49635.751821240665, 59078.93223737148, 71761.0, 74907.0, 80942.59528702318, 7859.096203936392, 7898.249666281694, 8009.519428834288, 8087.433879628369, 8323.417360784686, 7389.778306650809, 11365.147613929154, 12350.258984460961, 12909.54816581415, 13106.541271055466, 9552.85670714926, 10004.599816007569, 10455.16358691318, 10644.89355106439, 11272.718182045515, 10551.525181366704, 10715.981981711724, 10861.891381086403, 10969.451527423438, 11219.831702524632, 11156.442177891235, 11229.045531129945, 11701.531938722355, 11781.646550603497, 11858.16992810495, 7986.84026319482, 8057.194280571896, 8131.105578386255, 8143.79640508992, 8192.877106843283, 8154.02151741771, 10281.948590257001, 11068.446577670924, 11269.985701286596, 11573.421328933351], "value": 9378.224817094919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.9282035898202, 1615.5234205909255, 1851.45403588004, 1921.1546919355492, 1952.8828270303784, 7859.68561257549, 8421.91578084219, 8426.620802063906, 8790.120987901206, 8895.066018068099, 8474.23731864132, 8490.490570565755, 8510.914890851089, 8601.053884072748, 8616.138386161381, 2428.611422172453, 2438.146648672959, 2460.9138680146198, 2462.0398044762555, 2464.0143942423083, 2056.6812144117685, 2348.7181538215355, 2399.0044131685418, 2453.1659235859806, 2462.9507409851794, 2400.9159679411223, 2419.0565679385054, 2421.927342179729, 2426.8543887366727, 2434.3914021494625, 2384.8688322142275, 2389.9842566909083, 2408.157144999254, 2419.7822196002357, 2421.406755344934, 2368.609179485383, 2380.488195038075, 2395.137750409851, 2400.099962514057, 2412.372783076395, 8611.397202195849, 8686.913130868737, 8687.913120868774, 8748.212660860552, 8783.077776833468, 5221.895562088737, 5386.569074474032, 5478.58910581708, 5479.0959491683825, 5486.61593688442, 3514.0, 3570.785752854837, 3598.47822065799, 3618.565772107364, 3622.0118402318194, 1038.1383451735041, 1038.8961103889626, 1039.77644806367, 1040.5577629507504, 1043.2332235806675, 11370.602028928948, 11474.770504589946, 11483.023942964857, 11511.942440287829, 11549.480273387633, 3927.03787572041, 4030.7581545107387, 4865.440474345495, 4910.042541704333, 4924.507549245047, 9815.705528834147, 9867.358621689711, 9925.60297588103, 9945.900540994497, 9948.751281218027, 5324.254604355393, 5346.572274218053, 5396.703181325065, 5431.619786614899, 5528.226048353234, 4428.977855110704, 4725.149473094876, 4950.752462376867, 4962.503749625009, 5018.121828679967, 4013.8394464221105, 4104.798821086206, 4112.300908845504, 4120.75275483472, 4129.504459464823, 1357.6402253402857, 1389.3261768042491, 1390.0894913831457, 1391.4712409284407, 1395.7627203375248, 926.0, 931.9161275485238, 935.1163150822543, 963.3160456076124, 976.8925418203992, 5679.858003549862, 5824.417558244142, 5836.358000619928, 5887.0, 6072.240969878765, 453.75270477589135, 464.37077759635883, 479.69779039205076, 480.4498848818084, 1000.4147573669485, 3490.842912068963, 3781.205946751158, 3902.31709450845, 3991.720579559403, 4015.5181378234215, 10024.0, 10226.693199204035, 10390.480475976323, 10527.894721052844, 10552.050315471644, 10168.949155254177, 10263.332883362558, 10344.275900687031, 10422.687319380431, 10463.790724185474, 6847.589144651337, 7824.178461261599, 7925.603719813987, 8110.878336824952, 8140.837183256302, 5660.462256085665, 5830.7959221427045, 5877.294724633071, 5933.910991335047, 5937.732802024006, 9677.080677335642, 9772.364796288219, 9842.311038227255, 9905.158061564847, 9932.950335248277, 9650.420974741539, 9757.902420975699, 9868.506574671093, 9989.0, 10004.099631033241, 6438.935610643834, 6720.126383570105, 6948.965255173692, 7008.684609192701, 7023.648817558999, 8118.350531957311, 8141.51150930946, 8165.591720413837, 8224.342052635895, 8230.794230144054, 7237.8914316286355, 7381.1511676157925, 7388.187299397169, 7506.0, 7506.962465187639, 7277.490575659653, 7364.631768411665, 7552.282533159341, 7654.69381224767, 7664.73173438927, 6792.966035169792, 6851.45188384918, 6866.896996545156, 6883.105196324445, 6907.376766459777, 4911.10244955478, 5042.520960508746, 5119.590432765295, 5136.486351364983, 5341.439148889466, 4039.8788036358956, 4969.229769385751, 5089.949100508948, 5215.869603259949, 5462.808801691922], "value": 4531.888001752243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.81624657698524, 322.1655911190018, 330.86434561829657, 331.75947438107374, 332.0768264225454, 4833.806647734091, 4910.6071514278865, 5296.443873393296, 5435.891282174354, 5667.773289068437, 4100.712950093487, 4616.838410655628, 4725.6928299660585, 5400.324959380077, 5492.725363731807, 4217.0, 4218.535961044283, 4243.490781106264, 4244.0663054128045, 4272.700910936236, 3242.913623935984, 4171.749695018293, 4238.512571054322, 4244.469441319835, 4307.956920430803, 3417.333619944112, 3755.5309182073383, 3875.379939209727, 4105.460452330376, 4137.524184718751, 3498.667626575484, 4131.566185550504, 4145.585441455845, 4148.854790082332, 4182.728122672017, 2951.5720220567896, 3437.570303712036, 3625.981870090659, 3638.745287829853, 3689.4465830125428, 5060.873478163038, 5267.631265811395, 5288.762005709752, 5344.545713614348, 5361.973190134064, 4720.197566413718, 4768.47546769855, 4787.0, 4793.209120495114, 4800.759962001921, 4893.877653058702, 5632.464915832989, 5829.68832012798, 5855.092460668603, 6003.6397816131175, 3407.30150319184, 3702.629737026303, 3833.367494363427, 3961.841526338943, 3975.185087057146, 5293.168155037037, 5605.803796867131, 6053.1828203192445, 6155.169052177944, 6155.599886007395, 4021.3565829467143, 4032.931273212601, 4038.656714179269, 4060.127072679388, 4075.347944328893, 3413.4026545354463, 3887.969688032617, 4107.322291821816, 4282.593153650399, 4291.570842915684, 4428.180786554498, 4535.229011068126, 4879.829205977774, 4924.581410580141, 4961.925571116436, 4995.675281106716, 5359.008583412081, 5678.914816277759, 5686.516646085046, 5991.352378095971, 1521.5283262188757, 1556.167450414023, 1565.6946895355297, 1566.3577933047395, 1576.3694522191215, 875.7766769473743, 935.2845073518764, 1009.6264382178641, 1021.4892553723139, 1046.5709059285657, 4900.166971614834, 5874.647521148745, 5887.558433117533, 5889.5582831286965, 6023.849403764853, 6517.869642607121, 6528.249251336157, 6549.347514256734, 6567.8358041048405, 6568.67156642166, 4788.7366194859615, 4910.116179087799, 4983.576396006308, 5852.385499522574, 5874.9118763218585, 3037.255872311298, 3155.3689262147204, 3468.757186996886, 3483.320752453247, 3485.8387799564434, 5713.5714821388565, 6471.935280647133, 6845.863082738318, 6854.34883686049, 6857.417119544794, 6326.873462530723, 6385.808425747235, 6621.569597976116, 6755.594664320157, 6762.459003279824, 6468.741250350027, 6521.67391630426, 6613.636250006296, 6759.0, 6846.8972965405555, 5598.692071936082, 6030.517558595389, 6515.706793194223, 6557.409833115043, 6591.769288074895, 6448.355164483514, 6466.642005178777, 6500.837479063061, 6509.544331896911, 6510.632767118958, 5757.3954734753925, 6546.116274302908, 6706.362895524917, 6770.187577490536, 6790.287019862843, 4440.067585807016, 4460.553944605514, 4460.843870464518, 4479.894449608679, 4498.617617502418, 5135.639055650181, 5212.4005739338945, 5577.3028371453565, 6561.179852518435, 6617.139771829631, 5142.331496905378, 5401.837944861661, 5838.357780644211, 5849.94150058494, 5862.882742345215, 5379.435159308373, 5847.707614619337, 5888.705564721832, 5895.0, 5927.199828023162, 4866.756662166807, 5756.42435756421, 5786.0, 5787.421257874179, 5854.326752423355, 4773.522647735337, 5134.717590532557, 5842.267763111893, 5903.675297858659, 5913.9596839090445, 5122.259591118734, 5450.727463626724, 5794.565407594363, 5819.476247137609, 5853.297604287342], "value": 4369.644295222948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.6390680985672, 680.3434685528467, 759.2483441393023, 766.3600893254132, 774.1639029847765, 14295.714085718293, 14652.194129322883, 14894.553163405102, 14942.850571494295, 14962.551123466286, 11678.240914340562, 13476.73046539071, 13717.0398072135, 13833.100848444845, 13839.584812455643, 711.7295427737479, 888.5557221389305, 906.3700727994063, 911.8951320598117, 925.1165137293868, 913.2100732866089, 917.2891009467683, 922.2483675804232, 923.1414784250644, 923.4274749655223, 960.5293406230967, 962.5187406296851, 962.8170647576937, 967.1150896929302, 968.2447690801151, 957.2629075611775, 959.491469521155, 963.8313295173351, 964.7491652170417, 965.2615748951987, 702.2836706559281, 703.0157779109237, 710.0449894891362, 711.5872793779596, 715.1596873673413, 14364.856351436561, 14383.568492945229, 14605.561833145022, 14780.408783648641, 14829.48096816617, 12509.56216532417, 12689.746205075939, 12711.427985740664, 12726.87273127266, 12880.935595321964, 9628.229741620653, 9708.514574271258, 9928.205743540499, 10041.648542300984, 10139.188864890792, 3471.09751464621, 3472.305538892206, 3496.493008513751, 3589.892303230881, 3595.7482976191413, 81509.0, 82289.0, 82348.0, 82351.0, 82595.5870220645, 9242.630294788134, 9442.150206481312, 9474.147326740489, 9717.076877696607, 9733.56198971048, 18974.43076707701, 21958.780412195672, 22057.558848823253, 22067.448313792283, 22168.667469987962, 7439.702411903571, 7474.289942455458, 7497.812554686177, 7530.548167109991, 7599.924000759922, 3944.861929832442, 3998.34027385484, 4058.127502586958, 4061.7156799023783, 4064.4106604542176, 3548.964510354915, 3560.501529785832, 3593.7664051836546, 3625.3836847735947, 3628.4920111184456, 642.922849258092, 659.1891972873296, 660.428729149292, 663.1445435388295, 664.833791552112, 470.79285114550174, 476.0, 496.9875753106129, 580.9651420914759, 610.3377835049022, 8019.0, 8050.0, 8052.516848989079, 8207.669215746022, 8256.587170641444, 482.45723560993883, 530.9177077552986, 587.8412828536271, 599.9250093738283, 615.9661218633019, 3034.514477683604, 3498.7201023918024, 3847.6729477994686, 3849.230153969161, 4014.3070458728175, 81621.77567336494, 82940.281760379, 91879.0, 91962.54018729998, 92777.60833587502, 77640.83538746924, 78652.0, 79847.20152798513, 80188.19811801807, 81611.0, 71244.0, 71767.89972852262, 72564.27435725681, 72966.0, 73090.63454682799, 6338.366163383625, 7596.164421913474, 7747.6513556891205, 7805.648745806338, 7858.842823143391, 44734.77632611816, 44845.0, 45387.41144059942, 45658.315125272486, 46521.0, 60323.69838150781, 60374.79250415055, 61225.38774612197, 64379.034314486256, 64522.35477645163, 10834.07910327631, 10848.945755271174, 10850.891491084989, 10977.0, 11187.216894817284, 11795.35125568102, 11831.0, 11883.702907427383, 12158.088143389105, 12550.497980080694, 11040.668779936615, 11386.487608057823, 11458.484368203617, 11622.012128969132, 11687.76624467489, 11363.090952723596, 11400.372979485875, 11432.0, 11444.656660300205, 11805.76388472243, 11286.887131128911, 11425.485853136795, 11490.310581365145, 11507.309561426342, 11690.76618467609, 9661.46861922601, 9909.851352229867, 9999.450030248407, 10141.290109692545, 10146.695599132037, 9310.581023853807, 9587.328886978125, 9747.074027967332, 9837.158508007777, 9911.058449447291], "value": 6825.07772659963, "unit": "score"}], "name": "dromaeo_css", "value": 7170.402356244931, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 117.0, 116.0, 125.0, 147.0, 115.0, 117.0, 115.0, 118.0], "value": 119.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 179.0, 183.0, 141.0, 171.0, 162.0, 120.0, 173.0, 123.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 207.0, 241.0, 195.0, 198.0, 202.0, 194.0, 205.0, 195.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 71.0, 63.0, 130.0, 51.0, 59.0, 75.0, 92.0, 67.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 130.0, 76.0, 71.0, 124.0, 161.0, 119.0, 115.0, 125.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 90.0, 98.0, 89.0, 110.0, 134.0, 74.0, 132.0, 129.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 132.0, 149.0, 106.0, 149.0, 151.0, 94.0, 152.0, 152.0, 95.0], "value": 127.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 91.0, 90.0, 88.0, 91.0, 100.0, 90.0, 119.0, 130.0, 89.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 62.0, 61.0, 61.0, 62.0, 73.0, 63.0, 61.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 83.0, 67.0, 68.0, 76.0, 78.0, 73.0, 67.0, 67.0, 67.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 83.0, 82.0, 84.0, 84.0, 82.0, 86.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 135.0, 137.0, 135.0, 139.0, 157.0, 156.0, 189.0, 156.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 180.0, 170.0, 170.0, 168.0, 185.0, 171.0, 172.0, 172.0, 190.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 69.0, 85.0, 100.0, 87.0, 72.0, 71.0], "value": 75.8, "unit": "score"}], "name": "kraken", "value": 1602.6, "alertThreshold": 2.0}]} 17:38:21 INFO - Return code: 0 17:38:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:38:21 ERROR - # TBPL SUCCESS # 17:38:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:21 INFO - 2016-04-25 17:38:21.168 screenresolution[1954:13204] starting screenresolution argv=screenresolution get 17:38:21 INFO - 2016-04-25 17:38:21.172 screenresolution[1954:13204] Display 0: 1600x1200x32@60 17:38:21 INFO - 2016-04-25 17:38:21.178 screenresolution[1955:13207] starting screenresolution argv=screenresolution list 17:38:21 INFO - Available Modes on Display 0 17:38:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:21 INFO - Intel Iris: 17:38:21 INFO - Chipset Model: Intel Iris 17:38:21 INFO - Type: GPU 17:38:21 INFO - Bus: Built-In 17:38:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:38:21 INFO - Vendor: Intel (0x8086) 17:38:21 INFO - Device ID: 0x0a2e 17:38:21 INFO - Revision ID: 0x0009 17:38:21 INFO - Displays: 17:38:21 INFO - Display: 17:38:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:21 INFO - Display Serial Number: 1600x1200 60 17:38:21 INFO - Main Display: Yes 17:38:21 INFO - Mirror: Off 17:38:21 INFO - Online: Yes 17:38:21 INFO - Rotation: Supported 17:38:21 INFO - Return code: 0 17:38:21 INFO - Running post-action listener: _resource_record_post_action 17:38:21 INFO - Running post-run listener: _resource_record_post_run 17:38:22 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 966656; Write bytes: 698642432; Read time: 14; Write time: 2145 17:38:22 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395930112; Write bytes: 394594304; Read time: 30047; Write time: 878 17:38:22 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 966656; Write bytes: 298833920; Read time: 14; Write time: 1250 17:38:22 INFO - Running post-run listener: _upload_blobber_files 17:38:22 INFO - Blob upload gear active. 17:38:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:22 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 17:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:38:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:38:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:23 INFO - (blobuploader) - INFO - Done attempting. 17:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:38:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:24 INFO - (blobuploader) - INFO - Done attempting. 17:38:24 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:24 INFO - Return code: 0 17:38:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62704158d0785768fb53e4861d8d92e8d7da425c6444f06719ac3a62f19b52b68d75827a039b965e7cc52fe8445d3d75da4e183b2a7c01bd21cee0a8391ff7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/962847acd42a69a557613140f400477876af641851ef87ab54396bf9ad002d090fc989c190ea2d14b3c120ba3eb0cd750a2d7e7e0792e449fe5c6888c4afbf7f"} 17:38:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:24 INFO - Contents: 17:38:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62704158d0785768fb53e4861d8d92e8d7da425c6444f06719ac3a62f19b52b68d75827a039b965e7cc52fe8445d3d75da4e183b2a7c01bd21cee0a8391ff7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/962847acd42a69a557613140f400477876af641851ef87ab54396bf9ad002d090fc989c190ea2d14b3c120ba3eb0cd750a2d7e7e0792e449fe5c6888c4afbf7f"} 17:38:24 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:24 INFO - Copying logs to upload dir... 17:38:24 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.824261 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 17:38:24.817979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:24.821352) ========= 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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62704158d0785768fb53e4861d8d92e8d7da425c6444f06719ac3a62f19b52b68d75827a039b965e7cc52fe8445d3d75da4e183b2a7c01bd21cee0a8391ff7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/962847acd42a69a557613140f400477876af641851ef87ab54396bf9ad002d090fc989c190ea2d14b3c120ba3eb0cd750a2d7e7e0792e449fe5c6888c4afbf7f"} build_url:https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010978 build_url: 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62704158d0785768fb53e4861d8d92e8d7da425c6444f06719ac3a62f19b52b68d75827a039b965e7cc52fe8445d3d75da4e183b2a7c01bd21cee0a8391ff7a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/962847acd42a69a557613140f400477876af641851ef87ab54396bf9ad002d090fc989c190ea2d14b3c120ba3eb0cd750a2d7e7e0792e449fe5c6888c4afbf7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:24.852338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:24.852696) ========= 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.Oc5Wg1TJnK/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.zUdrg4ALS1/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005232 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:24.901783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:38:24.902100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:38:24.902489) ========= ========= Total master_lag: 0.17 =========