builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1460716458.35 results: success (0) buildid: 20160415014851 builduid: 82c794c2d287426992de7fc4aec04e81 revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.350556) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.350979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.351289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.373860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.374129) ========= 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.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-15 03:34:18-- 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% 163M=0s 2016-04-15 03:34:18 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.486932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.490374) ========= 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.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.026682 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:18.538638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 03:34:18.541963) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-15 03:34:18,625 truncating revision to first 12 chars 2016-04-15 03:34:18,625 Setting DEBUG logging. 2016-04-15 03:34:18,625 attempt 1/10 2016-04-15 03:34:18,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/529cff9c5663?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 03:34:19,691 unpacking tar archive at: fx-team-529cff9c5663/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 03:34:19.868248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:19.868593) ========= script_repo_revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:19.868979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:19.869242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 03:34:19.884552) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-15 03:34:19.884849) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:34:20 INFO - MultiFileLogger online at 20160415 03:34:20 in /builds/slave/test 03:34:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:34:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:20 INFO - {'append_to_log': False, 03:34:20 INFO - 'base_work_dir': '/builds/slave/test', 03:34:20 INFO - 'blob_upload_branch': 'Fx-Team', 03:34:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:20 INFO - 'branch': 'Fx-Team', 03:34:20 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:20 INFO - 'config_files': ('talos/mac_config.py',), 03:34:20 INFO - 'default_actions': ('clobber', 03:34:20 INFO - 'read-buildbot-config', 03:34:20 INFO - 'download-and-extract', 03:34:20 INFO - 'populate-webroot', 03:34:20 INFO - 'create-virtualenv', 03:34:20 INFO - 'install', 03:34:20 INFO - 'run-tests'), 03:34:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:20 INFO - 'download_minidump_stackwalk': True, 03:34:20 INFO - 'download_symbols': 'ondemand', 03:34:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:20 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:20 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:20 INFO - 'installer_path': 'installer.exe', 03:34:20 INFO - 'log_level': 'info', 03:34:20 INFO - 'log_name': 'talos', 03:34:20 INFO - 'log_to_console': True, 03:34:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:34:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:34:20 INFO - 'opt_config_files': (), 03:34:20 INFO - 'pip_index': False, 03:34:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:34:20 INFO - 'cmd': ('bash', 03:34:20 INFO - '-c', 03:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:34:20 INFO - 'enabled': True, 03:34:20 INFO - 'halt_on_failure': False, 03:34:20 INFO - 'name': 'check_screen_resolution'},), 03:34:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:34:20 INFO - 'cmd': ('bash', 03:34:20 INFO - '-c', 03:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:34:20 INFO - 'enabled': True, 03:34:20 INFO - 'halt_on_failure': False, 03:34:20 INFO - 'name': 'check_screen_resolution'},), 03:34:20 INFO - 'run_cmd_checks_enabled': True, 03:34:20 INFO - 'sps_profile': False, 03:34:20 INFO - 'sps_profile_interval': 0, 03:34:20 INFO - 'suite': 'dromaeojs-e10s', 03:34:20 INFO - 'system_bits': '32', 03:34:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:20 INFO - 'title': 't-yosemite-r7-0079', 03:34:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:20 INFO - 'use_talos_json': True, 03:34:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:20 INFO - 'work_dir': 'build'} 03:34:20 INFO - ##### 03:34:20 INFO - ##### Running clobber step. 03:34:20 INFO - ##### 03:34:20 INFO - Running pre-action listener: _resource_record_pre_action 03:34:20 INFO - Running main action method: clobber 03:34:20 INFO - rmtree: /builds/slave/test/build 03:34:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:21 INFO - Running post-action listener: _resource_record_post_action 03:34:21 INFO - ##### 03:34:21 INFO - ##### Running read-buildbot-config step. 03:34:21 INFO - ##### 03:34:21 INFO - Running pre-action listener: _resource_record_pre_action 03:34:21 INFO - Running main action method: read_buildbot_config 03:34:21 INFO - Using buildbot properties: 03:34:21 INFO - { 03:34:21 INFO - "project": "", 03:34:21 INFO - "product": "firefox", 03:34:21 INFO - "script_repo_revision": "production", 03:34:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:34:21 INFO - "repository": "", 03:34:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:34:21 INFO - "buildid": "20160415014851", 03:34:21 INFO - "pgo_build": "False", 03:34:21 INFO - "basedir": "/builds/slave/test", 03:34:21 INFO - "buildnumber": 693, 03:34:21 INFO - "slavename": "t-yosemite-r7-0079", 03:34:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:34:21 INFO - "platform": "yosemite_r7", 03:34:21 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 03:34:21 INFO - "branch": "fx-team", 03:34:21 INFO - "repo_path": "integration/fx-team", 03:34:21 INFO - "revision": "529cff9c5663a3581dfb5e690727144f07e8e23c", 03:34:21 INFO - "stage_platform": "macosx64", 03:34:21 INFO - "builduid": "82c794c2d287426992de7fc4aec04e81", 03:34:21 INFO - "slavebuilddir": "test" 03:34:21 INFO - } 03:34:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:34:21 INFO - Running post-action listener: _resource_record_post_action 03:34:21 INFO - ##### 03:34:21 INFO - ##### Running download-and-extract step. 03:34:21 INFO - ##### 03:34:21 INFO - Running pre-action listener: _resource_record_pre_action 03:34:21 INFO - Running main action method: download_and_extract 03:34:21 INFO - mkdir: /builds/slave/test/build/tests 03:34: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')]} 03:34:21 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 03:34:32 INFO - Downloaded 1199 bytes. 03:34:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:34:32 INFO - Using the following test package requirements: 03:34:32 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:34:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:34:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:34:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'jsshell-mac.zip'], 03:34:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:34:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:34:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:34:32 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:34:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:34:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:34:32 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:34:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:32 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:34:36 INFO - Downloaded 18031138 bytes. 03:34:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:34:39 INFO - Return code: 0 03:34:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:39 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:34:41 INFO - Downloaded 18031138 bytes. 03:34:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:34:44 INFO - Return code: 0 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:44 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:34:45 INFO - Downloaded 10841076 bytes. 03:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:34:45 INFO - Return code: 0 03:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:45 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:34:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:34:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:34:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 03:34:49 INFO - Downloaded 109830505 bytes. 03:34:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:34:49 INFO - mkdir: /builds/slave/test/properties 03:34:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:49 INFO - Contents: 03:34:49 INFO - build_url:https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:34:50 INFO - Running post-action listener: _resource_record_post_action 03:34:50 INFO - Running post-action listener: set_extra_try_arguments 03:34:50 INFO - ##### 03:34:50 INFO - ##### Running populate-webroot step. 03:34:50 INFO - ##### 03:34:50 INFO - Running pre-action listener: _resource_record_pre_action 03:34:50 INFO - Running main action method: populate_webroot 03:34:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:50 INFO - '--tppagecycles', 03:34:50 INFO - '7'], 03:34:50 INFO - 'tests': ['tsvgm']}}, 03:34:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['damp', 'tps']}, 03:34:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'tests': ['damp', 'tps']}, 03:34:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['dromaeo_dom']}, 03:34:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['a11yr', 03:34:50 INFO - 'ts_paint', 03:34:50 INFO - 'tpaint', 03:34:50 INFO - 'sessionrestore', 03:34:50 INFO - 'sessionrestore_no_auto_restore', 03:34:50 INFO - 'tabpaint']}, 03:34:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['tsvgx', 03:34:50 INFO - 'tsvgr_opacity', 03:34:50 INFO - 'tart', 03:34:50 INFO - 'tscrollx', 03:34:50 INFO - 'cart']}, 03:34:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:50 INFO - 'tsvgr_opacity', 03:34:50 INFO - 'tart', 03:34:50 INFO - 'tscrollx', 03:34:50 INFO - 'cart']}, 03:34:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'talos_options': ['--disable-e10s'], 03:34:50 INFO - 'tests': ['tp5o']}, 03:34:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'tests': ['tp5o']}, 03:34:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'talos_options': ['--disable-e10s', 03:34:50 INFO - '--xperf_path', 03:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:50 INFO - 'tests': ['tp5n']}, 03:34:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:50 INFO - 'talos_options': ['--xperf_path', 03:34:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:50 INFO - 'tests': ['tp5n']}}, 03:34:50 INFO - 'talos.zip': {'path': '', 03:34:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:50 INFO - Running post-action listener: _resource_record_post_action 03:34:50 INFO - ##### 03:34:50 INFO - ##### Running create-virtualenv step. 03:34:50 INFO - ##### 03:34:50 INFO - Running pre-action listener: _resource_record_pre_action 03:34:50 INFO - Running main action method: create_virtualenv 03:34:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:51 INFO - Using real prefix '/tools/python27' 03:34:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:54 INFO - Installing pip.................done. 03:34:54 INFO - Return code: 0 03:34:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:54 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:54 INFO - 'HOME': '/Users/cltbld', 03:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:54 INFO - 'LOGNAME': 'cltbld', 03:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:54 INFO - 'MOZ_NO_REMOTE': '1', 03:34:54 INFO - 'NO_EM_RESTART': '1', 03:34:54 INFO - 'PAGER': '/bin/cat', 03:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:54 INFO - 'PWD': '/builds/slave/test', 03:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:54 INFO - 'SHELL': '/bin/bash', 03:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:34:54 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:54 INFO - 'USER': 'cltbld', 03:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - 'XPC_FLAGS': '0x0', 03:34:54 INFO - 'XPC_SERVICE_NAME': '0', 03:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:55 INFO - Cleaning up... 03:34:55 INFO - Return code: 0 03:34:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:55 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:55 INFO - 'HOME': '/Users/cltbld', 03:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:55 INFO - 'LOGNAME': 'cltbld', 03:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:55 INFO - 'MOZ_NO_REMOTE': '1', 03:34:55 INFO - 'NO_EM_RESTART': '1', 03:34:55 INFO - 'PAGER': '/bin/cat', 03:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:55 INFO - 'PWD': '/builds/slave/test', 03:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:55 INFO - 'SHELL': '/bin/bash', 03:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:34:55 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:55 INFO - 'USER': 'cltbld', 03:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:55 INFO - 'XPC_FLAGS': '0x0', 03:34:55 INFO - 'XPC_SERVICE_NAME': '0', 03:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:55 INFO - Downloading/unpacking psutil>=0.7.1 03:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:58 INFO - Installing collected packages: psutil 03:34:58 INFO - Running setup.py install for psutil 03:34:58 INFO - building 'psutil._psutil_osx' extension 03:34:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:34:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:34:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:34:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:34:59 INFO - building 'psutil._psutil_posix' extension 03:34:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:34:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:34:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:34:59 INFO - ^ 03:34:59 INFO - 1 warning generated. 03:34:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:59 INFO - Successfully installed psutil 03:34:59 INFO - Cleaning up... 03:34:59 INFO - Return code: 0 03:34:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:59 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:59 INFO - 'HOME': '/Users/cltbld', 03:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:59 INFO - 'LOGNAME': 'cltbld', 03:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:59 INFO - 'MOZ_NO_REMOTE': '1', 03:34:59 INFO - 'NO_EM_RESTART': '1', 03:34:59 INFO - 'PAGER': '/bin/cat', 03:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:59 INFO - 'PWD': '/builds/slave/test', 03:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:59 INFO - 'SHELL': '/bin/bash', 03:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:34:59 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:59 INFO - 'USER': 'cltbld', 03:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:59 INFO - 'XPC_FLAGS': '0x0', 03:34:59 INFO - 'XPC_SERVICE_NAME': '0', 03:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:35:02 INFO - Installing collected packages: mozsystemmonitor 03:35:02 INFO - Running setup.py install for mozsystemmonitor 03:35:02 INFO - Successfully installed mozsystemmonitor 03:35:02 INFO - Cleaning up... 03:35:02 INFO - Return code: 0 03:35:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:02 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:02 INFO - 'HOME': '/Users/cltbld', 03:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:02 INFO - 'LOGNAME': 'cltbld', 03:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:02 INFO - 'MOZ_NO_REMOTE': '1', 03:35:02 INFO - 'NO_EM_RESTART': '1', 03:35:02 INFO - 'PAGER': '/bin/cat', 03:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:02 INFO - 'PWD': '/builds/slave/test', 03:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:02 INFO - 'SHELL': '/bin/bash', 03:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:02 INFO - 'USER': 'cltbld', 03:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:02 INFO - 'XPC_FLAGS': '0x0', 03:35:02 INFO - 'XPC_SERVICE_NAME': '0', 03:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:06 INFO - Downloading docopt-0.6.1.tar.gz 03:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:06 INFO - Running setup.py install for blobuploader 03:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:06 INFO - Running setup.py install for requests 03:35:07 INFO - Running setup.py install for docopt 03:35:07 INFO - Successfully installed blobuploader requests docopt 03:35:07 INFO - Cleaning up... 03:35:07 INFO - Return code: 0 03:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:07 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:07 INFO - 'HOME': '/Users/cltbld', 03:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:07 INFO - 'LOGNAME': 'cltbld', 03:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:07 INFO - 'MOZ_NO_REMOTE': '1', 03:35:07 INFO - 'NO_EM_RESTART': '1', 03:35:07 INFO - 'PAGER': '/bin/cat', 03:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:07 INFO - 'PWD': '/builds/slave/test', 03:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:07 INFO - 'SHELL': '/bin/bash', 03:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:07 INFO - 'USER': 'cltbld', 03:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:07 INFO - 'XPC_FLAGS': '0x0', 03:35:07 INFO - 'XPC_SERVICE_NAME': '0', 03:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-isy8ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-LI9bH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yZySqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-IAVyYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Sgt5fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zzXHuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9CEPeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-JPgByW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fiAW9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9coFW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-oYUyFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3gIGnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-skRR3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fNnZNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-NkxYNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HZaG9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1ILMdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:09 INFO - Running setup.py install for manifestparser 03:35:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozcrash 03:35:09 INFO - Running setup.py install for mozdebug 03:35:09 INFO - Running setup.py install for mozdevice 03:35:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for mozfile 03:35:10 INFO - Running setup.py install for mozhttpd 03:35:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for mozinfo 03:35:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for mozInstall 03:35:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for mozleak 03:35:10 INFO - Running setup.py install for mozlog 03:35:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for moznetwork 03:35:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Running setup.py install for mozprocess 03:35:11 INFO - Running setup.py install for mozprofile 03:35:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Running setup.py install for mozrunner 03:35:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Running setup.py install for mozscreenshot 03:35:11 INFO - Running setup.py install for moztest 03:35:11 INFO - Running setup.py install for mozversion 03:35:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:11 INFO - Cleaning up... 03:35:11 INFO - Return code: 0 03:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:11 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:11 INFO - 'HOME': '/Users/cltbld', 03:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PAGER': '/bin/cat', 03:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:11 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - 'XPC_FLAGS': '0x0', 03:35:11 INFO - 'XPC_SERVICE_NAME': '0', 03:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-hnxBAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-5xaZFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HRW_gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4h1zIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_iImBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-D_owqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BrIwfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ZAhxLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-vdvW8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-mOkmI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-NfZRwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-GHGM7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l7FhOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-GEpkhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-snmdCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WfmQjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-k6ivsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:16 INFO - Downloading blessings-1.6.tar.gz 03:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:16 INFO - Installing collected packages: blessings 03:35:16 INFO - Running setup.py install for blessings 03:35:16 INFO - Successfully installed blessings 03:35:16 INFO - Cleaning up... 03:35:16 INFO - Return code: 0 03:35:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:17 INFO - Reading from file tmpfile_stdout 03:35:17 INFO - Current package versions: 03:35:17 INFO - blessings == 1.6 03:35:17 INFO - blobuploader == 1.2.4 03:35:17 INFO - docopt == 0.6.1 03:35:17 INFO - manifestparser == 1.1 03:35:17 INFO - mozInstall == 1.12 03:35:17 INFO - mozcrash == 0.17 03:35:17 INFO - mozdebug == 0.1 03:35:17 INFO - mozdevice == 0.48 03:35:17 INFO - mozfile == 1.2 03:35:17 INFO - mozhttpd == 0.7 03:35:17 INFO - mozinfo == 0.9 03:35:17 INFO - mozleak == 0.1 03:35:17 INFO - mozlog == 3.1 03:35:17 INFO - moznetwork == 0.27 03:35:17 INFO - mozprocess == 0.22 03:35:17 INFO - mozprofile == 0.28 03:35:17 INFO - mozrunner == 6.11 03:35:17 INFO - mozscreenshot == 0.1 03:35:17 INFO - mozsystemmonitor == 0.0 03:35:17 INFO - moztest == 0.7 03:35:17 INFO - mozversion == 1.4 03:35:17 INFO - psutil == 3.1.1 03:35:17 INFO - requests == 1.2.3 03:35:17 INFO - wsgiref == 0.1.2 03:35:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:17 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:17 INFO - 'HOME': '/Users/cltbld', 03:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:17 INFO - 'LOGNAME': 'cltbld', 03:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:17 INFO - 'MOZ_NO_REMOTE': '1', 03:35:17 INFO - 'NO_EM_RESTART': '1', 03:35:17 INFO - 'PAGER': '/bin/cat', 03:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:17 INFO - 'PWD': '/builds/slave/test', 03:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:17 INFO - 'SHELL': '/bin/bash', 03:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:17 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:17 INFO - 'USER': 'cltbld', 03:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:17 INFO - 'XPC_FLAGS': '0x0', 03:35:17 INFO - 'XPC_SERVICE_NAME': '0', 03:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:17 INFO - Cleaning up... 03:35:17 INFO - Return code: 0 03:35:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:17 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 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:17 INFO - 'HOME': '/Users/cltbld', 03:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:17 INFO - 'LOGNAME': 'cltbld', 03:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:17 INFO - 'MOZ_NO_REMOTE': '1', 03:35:17 INFO - 'NO_EM_RESTART': '1', 03:35:17 INFO - 'PAGER': '/bin/cat', 03:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:17 INFO - 'PWD': '/builds/slave/test', 03:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:17 INFO - 'SHELL': '/bin/bash', 03:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:17 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:17 INFO - 'USER': 'cltbld', 03:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:17 INFO - 'XPC_FLAGS': '0x0', 03:35:17 INFO - 'XPC_SERVICE_NAME': '0', 03:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:17 INFO - Downloading/unpacking jsonschema 03:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:20 INFO - Downloading/unpacking functools32 (from jsonschema) 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:21 INFO - warning: no files found matching '*.txt' 03:35:21 INFO - no previously-included directories found matching 'build' 03:35:21 INFO - no previously-included directories found matching 'dist' 03:35:21 INFO - no previously-included directories found matching '.git*' 03:35:21 INFO - Installing collected packages: jsonschema, functools32 03:35:21 INFO - Running setup.py install for functools32 03:35:21 INFO - warning: no files found matching '*.txt' 03:35:21 INFO - no previously-included directories found matching 'build' 03:35:21 INFO - no previously-included directories found matching 'dist' 03:35:21 INFO - no previously-included directories found matching '.git*' 03:35:21 INFO - Successfully installed jsonschema functools32 03:35:21 INFO - Cleaning up... 03:35:21 INFO - Return code: 0 03:35:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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')]} 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1031b5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031c5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfc85c8e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, '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.OQF3vpx1jo/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.2kkw1TU121/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:21 INFO - 'HOME': '/Users/cltbld', 03:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:21 INFO - 'LOGNAME': 'cltbld', 03:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:21 INFO - 'MOZ_NO_REMOTE': '1', 03:35:21 INFO - 'NO_EM_RESTART': '1', 03:35:21 INFO - 'PAGER': '/bin/cat', 03:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:21 INFO - 'PWD': '/builds/slave/test', 03:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:21 INFO - 'SHELL': '/bin/bash', 03:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:35:21 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:21 INFO - 'USER': 'cltbld', 03:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:21 INFO - 'XPC_FLAGS': '0x0', 03:35:21 INFO - 'XPC_SERVICE_NAME': '0', 03:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:21 INFO - Downloading/unpacking flake8 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:35:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:35:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:26 INFO - no previously-included directories found matching 'docs/_build' 03:35:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:35:26 INFO - Running setup.py install for pep8 03:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:26 INFO - no previously-included directories found matching 'docs/_build' 03:35:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:35:26 INFO - Cleaning up... 03:35:26 INFO - Return code: 0 03:35:26 INFO - Running post-action listener: _resource_record_post_action 03:35:26 INFO - Running post-action listener: _start_resource_monitoring 03:35:26 INFO - Starting resource monitoring. 03:35:26 INFO - ##### 03:35:26 INFO - ##### Running install step. 03:35:26 INFO - ##### 03:35:26 INFO - Running pre-action listener: _resource_record_pre_action 03:35:26 INFO - Running main action method: install 03:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:26 INFO - Reading from file tmpfile_stdout 03:35:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:26 INFO - Reading from file tmpfile_stdout 03:35:26 INFO - Output received: 03:35:26 INFO - Usage: mozinstall [options] installer 03:35:26 INFO - Options: 03:35:26 INFO - -h, --help show this help message and exit 03:35:26 INFO - -d DEST, --destination=DEST 03:35:26 INFO - Directory to install application into. [default: 03:35:26 INFO - "/builds/slave/test"] 03:35:26 INFO - --app=APP Application being installed. [default: firefox] 03:35:26 INFO - mkdir: /builds/slave/test/build/application 03:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:36:00 INFO - Reading from file tmpfile_stdout 03:36:00 INFO - Output received: 03:36:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:36:00 INFO - Running post-action listener: _resource_record_post_action 03:36:00 INFO - ##### 03:36:00 INFO - ##### Running run-tests step. 03:36:00 INFO - ##### 03:36:00 INFO - Running pre-action listener: _resource_record_pre_action 03:36:00 INFO - Running main action method: run_tests 03:36:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:36:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:36:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:36:00 INFO - 2016-04-15 03:36:00.214 screenresolution[1660:7734] starting screenresolution argv=screenresolution get 03:36:00 INFO - 2016-04-15 03:36:00.217 screenresolution[1660:7734] Display 0: 1600x1200x32@60 03:36:00 INFO - 2016-04-15 03:36:00.223 screenresolution[1661:7736] starting screenresolution argv=screenresolution list 03:36:00 INFO - Available Modes on Display 0 03:36:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:36:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:36:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:36:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:36:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:36:00 INFO - Intel Iris: 03:36:00 INFO - Chipset Model: Intel Iris 03:36:00 INFO - Type: GPU 03:36:00 INFO - Bus: Built-In 03:36:00 INFO - VRAM (Dynamic, Max): 1536 MB 03:36:00 INFO - Vendor: Intel (0x8086) 03:36:00 INFO - Device ID: 0x0a2e 03:36:00 INFO - Revision ID: 0x0009 03:36:00 INFO - Displays: 03:36:00 INFO - Display: 03:36:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:36:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:36:00 INFO - Display Serial Number: 1600x1200 60 03:36:00 INFO - Main Display: Yes 03:36:00 INFO - Mirror: Off 03:36:00 INFO - Online: Yes 03:36:00 INFO - Rotation: Supported 03:36:00 INFO - Return code: 0 03:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:00 INFO - Python 2.7.3 03:36:00 INFO - Return code: 0 03:36:00 INFO - grabbing minidump binary from tooltool 03:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:00 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 0x103054e00>, '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 0x102ebddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10304fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:36:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:36:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:00 INFO - Return code: 0 03:36:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:36:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:36:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:36:01 INFO - Return code: 0 03:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OQF3vpx1jo/Render', 03:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:01 INFO - 'HOME': '/Users/cltbld', 03:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:01 INFO - 'LOGNAME': 'cltbld', 03:36:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:01 INFO - 'MOZ_NO_REMOTE': '1', 03:36:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:01 INFO - 'NO_EM_RESTART': '1', 03:36:01 INFO - 'PAGER': '/bin/cat', 03:36:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:01 INFO - 'PWD': '/builds/slave/test', 03:36:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:01 INFO - 'SHELL': '/bin/bash', 03:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2kkw1TU121/Listeners', 03:36:01 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 03:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:01 INFO - 'USER': 'cltbld', 03:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:01 INFO - 'XPC_FLAGS': '0x0', 03:36:01 INFO - 'XPC_SERVICE_NAME': '0', 03:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:36:01 INFO - mozversion application_buildid: 20160415014851 03:36:01 INFO - mozversion application_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 03:36:01 INFO - mozversion application_display_name: Nightly 03:36:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:01 INFO - mozversion application_name: Firefox 03:36:01 INFO - mozversion application_remotingname: firefox 03:36:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:36:01 INFO - mozversion application_vendor: Mozilla 03:36:01 INFO - mozversion application_version: 48.0a1 03:36:01 INFO - mozversion platform_buildid: 20160415014851 03:36:01 INFO - mozversion platform_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 03:36:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:36:01 INFO - mozversion platform_version: 48.0a1 03:36:01 INFO - using testdate: 1460716561 03:36:01 INFO - actual date: 1460716561 03:36:01 INFO - starting webserver on 'localhost:49275' 03:36:01 INFO - SUITE-START | Running 2 tests 03:36:01 INFO - TEST-START | dromaeo_css 03:36:01 INFO - operating with platform_type : mac_ 03:36:01 INFO - Initialising browser for dromaeo_css test... 03:36:01 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpQ683T7/profile http://localhost:49275/getInfo.html) 03:36:04 INFO - PROCESS | 1679 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 03:36:04 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:36:04 INFO - PROCESS | 1679 | colorDepth:24 03:36:04 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:36:04 INFO - PROCESS | 1679 | __metrics 03:36:04 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:36:05 INFO - TEST-INFO | 1679: exit 0 03:36:05 INFO - Browser initialized. 03:36:05 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:05 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpQ683T7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:17 INFO - PROCESS | 1682 | RSS: Main: 247820288 03:36:17 INFO - PROCESS | 1682 | 03:37:07 INFO - PROCESS | 1682 | 1460716627292 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:39:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:39:19 INFO - PROCESS | 1682 | RSS: Main: 260083712 03:39:19 INFO - PROCESS | 1682 | 03:42:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:42:22 INFO - PROCESS | 1682 | RSS: Main: 271872000 03:42:22 INFO - PROCESS | 1682 | 03:45:24 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:45:25 INFO - PROCESS | 1682 | RSS: Main: 273678336 03:45:25 INFO - PROCESS | 1682 | 03:48:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:48:27 INFO - PROCESS | 1682 | RSS: Main: 275234816 03:48:27 INFO - PROCESS | 1682 | 03:51:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:51:30 INFO - PROCESS | 1682 | RSS: Main: 278261760 03:51:30 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:54:33 INFO - PROCESS | 1682 | RSS: Main: 279248896 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | __start_tp_report 03:54:33 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 03:54:33 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 03:54:33 INFO - PROCESS | 1682 | |i|pagename|runs| 03:54:33 INFO - PROCESS | 1682 | |0;dojo.html;3204.423203823311;3217.8873739419123;3430.5025771263176;3517.6482351764844;3520.80635565044;4727.716337019772;5766.961946849566;5805.564582656297;5834.56240781941;5839.270091238595;4163.292240319145;5392.46314800282;5778;5813.157092221625;5920.259967504062;4229.259879521087;5203.115470370037;5267.499587539178;5283.339582552181;5337.919931201035;5263.86840328991;5326.813561525348;5357.571394288448;5371.81198658047;5428.267183930158;4207.410962465257;5173.224016397533;5209.791608335662;5220.947790522084;5295.894082118336;5254.789808407659;5274.182501712203;5277.9971805357245;5298.470152984709;5313.38896026958;4412.602865742067;5207.687538747649;5244.906589716132;5267.499587539178;5273.683578985273;5017.523335283142;5445.910817836409;5651.4913657770585;5666.603337766358;5714.371419143891;5085.593152547787;6231.6572588507615;6233;6291.559590828644;6295.842603934892;5332.733363331857;6137.438273608336;6273.309935907047;6281.183446151971;6286.559940804145;5865.794697185578;5882;5888.087346461305;5895.734691938873;5900.881982360329;6307.148534947723;6351.396617321347;6374.9681251594375;6385;6388.872222555523;6092.573519853657;6104.337893874325;6209.844753881189;6228.439440450381;6246.437820596168;5675.836453527099;5796.21751063601;6250.531210159256;6263.404976527223;6299.212598425197;6012.969935150296;6176.567640265138;6267.905981410283;6271.404216599416;6294.937050629526;6117.918752924011;6150.907736383958;6184.721687524072;6209.658468784261;6255.468285195719;4961.305417241589;4976.42771081323;4986.501349864984;4999.200127979506;5026.321446604735;4436.534163912807;4459.308807134899;4479.238529450001;4493.662975276868;4515.7290562565695;5630.183623374588;5796.304443466726;5864.882702345929;5891.027980383275;5910.408959104056;6225.159603453566;6252.124702541648;6253.593516421418;6283.842903927347;6299.937000629935;5885.588008839341;5907.7046147692445;5908.113782932509;5925.822225333247;5962.165296858443;5374.408815030343;5415.48552887475;5480.6437581557075;5491.2312276281355;5509.090999985037;6468.6442245676935;6490.96754516215;6491.318411566717;6495.577787443801;6506.479481641552;6144.880016394337;6263.029230469285;6278.15244941927;6291.402316779899;6294.968525157528;5021.6735912165595;6342.460890824332;6389.2652344980925;6509.641969691713;6512.967435162794;5583.972080139573;6194.659293738708;6284.120223168851;6288.119663247057;6305.716242769178;6155.984262596621;6174.44430001302;6252.205418246619;6296.811095667137;6299.370062993848;5335.413104558418;6010.248718910137;6148.262208535004;6197.194364732556;6261.78083767066;5370.516653501204;5395.81114660985;5831;6196.969015154896;6231.4391704746795;5926.644401335933;6001.189839371804;6104.908426373697;6119.173911521888;6123.081537769192;6107.917136653054;6115.327313995546;6124.601900876429;6133.756626433956;6186.690665466798;4966.503349665005;6017.488513476404;6049.909251361145;6054.3340232575265;6077.574569780073 03:54:33 INFO - PROCESS | 1682 | |1;ext.html;503.7758197602066;516.1432022842083;529.5869222006834;538.4911258860377;600.2197143713172;36280;36473.63526364739;37064.629353706456;37103.62896371039;37242.441363379505;39039.82880513582;39697.40453893186;39724.40413393794;39852;39878.80060599693;9287.907120928789;9426.670066547673;9489.857652135224;9500.762480937998;9536.952315238414;9359.906400936006;9419.387739796926;9428.905710942905;9432.764180895498;9483.05169483053;8177.427580069398;9413.058694130601;9418.717438476857;9469.479178645171;9486.762830929212;9355.391899526508;9439.19766819821;9445;9487.762805929839;9517.191038761714;9204.631814727403;9221.907780922173;9226.215771659417;9254.537273136317;9311.44131352121;32078;37336.626633733584;37543;37565.62434375676;38005;2966.0656893078612;2993.5060714982;3099.7520198384077;3181.6659250778566;3474.2183008823067;27934.44131117366;28683.85658071696;29314.85342573295;29374.412511749644;29382.85308573465;2717.850518221497;2721.9183424497296;2752.215618548704;2780.958285625717;2837.730415610514;419895;420753;425662.9999999969;426676;426817;34727.9581612552;58139.70930145322;61535.38464615386;62303.376966230666;62350.44123896939;31071;31177.532337014964;31380;31500.212494687818;31580.842095789372;14927;15014.399424022917;15020.474283400028;15139.54581362561;15166.469173578871;11244.437778111225;12423.751524969632;12729.618111456672;12830.935845320713;12839.422225999666;7888.723894663659;7897.842043159105;7920.089189743253;8054.114047454776;8099.838003239902;3312.8343582821244;3338.5159151922835;3354.580677415323;3374.207061340583;3386.5766779152605;983.4099540275778;991.9156871665989;992.2211064314479;1004.6031817432073;1117.9608713694981;24187.637185442232;24408.755912441004;29153.56269655957;29995.400091998476;30520;936.7564433247405;1086.266769930294;1126.5143123941364;1203.711109333771;1268.9111762176558;15289.770653440208;15446.613834654223;15448.150351730763;15677;15768.817338699413;501138;599277;630625.6937430659;631380;637336;57521.71239143777;59498.70250648719;59651.80696386048;59673.40326596679;60860;1147.8909503597145;1401.7546929287334;1438;1490.2250829568563;1494.1931357067278;29266;29279.853600732713;29605.555916660836;29796.702032979392;30062.69937300599;49609.50390496049;49617.255741163186;50062;50411;50607;555950;564719;567681;570727;571623;26200.8689956549;26396.868015660566;26433.73566264313;26664.333391665365;27036.324091897073;45879;46248.768756156;46272;46690.766546167055;47072.293915590606;36480.81759591185;37360.87917362483;37943.62056379511;38225.23549528938;38466.0383490415;36928.815355924125;37023.75259046626;37491.62508374881;37494.812525937195;38141.237175256894;37063.81468092642;37992;38110.42834357431;38850;39057.6094239054;29857;31460.89886853949;31851.522227167075;31853;32122.35755284928;23936.162234321717;24354.878225609467;24543.877280613484;24757.62863557084;24871.75128248767 03:54:33 INFO - PROCESS | 1682 | |2;jquery.html;389.108940526195;395.19183270212415;401.61244399154816;402.4144869215292;408.5036680433273;14122.293885305719;19801.603967920633;20510.692339614918;20537;20573.69139462909;19705.704414433796;19858.205671773147;20259.898700506477;20386.286479973205;20665.690014649794;5765.913511297334;5875.88248235035;5890.499307558863;5911.822645320647;5925.170476133345;5764.020116580192;5773.134029895528;5849.415058494138;5867.237259156325;5901.026330655437;5619.381867994517;5864.618799778001;5959;5966.910496342558;5985.401459854023;5869.354371019184;5971.104334349839;5980.13288073227;5986.521078313746;6012.488938440238;5485.396606373336;5520.834374968757;5557.138643510262;5576.358718747356;5587.525060369833;12638.810417843739;13360.933195334059;13500.594982150453;13520.729585408237;13524.188548687012;2013.7684166320914;2035.5928814237063;2091.7176181215495;2121.487034803155;2174.8912554372378;8817.779555511099;9218.847644044494;9937.503124843728;12938.094333396666;13624.114432561952;1754.921028553718;1755.1926113987581;1763.215369160724;1767.6641438126844;1781.0649409060218;117644;118715.40642296734;119570.60858782775;120669.39665301704;121276;8055.993000874891;11670.474828632732;11710.941445292889;11820.345151678772;11880.821787673192;12277.263364198177;14833.664970152522;14870.628234294012;14897.553073407815;14923.253837308092;8544.31645468361;8605.397622166389;8734.301255899512;8736.825263494822;8794.956025219833;8504;8526.914730852612;8545.102764209792;8578.528180949983;8606.225439710332;4300.505441874225;4560.8175672973375;4627.606653434428;4659.370984917061;4718.292256161603;1865.3191585071352;1990.3224681194672;2006.4081096076693;2008.096356639489;2029.0564887327464;905.62869223618;978.1832170138015;1011.9139873110721;1032.7779527401494;1069.7860427914293;15965.563099321116;20067.799322006886;20362.981850907396;20520.486987825425;20551.58896822085;829.4525613095328;855.362754747717;944.7354740672623;966.8888077870994;991.5240684471494;10429.5828166874;10712.892871071346;10830.945845270724;10854.023137917626;10860.891391086147;513698;598518;602404;622401;624810.8759456173;104935;116026;116286;121354.39322803506;124627;1001.3691374434205;1007.7027276953316;1025.9897401026044;1038.8909164537765;1041.6198087698087;17846.01846898433;18004.009779461732;18151.727724084412;18165.18256678479;18534.351297704514;38974.80512597419;44444;47280.29079563878;48783.512164879314;48857.02285954332;74578.99197367679;74891.62554187194;75017.62491187509;76110.6194469024;76586.10725034773;7919.0893047298;8065;8129.674813007414;8148.83702325962;8356.289715374262;11518.654440366803;11732.061435085343;11747.530098795953;12189.878101218874;12621.558245461365;10445.373277603368;10764.946175269073;10889.836652450062;11126.833097503706;11177.105831533296;8909.109089091038;8910.777230569287;10603.89396106029;10738.97979691928;10996.890031099907;8591.097934717014;8838.160374764388;10586.629467968583;11101.16741244426;11519.596814111466;6722.428593569406;7099.645017749195;7579.54522728638;7979.521228726295;8316.589412537081;8193.50838949665;10109.292349535463;10607.628732994308;10782.892171078189;10912.399818010086 03:54:33 INFO - PROCESS | 1682 | |3;mootools.html;1356.4913157565916;1360.2994457854204;1594.6730920161367;1856.2482194711138;1938.922443102276;7963.681452741884;8514.403991720583;8539.530325832076;8778.034416214212;8782.077881822412;8505;8575.571221438919;8620.439671421369;8643.351748618847;8664.176903194186;2350.6239001759723;2358.2099996501192;2375.7861792438675;2382.8927698253533;2383.6067048936907;2318.0380142241033;2318.8840557972117;2328.662343960125;2330.463993281546;2362.976370236293;1860.990695046523;2310.595645761993;2349.4009027698;2371.9169829055986;2383.0944241188413;2314.6065168921323;2321.5124823787023;2330.4290448839974;2336.275754516097;2356.7643235676464;2331.137479132715;2334.498082912165;2335.089315167086;2344.5076533927895;2348.5420343033115;7546.547207167532;8309.709160179365;8676.739697809076;8747.606357713918;8783.033866274705;5168.4314725380555;5281.234221037967;5346.198070289449;5358.5981051421295;5375.543078838304;3473.426884564069;3500.1249687578106;3577.481265216555;3587.0494319005484;3645.7083433325533;1026.5534492495713;1037.6005237983354;1048.3185929146116;1048.8951104889527;1057.5981127171704;11480.942595287053;11500.654980350602;11574.53701851925;11576.189666723332;11590.362530060844;4687.671862969628;4739.786709598076;4883.072216278895;4898.681585696918;4914.754262286871;9828.262880284008;9868.013198680075;9934.907160212371;9946.552405141785;9966.850497242547;5311;5340.813071542478;5351.491608297206;5356.5982551308025;5434.157705555566;4391.209582275221;4725.220338644154;4891.951080489221;4903.926441103386;4936.531029552187;3948.6841052715713;3987.3620220764537;4015.3976903464713;4037.6567991720444;4156.43888075112;1350.8311461067367;1357.260293140241;1372.28641106624;1384.1003347823994;1384.5431007767413;832;848.9685032685194;908.6002159049997;921.2583869984727;930.3022732950287;5538.335399751975;5676.801311954062;5766.250387449605;5846.1523079153285;5987.161797348374;971.3394891473865;973.2457345557108;979.8922118566952;991.1575161113141;1036.2176556699794;3725.161838586296;3939.901502462404;3972.3842804365368;3973.7019723520852;3992.782086814357;10083.19334453242;10542.841857372145;10557;10568.577256909637;10657.307275027099;9105.81788364229;9387.014363491735;9921.255905807093;10504.474776261157;10562.155027597773;7277.017602623684;7822.765317040498;7991.520508769492;8039;8262.793430164174;4094.877153685394;5572.4706152915405;5881.647101173943;5906.645601263766;5929.970350148222;9626;9648.179904707898;9886;9940.254480914105;9978.301518893608;8148.796280092808;9805.901940980499;9820.263480239153;9944.35361701487;10091.142252908585;5981.431763982415;6684.933150668626;7411.5553066816165;7425.9628701856145;7467.327940485382;8163.102058773649;8238.217369349903;8247.9587602064;8299.709510167115;8308.792280193044;6154.846128846814;7262.600556969417;7418.295261950106;7519.1728909818785;7578.658960346687;7236.20401755817;7302.3792977597495;7355.264473552602;7364.521306115085;7410.777676669709;6967.303269672992;6989.091418115612;7036.472264580075;7079.22128565847;7080.752173673896;4842.6368022397755;4887.926681099858;4913.385826771653;4936.456989731055;5123.974380128076;4754.97767979886;4844.806207751651;4873.780679869344;4931.679440836334;5125.461826508312 03:54:33 INFO - PROCESS | 1682 | |4;prototype.html;314.9370125974804;320;328.09773123909247;330.92057906102514;331.06474210355736;5659.660420374776;5889.083759300061;6117.113018612298;6130.019196928492;6176.258848938122;5044.84865454036;6058.242719660043;6127.448529632332;6138.202033735608;6174.228221472316;4538.863834084975;4550.49944506104;4552.84065057723;4556.179887620227;4589.128065667529;4374.365716971038;4468.687191896569;4536.888462326718;4547.204239258117;4557.908841823161;3611.693006094485;4439.889002774924;4455.754933478657;4476.216662084138;4492.887677808065;4222.23999680059;4456.732596044248;4497.168023915586;4498.730076195422;4516.435445569304;3719.3863012602887;3798.088458769903;3833;3846.6922646188236;3856.382978723419;5829.504492118175;5885.146653735227;5889.646621202742;5892.970535147297;5898.528117750612;5196.68819870809;5203.505666961632;5214.739263036833;5221.399539052982;5224.9738751306;5335.226392173152;6039.063945088518;6293.968530157365;6481.384268494486;6544.770933017321;3329.7502687298547;4225.197212529641;4256.2338779019765;4273.615374616299;4276.615104640566;4594.632429405639;6351.491880649537;6613.801585952381;6649.667516624198;6908.585484870873;3832.080300727861;4327.49005576771;4458.5318541553315;4499.235130027903;4502.3921770560555;3839.577646458887;4590.288505281686;4601.309803529497;4615.815367385334;4619.214733495247;5087.77714496974;5143.588512918957;5334.546563542142;5375.220593014069;5391.245225668409;5476.534494567926;6014.1580178775;6460.353964603502;6485.77299794505;6523.543351965317;1178.8997935175605;1295.5724610878387;1461;1567.788348572928;1573.944911928077;958.9232861371073;965.9855102173473;1008.4201584089031;1044.6918159143072;1065.8382363224123;5974.3428222895445;6041.368830415763;6054.848628784228;6057.000594901792;6124.38756124384;6354.3010268870385;6683.598984060972;6732.899006514906;6742.190937087483;6754.493412994045;5824.912626310609;5953.613015154001;6035.245594300713;6065.877812604682;6079.483243924316;2807.5507918732906;3458.239187378773;3508.456189290613;3535.169235229719;3561.5726112866105;6569.37590928861;6798.116244888231;6989.231184569693;7005.264447233069;7065.2228254891925;6451.612903225821;6813.591184528944;6848.609938080682;6851.38337549613;6861.725530978705;5789.565782566325;6173.32093469718;6654.26803051664;6839.89740153908;7032.753853615099;6607.372299631527;6627.701753421011;6646.235682896336;6680.265170831108;6697.598144111369;6063.975537596989;6544.3782840630065;6566.343365663395;6576.599541167535;6577.632052461206;5773.480386765212;6294.6852657366035;6336.7148478319505;6925.861482770216;6951.296932251631;3804.752691075071;4506.211413002646;4519.457665080211;4541.977290113528;4567.2920697291975;5877.382874798084;6145.846353841011;6477.77327793525;6625.072489851521;6703.597784132968;5792.797252096157;5974.342822289632;6483.870322593616;6484.578502397329;6501.05734668461;6164.612962083495;6182.289036760651;6462.450691691259;6541.70562324706;6649.434798042221;6473.155150782005;6497.5126865484335;6515.934840651533;6541.6402097885075;6595.637239951849;6149.938500615115;6598.472122230306;6629.403353698191;6629.569078009914;6642.900356494753;5291.497307755757;5760.855978600569;5939.703014849327;6438.227412710505;6520.934790652223 03:54:33 INFO - PROCESS | 1682 | |5;yui.html;655.09367739877;658.3811217455591;660.4155322539552;662.5064327076329;767.1637914673005;12179.695507612314;12598.559050433236;14922.179280139588;15119.546413607595;15348;14180.787288190686;14246.074005189656;14263.21552314625;14288.499902503414;14301.856981430183;716.985660286794;900.3427497926517;917.2478567574592;918.0635751533432;922.2391526990226;817.5013241922422;881.1761003461752;899.9685011024616;911.6080085563206;915.514777168102;934.8784657994452;946.564580293066;953.0850383631722;961.3318743473288;963.3930623707055;919.0717375450776;926.2312280806914;938.7043081429362;953.5327689432163;957.1194501059042;689.3279052923409;707.8655055539482;712.7149140343852;716.5306724095726;717.0069453806516;14966.775498367533;15060.774088388684;15233.238338083162;15235.466758663393;15261.38954441821;12795.232286062866;12844.743105137844;12887.097903146783;12898;12900.935495322557;10005.699829005142;10072.94963525185;10211.948940255252;10365.170786337076;10489.632862849763;3461.6884480396634;3516.8769093081874;3525.4359302511475;3526.1889765354113;3533.9293214135573;73641.52716945631;81424.82189726284;82096.17903820945;83296.58351708263;83361;8002.634612218028;8487.321014318839;9112.544372781334;9136.95431522838;9313.90686093144;19684.114214860365;19691.310804121786;19720.605587888163;20625.484362890747;21346.359609211748;7626;7633.809154771176;7905;7961.8407631848195;8000.159983201796;4064.288749468831;4076.5515793262716;4130.545639979599;4148.543660197376;4163.292240319153;3545.096000519851;3637.418013117888;3640.3993341098953;3640.4903313536124;3644.0525463379713;631.8609905820712;637.6206157336377;644.9097126402307;656.2813718977711;656.8719099775498;557.701629628147;581.7033313010395;596.63307066154;610.6336198280995;622.8847663182326;7715.575643339558;7770.883436748453;7914.2085791420395;8197.754067377988;8222.794430139294;450.9425397442991;507.56603104345254;537.6559002238571;590.052964991183;608.3703367015119;3619.4570814378053;3873.24471728016;3903.1217975955183;3924.843006279774;3932.8230229639735;87223;88112;88777.55611221903;89848;89868.55065724629;75217.62391188009;76998;77368.61315693498;77451;77722;52000.21999670008;66329.34176645623;68251;69218.30781692118;69825.95261071088;5803.912941305799;6318.178636777189;7584.393248540214;7754.961225193838;7799.5320280783335;33450.163745906546;34550.48174277337;43721.56278437302;43913.78043109764;44584.331235030855;62622.6868865671;63401.36598634139;63426.68286658537;63783;63876;9890.703278901645;10044.698659040241;10146.594136234467;10262.486875656337;10394.324368915995;11132.276402033842;11175.608853690082;11189.888101118884;11335.829962550404;11365.204435689422;8334.458260213067;8567.528785916586;10204.183665306906;10257.640982565872;10838.620648277272;10348.637797677045;10698.144148467949;10760.83858742135;10870.836937445787;10890.945545272223;10237.283390162616;10535.473226338805;11091.667249982513;11165.888341116484;11469.662921348314;8043.879341809995;9452.669156579486;9535.38020028696;9811.509424528887;9813.460259685786;9417.434953902788;9552.85670714926;9574.377665451724;9603.183729383081;9658.9034109658 03:54:33 INFO - PROCESS | 1682 | __end_tp_report 03:54:33 INFO - PROCESS | 1682 | __start_cc_report 03:54:33 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,389 03:54:33 INFO - PROCESS | 1682 | __end_cc_report 03:54:33 INFO - PROCESS | 1682 | __startTimestamp1460717673549__endTimestamp 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | ------- Summary: start ------- 03:54:33 INFO - PROCESS | 1682 | Number of tests: 6 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:5716.70 Median:5910.41 stddev:688.92 (11.7%) stddev-sans-first:662.24 03:54:33 INFO - PROCESS | 1682 | Values: 3204.4 3217.9 3430.5 3517.6 3520.8 4727.7 5767.0 5805.6 5834.6 5839.3 4163.3 5392.5 5778.0 5813.2 5920.3 4229.3 5203.1 5267.5 5283.3 5337.9 5263.9 5326.8 5357.6 5371.8 5428.3 4207.4 5173.2 5209.8 5220.9 5295.9 5254.8 5274.2 5278.0 5298.5 5313.4 4412.6 5207.7 5244.9 5267.5 5273.7 5017.5 5445.9 5651.5 5666.6 5714.4 5085.6 6231.7 6233.0 6291.6 6295.8 5332.7 6137.4 6273.3 6281.2 6286.6 5865.8 5882.0 5888.1 5895.7 5900.9 6307.1 6351.4 6375.0 6385.0 6388.9 6092.6 6104.3 6209.8 6228.4 6246.4 5675.8 5796.2 6250.5 6263.4 6299.2 6013.0 6176.6 6267.9 6271.4 6294.9 6117.9 6150.9 6184.7 6209.7 6255.5 4961.3 4976.4 4986.5 4999.2 5026.3 4436.5 4459.3 4479.2 4493.7 4515.7 5630.2 5796.3 5864.9 5891.0 5910.4 6225.2 6252.1 6253.6 6283.8 6299.9 5885.6 5907.7 5908.1 5925.8 5962.2 5374.4 5415.5 5480.6 5491.2 5509.1 6468.6 6491.0 6491.3 6495.6 6506.5 6144.9 6263.0 6278.2 6291.4 6295.0 5021.7 6342.5 6389.3 6509.6 6513.0 5584.0 6194.7 6284.1 6288.1 6305.7 6156.0 6174.4 6252.2 6296.8 6299.4 5335.4 6010.2 6148.3 6197.2 6261.8 5370.5 5395.8 5831.0 6197.0 6231.4 5926.6 6001.2 6104.9 6119.2 6123.1 6107.9 6115.3 6124.6 6133.8 6186.7 4966.5 6017.5 6049.9 6054.3 6077.6 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:64976.74 Median:37518.91 stddev:143554.15 (382.6%) stddev-sans-first:143875.25 03:54:33 INFO - PROCESS | 1682 | Values: 503.8 516.1 529.6 538.5 600.2 36280.0 36473.6 37064.6 37103.6 37242.4 39039.8 39697.4 39724.4 39852.0 39878.8 9287.9 9426.7 9489.9 9500.8 9537.0 9359.9 9419.4 9428.9 9432.8 9483.1 8177.4 9413.1 9418.7 9469.5 9486.8 9355.4 9439.2 9445.0 9487.8 9517.2 9204.6 9221.9 9226.2 9254.5 9311.4 32078.0 37336.6 37543.0 37565.6 38005.0 2966.1 2993.5 3099.8 3181.7 3474.2 27934.4 28683.9 29314.9 29374.4 29382.9 2717.9 2721.9 2752.2 2781.0 2837.7 419895.0 420753.0 425663.0 426676.0 426817.0 34728.0 58139.7 61535.4 62303.4 62350.4 31071.0 31177.5 31380.0 31500.2 31580.8 14927.0 15014.4 15020.5 15139.5 15166.5 11244.4 12423.8 12729.6 12830.9 12839.4 7888.7 7897.8 7920.1 8054.1 8099.8 3312.8 3338.5 3354.6 3374.2 3386.6 983.4 991.9 992.2 1004.6 1118.0 24187.6 24408.8 29153.6 29995.4 30520.0 936.8 1086.3 1126.5 1203.7 1268.9 15289.8 15446.6 15448.2 15677.0 15768.8 501138.0 599277.0 630625.7 631380.0 637336.0 57521.7 59498.7 59651.8 59673.4 60860.0 1147.9 1401.8 1438.0 1490.2 1494.2 29266.0 29279.9 29605.6 29796.7 30062.7 49609.5 49617.3 50062.0 50411.0 50607.0 555950.0 564719.0 567681.0 570727.0 571623.0 26200.9 26396.9 26433.7 26664.3 27036.3 45879.0 46248.8 46272.0 46690.8 47072.3 36480.8 37360.9 37943.6 38225.2 38466.0 36928.8 37023.8 37491.6 37494.8 38141.2 37063.8 37992.0 38110.4 38850.0 39057.6 29857.0 31460.9 31851.5 31853.0 32122.4 23936.2 24354.9 24543.9 24757.6 24871.8 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:33772.56 Median:11378.70 stddev:98949.70 (869.6%) stddev-sans-first:99195.53 03:54:33 INFO - PROCESS | 1682 | Values: 389.1 395.2 401.6 402.4 408.5 14122.3 19801.6 20510.7 20537.0 20573.7 19705.7 19858.2 20259.9 20386.3 20665.7 5765.9 5875.9 5890.5 5911.8 5925.2 5764.0 5773.1 5849.4 5867.2 5901.0 5619.4 5864.6 5959.0 5966.9 5985.4 5869.4 5971.1 5980.1 5986.5 6012.5 5485.4 5520.8 5557.1 5576.4 5587.5 12638.8 13360.9 13500.6 13520.7 13524.2 2013.8 2035.6 2091.7 2121.5 2174.9 8817.8 9218.8 9937.5 12938.1 13624.1 1754.9 1755.2 1763.2 1767.7 1781.1 117644.0 118715.4 119570.6 120669.4 121276.0 8056.0 11670.5 11710.9 11820.3 11880.8 12277.3 14833.7 14870.6 14897.6 14923.3 8544.3 8605.4 8734.3 8736.8 8795.0 8504.0 8526.9 8545.1 8578.5 8606.2 4300.5 4560.8 4627.6 4659.4 4718.3 1865.3 1990.3 2006.4 2008.1 2029.1 905.6 978.2 1011.9 1032.8 1069.8 15965.6 20067.8 20363.0 20520.5 20551.6 829.5 855.4 944.7 966.9 991.5 10429.6 10712.9 10830.9 10854.0 10860.9 513698.0 598518.0 602404.0 622401.0 624810.9 104935.0 116026.0 116286.0 121354.4 124627.0 1001.4 1007.7 1026.0 1038.9 1041.6 17846.0 18004.0 18151.7 18165.2 18534.4 38974.8 44444.0 47280.3 48783.5 48857.0 74579.0 74891.6 75017.6 76110.6 76586.1 7919.1 8065.0 8129.7 8148.8 8356.3 11518.7 11732.1 11747.5 12189.9 12621.6 10445.4 10764.9 10889.8 11126.8 11177.1 8909.1 8910.8 10603.9 10739.0 10996.9 8591.1 8838.2 10586.6 11101.2 11519.6 6722.4 7099.6 7579.5 7979.5 8316.6 8193.5 10109.3 10607.6 10782.9 10912.4 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:5605.81 Median:5224.83 stddev:3094.91 (59.2%) stddev-sans-first:3087.11 03:54:33 INFO - PROCESS | 1682 | Values: 1356.5 1360.3 1594.7 1856.2 1938.9 7963.7 8514.4 8539.5 8778.0 8782.1 8505.0 8575.6 8620.4 8643.4 8664.2 2350.6 2358.2 2375.8 2382.9 2383.6 2318.0 2318.9 2328.7 2330.5 2363.0 1861.0 2310.6 2349.4 2371.9 2383.1 2314.6 2321.5 2330.4 2336.3 2356.8 2331.1 2334.5 2335.1 2344.5 2348.5 7546.5 8309.7 8676.7 8747.6 8783.0 5168.4 5281.2 5346.2 5358.6 5375.5 3473.4 3500.1 3577.5 3587.0 3645.7 1026.6 1037.6 1048.3 1048.9 1057.6 11480.9 11500.7 11574.5 11576.2 11590.4 4687.7 4739.8 4883.1 4898.7 4914.8 9828.3 9868.0 9934.9 9946.6 9966.9 5311.0 5340.8 5351.5 5356.6 5434.2 4391.2 4725.2 4892.0 4903.9 4936.5 3948.7 3987.4 4015.4 4037.7 4156.4 1350.8 1357.3 1372.3 1384.1 1384.5 832.0 849.0 908.6 921.3 930.3 5538.3 5676.8 5766.3 5846.2 5987.2 971.3 973.2 979.9 991.2 1036.2 3725.2 3939.9 3972.4 3973.7 3992.8 10083.2 10542.8 10557.0 10568.6 10657.3 9105.8 9387.0 9921.3 10504.5 10562.2 7277.0 7822.8 7991.5 8039.0 8262.8 4094.9 5572.5 5881.6 5906.6 5930.0 9626.0 9648.2 9886.0 9940.3 9978.3 8148.8 9805.9 9820.3 9944.4 10091.1 5981.4 6684.9 7411.6 7426.0 7467.3 8163.1 8238.2 8248.0 8299.7 8308.8 6154.8 7262.6 7418.3 7519.2 7578.7 7236.2 7302.4 7355.3 7364.5 7410.8 6967.3 6989.1 7036.5 7079.2 7080.8 4842.6 4887.9 4913.4 4936.5 5124.0 4755.0 4844.8 4873.8 4931.7 5125.5 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:5229.22 Median:5919.12 stddev:1651.62 (27.9%) stddev-sans-first:1614.54 03:54:33 INFO - PROCESS | 1682 | Values: 314.9 320.0 328.1 330.9 331.1 5659.7 5889.1 6117.1 6130.0 6176.3 5044.8 6058.2 6127.4 6138.2 6174.2 4538.9 4550.5 4552.8 4556.2 4589.1 4374.4 4468.7 4536.9 4547.2 4557.9 3611.7 4439.9 4455.8 4476.2 4492.9 4222.2 4456.7 4497.2 4498.7 4516.4 3719.4 3798.1 3833.0 3846.7 3856.4 5829.5 5885.1 5889.6 5893.0 5898.5 5196.7 5203.5 5214.7 5221.4 5225.0 5335.2 6039.1 6294.0 6481.4 6544.8 3329.8 4225.2 4256.2 4273.6 4276.6 4594.6 6351.5 6613.8 6649.7 6908.6 3832.1 4327.5 4458.5 4499.2 4502.4 3839.6 4590.3 4601.3 4615.8 4619.2 5087.8 5143.6 5334.5 5375.2 5391.2 5476.5 6014.2 6460.4 6485.8 6523.5 1178.9 1295.6 1461.0 1567.8 1573.9 958.9 966.0 1008.4 1044.7 1065.8 5974.3 6041.4 6054.8 6057.0 6124.4 6354.3 6683.6 6732.9 6742.2 6754.5 5824.9 5953.6 6035.2 6065.9 6079.5 2807.6 3458.2 3508.5 3535.2 3561.6 6569.4 6798.1 6989.2 7005.3 7065.2 6451.6 6813.6 6848.6 6851.4 6861.7 5789.6 6173.3 6654.3 6839.9 7032.8 6607.4 6627.7 6646.2 6680.3 6697.6 6064.0 6544.4 6566.3 6576.6 6577.6 5773.5 6294.7 6336.7 6925.9 6951.3 3804.8 4506.2 4519.5 4542.0 4567.3 5877.4 6145.8 6477.8 6625.1 6703.6 5792.8 5974.3 6483.9 6484.6 6501.1 6164.6 6182.3 6462.5 6541.7 6649.4 6473.2 6497.5 6515.9 6541.6 6595.6 6149.9 6598.5 6629.4 6629.6 6642.9 5291.5 5760.9 5939.7 6438.2 6520.9 03:54:33 INFO - PROCESS | 1682 | 03:54:33 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:17414.69 Median:3475.02 stddev:24631.30 (708.8%) stddev-sans-first:24668.25 03:54:33 INFO - PROCESS | 1682 | Values: 655.1 658.4 660.4 662.5 767.2 12179.7 12598.6 14922.2 15119.5 15348.0 14180.8 14246.1 14263.2 14288.5 14301.9 717.0 900.3 917.2 918.1 922.2 817.5 881.2 900.0 911.6 915.5 934.9 946.6 953.1 961.3 963.4 919.1 926.2 938.7 953.5 957.1 689.3 707.9 712.7 716.5 717.0 14966.8 15060.8 15233.2 15235.5 15261.4 12795.2 12844.7 12887.1 12898.0 12900.9 10005.7 10072.9 10211.9 10365.2 10489.6 3461.7 3516.9 3525.4 3526.2 3533.9 73641.5 81424.8 82096.2 83296.6 83361.0 8002.6 8487.3 9112.5 9137.0 9313.9 19684.1 19691.3 19720.6 20625.5 21346.4 7626.0 7633.8 7905.0 7961.8 8000.2 4064.3 4076.6 4130.5 4148.5 4163.3 3545.1 3637.4 3640.4 3640.5 3644.1 631.9 637.6 644.9 656.3 656.9 557.7 581.7 596.6 610.6 622.9 7715.6 7770.9 7914.2 8197.8 8222.8 450.9 507.6 537.7 590.1 608.4 3619.5 3873.2 3903.1 3924.8 3932.8 87223.0 88112.0 88777.6 89848.0 89868.6 75217.6 76998.0 77368.6 77451.0 77722.0 52000.2 66329.3 68251.0 69218.3 69826.0 5803.9 6318.2 7584.4 7755.0 7799.5 33450.2 34550.5 43721.6 43913.8 44584.3 62622.7 63401.4 63426.7 63783.0 63876.0 9890.7 10044.7 10146.6 10262.5 10394.3 11132.3 11175.6 11189.9 11335.8 11365.2 8334.5 8567.5 10204.2 10257.6 10838.6 10348.6 10698.1 10760.8 10870.8 10890.9 10237.3 10535.5 11091.7 11165.9 11469.7 8043.9 9452.7 9535.4 9811.5 9813.5 9417.4 9552.9 9574.4 9603.2 9658.9 03:54:33 INFO - PROCESS | 1682 | -------- Summary: end -------- 03:54:33 INFO - PROCESS | 1682 | 03:54:34 INFO - TEST-INFO | 1682: exit 0 03:54:34 INFO - TEST-OK | dromaeo_css | took 1112143ms 03:54:34 INFO - TEST-START | kraken 03:54:34 INFO - operating with platform_type : mac_ 03:54:34 INFO - Initialising browser for kraken test... 03:54:34 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpQzoVte/profile http://localhost:49275/getInfo.html) 03:54:36 INFO - PROCESS | 1697 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 03:54:36 INFO - PROCESS | 1697 | __metrics Screen width/height:1600/1200 03:54:36 INFO - PROCESS | 1697 | colorDepth:24 03:54:36 INFO - PROCESS | 1697 | Browser inner width/height: 1024/689 03:54:36 INFO - PROCESS | 1697 | __metrics 03:54:36 ERROR - PROCESS | 1697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:54:37 INFO - TEST-INFO | 1697: exit 0 03:54:37 INFO - Browser initialized. 03:54:37 INFO - Running cycle 1/1 for kraken test... 03:54:37 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpQzoVte/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:49 INFO - PROCESS | 1700 | RSS: Main: 247459840 03:54:49 INFO - PROCESS | 1700 | 03:54:52 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:53 INFO - PROCESS | 1700 | RSS: Main: 259571712 03:54:53 INFO - PROCESS | 1700 | 03:54:55 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:54:56 INFO - PROCESS | 1700 | RSS: Main: 268464128 03:54:56 INFO - PROCESS | 1700 | 03:54:59 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:55:00 INFO - PROCESS | 1700 | RSS: Main: 271671296 03:55:00 INFO - PROCESS | 1700 | 03:55:02 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:55:03 INFO - PROCESS | 1700 | RSS: Main: 272482304 03:55:03 INFO - PROCESS | 1700 | 03:55:05 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:06 INFO - PROCESS | 1700 | RSS: Main: 273010688 03:55:06 INFO - PROCESS | 1700 | 03:55:08 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:09 INFO - PROCESS | 1700 | RSS: Main: 273768448 03:55:09 INFO - PROCESS | 1700 | 03:55:12 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:13 INFO - PROCESS | 1700 | RSS: Main: 273960960 03:55:13 INFO - PROCESS | 1700 | 03:55:16 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:55:16 INFO - PROCESS | 1700 | RSS: Main: 274104320 03:55:16 INFO - PROCESS | 1700 | 03:55:18 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:19 INFO - PROCESS | 1700 | RSS: Main: 273920000 03:55:19 INFO - PROCESS | 1700 | 03:55:20 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:21 INFO - PROCESS | 1700 | RSS: Main: 273448960 03:55:21 INFO - PROCESS | 1700 | 03:55:23 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:24 INFO - PROCESS | 1700 | RSS: Main: 275042304 03:55:24 INFO - PROCESS | 1700 | 03:55:27 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:28 INFO - PROCESS | 1700 | RSS: Main: 274984960 03:55:28 INFO - PROCESS | 1700 | 03:55:31 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:31 INFO - PROCESS | 1700 | RSS: Main: 274939904 03:55:31 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:55:33 INFO - PROCESS | 1700 | RSS: Main: 276320256 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | __start_tp_report 03:55:33 INFO - PROCESS | 1700 | _x_x_mozilla_page_load 03:55:33 INFO - PROCESS | 1700 | _x_x_mozilla_page_load_details 03:55:33 INFO - PROCESS | 1700 | |i|pagename|runs| 03:55:33 INFO - PROCESS | 1700 | |0;ai-astar;132;158;164;115;115;125;114;117;114;114 03:55:33 INFO - PROCESS | 1700 | |1;audio-beat-detection;155;127;144;165;123;141;139;122;170;130 03:55:33 INFO - PROCESS | 1700 | |2;audio-dft;200;199;211;229;208;204;254;196;201;199 03:55:33 INFO - PROCESS | 1700 | |3;audio-fft;72;86;66;169;73;78;87;96;134;58 03:55:33 INFO - PROCESS | 1700 | |4;audio-oscillator;83;115;163;118;83;86;149;65;110;162 03:55:33 INFO - PROCESS | 1700 | |5;imaging-gaussian-blur;89;86;88;85;89;85;89;88;77;131 03:55:33 INFO - PROCESS | 1700 | |6;imaging-darkroom;95;96;96;107;97;100;149;97;95;95 03:55:33 INFO - PROCESS | 1700 | |7;imaging-desaturate;152;77;98;151;144;121;94;126;155;93 03:55:33 INFO - PROCESS | 1700 | |8;json-parse-financial;60;63;61;63;61;61;61;77;62;60 03:55:33 INFO - PROCESS | 1700 | |9;json-stringify-tinderbox;65;70;71;68;81;74;72;68;67;67 03:55:33 INFO - PROCESS | 1700 | |10;stanford-crypto-aes;106;116;122;86;87;88;90;88;89;86 03:55:33 INFO - PROCESS | 1700 | |11;stanford-crypto-ccm;148;159;172;169;188;177;150;150;203;188 03:55:33 INFO - PROCESS | 1700 | |12;stanford-crypto-pbkdf2;173;169;164;173;175;174;173;174;174;172 03:55:33 INFO - PROCESS | 1700 | |13;stanford-crypto-sha256-iterative;70;66;72;69;70;71;80;103;82;71 03:55:33 INFO - PROCESS | 1700 | __end_tp_report 03:55:33 INFO - PROCESS | 1700 | __start_cc_report 03:55:33 INFO - PROCESS | 1700 | _x_x_mozilla_cycle_collect,988 03:55:33 INFO - PROCESS | 1700 | __end_cc_report 03:55:33 INFO - PROCESS | 1700 | __startTimestamp1460717733778__endTimestamp 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | ------- Summary: start ------- 03:55:33 INFO - PROCESS | 1700 | Number of tests: 14 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#0] ai-astar Cycles:10 Average:126.80 Median:121.00 stddev:19.01 (15.7%) stddev-sans-first:20.07 03:55:33 INFO - PROCESS | 1700 | Values: 132.0 158.0 164.0 115.0 115.0 125.0 114.0 117.0 114.0 114.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:142.50 stddev:17.08 (12.0%) stddev-sans-first:17.41 03:55:33 INFO - PROCESS | 1700 | Values: 155.0 127.0 144.0 165.0 123.0 141.0 139.0 122.0 170.0 130.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#2] audio-dft Cycles:10 Average:210.10 Median:206.00 stddev:18.13 (8.8%) stddev-sans-first:18.85 03:55:33 INFO - PROCESS | 1700 | Values: 200.0 199.0 211.0 229.0 208.0 204.0 254.0 196.0 201.0 199.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.50 stddev:34.25 (45.4%) stddev-sans-first:35.56 03:55:33 INFO - PROCESS | 1700 | Values: 72.0 86.0 66.0 169.0 73.0 78.0 87.0 96.0 134.0 58.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#4] audio-oscillator Cycles:10 Average:113.40 Median:114.00 stddev:35.07 (30.8%) stddev-sans-first:35.43 03:55:33 INFO - PROCESS | 1700 | Values: 83.0 115.0 163.0 118.0 83.0 86.0 149.0 65.0 110.0 162.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:88.00 stddev:14.61 (16.6%) stddev-sans-first:15.49 03:55:33 INFO - PROCESS | 1700 | Values: 89.0 86.0 88.0 85.0 89.0 85.0 89.0 88.0 77.0 131.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:95.50 stddev:16.67 (17.5%) stddev-sans-first:17.45 03:55:33 INFO - PROCESS | 1700 | Values: 95.0 96.0 96.0 107.0 97.0 100.0 149.0 97.0 95.0 95.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#7] imaging-desaturate Cycles:10 Average:121.10 Median:116.00 stddev:28.96 (25.0%) stddev-sans-first:28.48 03:55:33 INFO - PROCESS | 1700 | Values: 152.0 77.0 98.0 151.0 144.0 121.0 94.0 126.0 155.0 93.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:61.50 stddev:5.07 (8.2%) stddev-sans-first:5.26 03:55:33 INFO - PROCESS | 1700 | Values: 60.0 63.0 61.0 63.0 61.0 61.0 61.0 77.0 62.0 60.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:4.62 (6.6%) stddev-sans-first:4.48 03:55:33 INFO - PROCESS | 1700 | Values: 65.0 70.0 71.0 68.0 81.0 74.0 72.0 68.0 67.0 67.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:87.50 stddev:13.62 (15.6%) stddev-sans-first:13.94 03:55:33 INFO - PROCESS | 1700 | Values: 106.0 116.0 122.0 86.0 87.0 88.0 90.0 88.0 89.0 86.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:170.40 Median:174.50 stddev:18.84 (10.8%) stddev-sans-first:18.16 03:55:33 INFO - PROCESS | 1700 | Values: 148.0 159.0 172.0 169.0 188.0 177.0 150.0 150.0 203.0 188.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.50 stddev:3.28 (1.9%) stddev-sans-first:3.46 03:55:33 INFO - PROCESS | 1700 | Values: 173.0 169.0 164.0 173.0 175.0 174.0 173.0 174.0 174.0 172.0 03:55:33 INFO - PROCESS | 1700 | 03:55:33 INFO - PROCESS | 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:71.00 stddev:10.88 (15.3%) stddev-sans-first:11.36 03:55:33 INFO - PROCESS | 1700 | Values: 70.0 66.0 72.0 69.0 70.0 71.0 80.0 103.0 82.0 71.0 03:55:33 INFO - PROCESS | 1700 | -------- Summary: end -------- 03:55:33 INFO - PROCESS | 1700 | 03:55:34 INFO - TEST-INFO | 1700: exit 0 03:55:34 INFO - TEST-OK | kraken | took 60408ms 03:55:34 INFO - SUITE-END | took 1172s 03:55:34 INFO - Completed test suite (00:19:32) 03:55:34 INFO - javascript benchmark 03:55:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3204.423203823311, 3217.8873739419123, 3430.5025771263176, 3517.6482351764844, 3520.80635565044, 4727.716337019772, 5766.961946849566, 5805.564582656297, 5834.56240781941, 5839.270091238595, 4163.292240319145, 5392.46314800282, 5778.0, 5813.157092221625, 5920.259967504062, 4229.259879521087, 5203.115470370037, 5267.499587539178, 5283.339582552181, 5337.919931201035, 5263.86840328991, 5326.813561525348, 5357.571394288448, 5371.81198658047, 5428.267183930158, 4207.410962465257, 5173.224016397533, 5209.791608335662, 5220.947790522084, 5295.894082118336, 5254.789808407659, 5274.182501712203, 5277.9971805357245, 5298.470152984709, 5313.38896026958, 4412.602865742067, 5207.687538747649, 5244.906589716132, 5267.499587539178, 5273.683578985273, 5017.523335283142, 5445.910817836409, 5651.4913657770585, 5666.603337766358, 5714.371419143891, 5085.593152547787, 6231.6572588507615, 6233.0, 6291.559590828644, 6295.842603934892, 5332.733363331857, 6137.438273608336, 6273.309935907047, 6281.183446151971, 6286.559940804145, 5865.794697185578, 5882.0, 5888.087346461305, 5895.734691938873, 5900.881982360329, 6307.148534947723, 6351.396617321347, 6374.9681251594375, 6385.0, 6388.872222555523, 6092.573519853657, 6104.337893874325, 6209.844753881189, 6228.439440450381, 6246.437820596168, 5675.836453527099, 5796.21751063601, 6250.531210159256, 6263.404976527223, 6299.212598425197, 6012.969935150296, 6176.567640265138, 6267.905981410283, 6271.404216599416, 6294.937050629526, 6117.918752924011, 6150.907736383958, 6184.721687524072, 6209.658468784261, 6255.468285195719, 4961.305417241589, 4976.42771081323, 4986.501349864984, 4999.200127979506, 5026.321446604735, 4436.534163912807, 4459.308807134899, 4479.238529450001, 4493.662975276868, 4515.7290562565695, 5630.183623374588, 5796.304443466726, 5864.882702345929, 5891.027980383275, 5910.408959104056, 6225.159603453566, 6252.124702541648, 6253.593516421418, 6283.842903927347, 6299.937000629935, 5885.588008839341, 5907.7046147692445, 5908.113782932509, 5925.822225333247, 5962.165296858443, 5374.408815030343, 5415.48552887475, 5480.6437581557075, 5491.2312276281355, 5509.090999985037, 6468.6442245676935, 6490.96754516215, 6491.318411566717, 6495.577787443801, 6506.479481641552, 6144.880016394337, 6263.029230469285, 6278.15244941927, 6291.402316779899, 6294.968525157528, 5021.6735912165595, 6342.460890824332, 6389.2652344980925, 6509.641969691713, 6512.967435162794, 5583.972080139573, 6194.659293738708, 6284.120223168851, 6288.119663247057, 6305.716242769178, 6155.984262596621, 6174.44430001302, 6252.205418246619, 6296.811095667137, 6299.370062993848, 5335.413104558418, 6010.248718910137, 6148.262208535004, 6197.194364732556, 6261.78083767066, 5370.516653501204, 5395.81114660985, 5831.0, 6196.969015154896, 6231.4391704746795, 5926.644401335933, 6001.189839371804, 6104.908426373697, 6119.173911521888, 6123.081537769192, 6107.917136653054, 6115.327313995546, 6124.601900876429, 6133.756626433956, 6186.690665466798, 4966.503349665005, 6017.488513476404, 6049.909251361145, 6054.3340232575265, 6077.574569780073], "value": 5675.744732848116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.7758197602066, 516.1432022842083, 529.5869222006834, 538.4911258860377, 600.2197143713172, 36280.0, 36473.63526364739, 37064.629353706456, 37103.62896371039, 37242.441363379505, 39039.82880513582, 39697.40453893186, 39724.40413393794, 39852.0, 39878.80060599693, 9287.907120928789, 9426.670066547673, 9489.857652135224, 9500.762480937998, 9536.952315238414, 9359.906400936006, 9419.387739796926, 9428.905710942905, 9432.764180895498, 9483.05169483053, 8177.427580069398, 9413.058694130601, 9418.717438476857, 9469.479178645171, 9486.762830929212, 9355.391899526508, 9439.19766819821, 9445.0, 9487.762805929839, 9517.191038761714, 9204.631814727403, 9221.907780922173, 9226.215771659417, 9254.537273136317, 9311.44131352121, 32078.0, 37336.626633733584, 37543.0, 37565.62434375676, 38005.0, 2966.0656893078612, 2993.5060714982, 3099.7520198384077, 3181.6659250778566, 3474.2183008823067, 27934.44131117366, 28683.85658071696, 29314.85342573295, 29374.412511749644, 29382.85308573465, 2717.850518221497, 2721.9183424497296, 2752.215618548704, 2780.958285625717, 2837.730415610514, 419895.0, 420753.0, 425662.9999999969, 426676.0, 426817.0, 34727.9581612552, 58139.70930145322, 61535.38464615386, 62303.376966230666, 62350.44123896939, 31071.0, 31177.532337014964, 31380.0, 31500.212494687818, 31580.842095789372, 14927.0, 15014.399424022917, 15020.474283400028, 15139.54581362561, 15166.469173578871, 11244.437778111225, 12423.751524969632, 12729.618111456672, 12830.935845320713, 12839.422225999666, 7888.723894663659, 7897.842043159105, 7920.089189743253, 8054.114047454776, 8099.838003239902, 3312.8343582821244, 3338.5159151922835, 3354.580677415323, 3374.207061340583, 3386.5766779152605, 983.4099540275778, 991.9156871665989, 992.2211064314479, 1004.6031817432073, 1117.9608713694981, 24187.637185442232, 24408.755912441004, 29153.56269655957, 29995.400091998476, 30520.0, 936.7564433247405, 1086.266769930294, 1126.5143123941364, 1203.711109333771, 1268.9111762176558, 15289.770653440208, 15446.613834654223, 15448.150351730763, 15677.0, 15768.817338699413, 501138.0, 599277.0, 630625.6937430659, 631380.0, 637336.0, 57521.71239143777, 59498.70250648719, 59651.80696386048, 59673.40326596679, 60860.0, 1147.8909503597145, 1401.7546929287334, 1438.0, 1490.2250829568563, 1494.1931357067278, 29266.0, 29279.853600732713, 29605.555916660836, 29796.702032979392, 30062.69937300599, 49609.50390496049, 49617.255741163186, 50062.0, 50411.0, 50607.0, 555950.0, 564719.0, 567681.0, 570727.0, 571623.0, 26200.8689956549, 26396.868015660566, 26433.73566264313, 26664.333391665365, 27036.324091897073, 45879.0, 46248.768756156, 46272.0, 46690.766546167055, 47072.293915590606, 36480.81759591185, 37360.87917362483, 37943.62056379511, 38225.23549528938, 38466.0383490415, 36928.815355924125, 37023.75259046626, 37491.62508374881, 37494.812525937195, 38141.237175256894, 37063.81468092642, 37992.0, 38110.42834357431, 38850.0, 39057.6094239054, 29857.0, 31460.89886853949, 31851.522227167075, 31853.0, 32122.35755284928, 23936.162234321717, 24354.878225609467, 24543.877280613484, 24757.62863557084, 24871.75128248767], "value": 18130.854071280653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.108940526195, 395.19183270212415, 401.61244399154816, 402.4144869215292, 408.5036680433273, 14122.293885305719, 19801.603967920633, 20510.692339614918, 20537.0, 20573.69139462909, 19705.704414433796, 19858.205671773147, 20259.898700506477, 20386.286479973205, 20665.690014649794, 5765.913511297334, 5875.88248235035, 5890.499307558863, 5911.822645320647, 5925.170476133345, 5764.020116580192, 5773.134029895528, 5849.415058494138, 5867.237259156325, 5901.026330655437, 5619.381867994517, 5864.618799778001, 5959.0, 5966.910496342558, 5985.401459854023, 5869.354371019184, 5971.104334349839, 5980.13288073227, 5986.521078313746, 6012.488938440238, 5485.396606373336, 5520.834374968757, 5557.138643510262, 5576.358718747356, 5587.525060369833, 12638.810417843739, 13360.933195334059, 13500.594982150453, 13520.729585408237, 13524.188548687012, 2013.7684166320914, 2035.5928814237063, 2091.7176181215495, 2121.487034803155, 2174.8912554372378, 8817.779555511099, 9218.847644044494, 9937.503124843728, 12938.094333396666, 13624.114432561952, 1754.921028553718, 1755.1926113987581, 1763.215369160724, 1767.6641438126844, 1781.0649409060218, 117644.0, 118715.40642296734, 119570.60858782775, 120669.39665301704, 121276.0, 8055.993000874891, 11670.474828632732, 11710.941445292889, 11820.345151678772, 11880.821787673192, 12277.263364198177, 14833.664970152522, 14870.628234294012, 14897.553073407815, 14923.253837308092, 8544.31645468361, 8605.397622166389, 8734.301255899512, 8736.825263494822, 8794.956025219833, 8504.0, 8526.914730852612, 8545.102764209792, 8578.528180949983, 8606.225439710332, 4300.505441874225, 4560.8175672973375, 4627.606653434428, 4659.370984917061, 4718.292256161603, 1865.3191585071352, 1990.3224681194672, 2006.4081096076693, 2008.096356639489, 2029.0564887327464, 905.62869223618, 978.1832170138015, 1011.9139873110721, 1032.7779527401494, 1069.7860427914293, 15965.563099321116, 20067.799322006886, 20362.981850907396, 20520.486987825425, 20551.58896822085, 829.4525613095328, 855.362754747717, 944.7354740672623, 966.8888077870994, 991.5240684471494, 10429.5828166874, 10712.892871071346, 10830.945845270724, 10854.023137917626, 10860.891391086147, 513698.0, 598518.0, 602404.0, 622401.0, 624810.8759456173, 104935.0, 116026.0, 116286.0, 121354.39322803506, 124627.0, 1001.3691374434205, 1007.7027276953316, 1025.9897401026044, 1038.8909164537765, 1041.6198087698087, 17846.01846898433, 18004.009779461732, 18151.727724084412, 18165.18256678479, 18534.351297704514, 38974.80512597419, 44444.0, 47280.29079563878, 48783.512164879314, 48857.02285954332, 74578.99197367679, 74891.62554187194, 75017.62491187509, 76110.6194469024, 76586.10725034773, 7919.0893047298, 8065.0, 8129.674813007414, 8148.83702325962, 8356.289715374262, 11518.654440366803, 11732.061435085343, 11747.530098795953, 12189.878101218874, 12621.558245461365, 10445.373277603368, 10764.946175269073, 10889.836652450062, 11126.833097503706, 11177.105831533296, 8909.109089091038, 8910.777230569287, 10603.89396106029, 10738.97979691928, 10996.890031099907, 8591.097934717014, 8838.160374764388, 10586.629467968583, 11101.16741244426, 11519.596814111466, 6722.428593569406, 7099.645017749195, 7579.54522728638, 7979.521228726295, 8316.589412537081, 8193.50838949665, 10109.292349535463, 10607.628732994308, 10782.892171078189, 10912.399818010086], "value": 9195.458296365001, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.4913157565916, 1360.2994457854204, 1594.6730920161367, 1856.2482194711138, 1938.922443102276, 7963.681452741884, 8514.403991720583, 8539.530325832076, 8778.034416214212, 8782.077881822412, 8505.0, 8575.571221438919, 8620.439671421369, 8643.351748618847, 8664.176903194186, 2350.6239001759723, 2358.2099996501192, 2375.7861792438675, 2382.8927698253533, 2383.6067048936907, 2318.0380142241033, 2318.8840557972117, 2328.662343960125, 2330.463993281546, 2362.976370236293, 1860.990695046523, 2310.595645761993, 2349.4009027698, 2371.9169829055986, 2383.0944241188413, 2314.6065168921323, 2321.5124823787023, 2330.4290448839974, 2336.275754516097, 2356.7643235676464, 2331.137479132715, 2334.498082912165, 2335.089315167086, 2344.5076533927895, 2348.5420343033115, 7546.547207167532, 8309.709160179365, 8676.739697809076, 8747.606357713918, 8783.033866274705, 5168.4314725380555, 5281.234221037967, 5346.198070289449, 5358.5981051421295, 5375.543078838304, 3473.426884564069, 3500.1249687578106, 3577.481265216555, 3587.0494319005484, 3645.7083433325533, 1026.5534492495713, 1037.6005237983354, 1048.3185929146116, 1048.8951104889527, 1057.5981127171704, 11480.942595287053, 11500.654980350602, 11574.53701851925, 11576.189666723332, 11590.362530060844, 4687.671862969628, 4739.786709598076, 4883.072216278895, 4898.681585696918, 4914.754262286871, 9828.262880284008, 9868.013198680075, 9934.907160212371, 9946.552405141785, 9966.850497242547, 5311.0, 5340.813071542478, 5351.491608297206, 5356.5982551308025, 5434.157705555566, 4391.209582275221, 4725.220338644154, 4891.951080489221, 4903.926441103386, 4936.531029552187, 3948.6841052715713, 3987.3620220764537, 4015.3976903464713, 4037.6567991720444, 4156.43888075112, 1350.8311461067367, 1357.260293140241, 1372.28641106624, 1384.1003347823994, 1384.5431007767413, 832.0, 848.9685032685194, 908.6002159049997, 921.2583869984727, 930.3022732950287, 5538.335399751975, 5676.801311954062, 5766.250387449605, 5846.1523079153285, 5987.161797348374, 971.3394891473865, 973.2457345557108, 979.8922118566952, 991.1575161113141, 1036.2176556699794, 3725.161838586296, 3939.901502462404, 3972.3842804365368, 3973.7019723520852, 3992.782086814357, 10083.19334453242, 10542.841857372145, 10557.0, 10568.577256909637, 10657.307275027099, 9105.81788364229, 9387.014363491735, 9921.255905807093, 10504.474776261157, 10562.155027597773, 7277.017602623684, 7822.765317040498, 7991.520508769492, 8039.0, 8262.793430164174, 4094.877153685394, 5572.4706152915405, 5881.647101173943, 5906.645601263766, 5929.970350148222, 9626.0, 9648.179904707898, 9886.0, 9940.254480914105, 9978.301518893608, 8148.796280092808, 9805.901940980499, 9820.263480239153, 9944.35361701487, 10091.142252908585, 5981.431763982415, 6684.933150668626, 7411.5553066816165, 7425.9628701856145, 7467.327940485382, 8163.102058773649, 8238.217369349903, 8247.9587602064, 8299.709510167115, 8308.792280193044, 6154.846128846814, 7262.600556969417, 7418.295261950106, 7519.1728909818785, 7578.658960346687, 7236.20401755817, 7302.3792977597495, 7355.264473552602, 7364.521306115085, 7410.777676669709, 6967.303269672992, 6989.091418115612, 7036.472264580075, 7079.22128565847, 7080.752173673896, 4842.6368022397755, 4887.926681099858, 4913.385826771653, 4936.456989731055, 5123.974380128076, 4754.97767979886, 4844.806207751651, 4873.780679869344, 4931.679440836334, 5125.461826508312], "value": 4540.375854262492, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9370125974804, 320.0, 328.09773123909247, 330.92057906102514, 331.06474210355736, 5659.660420374776, 5889.083759300061, 6117.113018612298, 6130.019196928492, 6176.258848938122, 5044.84865454036, 6058.242719660043, 6127.448529632332, 6138.202033735608, 6174.228221472316, 4538.863834084975, 4550.49944506104, 4552.84065057723, 4556.179887620227, 4589.128065667529, 4374.365716971038, 4468.687191896569, 4536.888462326718, 4547.204239258117, 4557.908841823161, 3611.693006094485, 4439.889002774924, 4455.754933478657, 4476.216662084138, 4492.887677808065, 4222.23999680059, 4456.732596044248, 4497.168023915586, 4498.730076195422, 4516.435445569304, 3719.3863012602887, 3798.088458769903, 3833.0, 3846.6922646188236, 3856.382978723419, 5829.504492118175, 5885.146653735227, 5889.646621202742, 5892.970535147297, 5898.528117750612, 5196.68819870809, 5203.505666961632, 5214.739263036833, 5221.399539052982, 5224.9738751306, 5335.226392173152, 6039.063945088518, 6293.968530157365, 6481.384268494486, 6544.770933017321, 3329.7502687298547, 4225.197212529641, 4256.2338779019765, 4273.615374616299, 4276.615104640566, 4594.632429405639, 6351.491880649537, 6613.801585952381, 6649.667516624198, 6908.585484870873, 3832.080300727861, 4327.49005576771, 4458.5318541553315, 4499.235130027903, 4502.3921770560555, 3839.577646458887, 4590.288505281686, 4601.309803529497, 4615.815367385334, 4619.214733495247, 5087.77714496974, 5143.588512918957, 5334.546563542142, 5375.220593014069, 5391.245225668409, 5476.534494567926, 6014.1580178775, 6460.353964603502, 6485.77299794505, 6523.543351965317, 1178.8997935175605, 1295.5724610878387, 1461.0, 1567.788348572928, 1573.944911928077, 958.9232861371073, 965.9855102173473, 1008.4201584089031, 1044.6918159143072, 1065.8382363224123, 5974.3428222895445, 6041.368830415763, 6054.848628784228, 6057.000594901792, 6124.38756124384, 6354.3010268870385, 6683.598984060972, 6732.899006514906, 6742.190937087483, 6754.493412994045, 5824.912626310609, 5953.613015154001, 6035.245594300713, 6065.877812604682, 6079.483243924316, 2807.5507918732906, 3458.239187378773, 3508.456189290613, 3535.169235229719, 3561.5726112866105, 6569.37590928861, 6798.116244888231, 6989.231184569693, 7005.264447233069, 7065.2228254891925, 6451.612903225821, 6813.591184528944, 6848.609938080682, 6851.38337549613, 6861.725530978705, 5789.565782566325, 6173.32093469718, 6654.26803051664, 6839.89740153908, 7032.753853615099, 6607.372299631527, 6627.701753421011, 6646.235682896336, 6680.265170831108, 6697.598144111369, 6063.975537596989, 6544.3782840630065, 6566.343365663395, 6576.599541167535, 6577.632052461206, 5773.480386765212, 6294.6852657366035, 6336.7148478319505, 6925.861482770216, 6951.296932251631, 3804.752691075071, 4506.211413002646, 4519.457665080211, 4541.977290113528, 4567.2920697291975, 5877.382874798084, 6145.846353841011, 6477.77327793525, 6625.072489851521, 6703.597784132968, 5792.797252096157, 5974.342822289632, 6483.870322593616, 6484.578502397329, 6501.05734668461, 6164.612962083495, 6182.289036760651, 6462.450691691259, 6541.70562324706, 6649.434798042221, 6473.155150782005, 6497.5126865484335, 6515.934840651533, 6541.6402097885075, 6595.637239951849, 6149.938500615115, 6598.472122230306, 6629.403353698191, 6629.569078009914, 6642.900356494753, 5291.497307755757, 5760.855978600569, 5939.703014849327, 6438.227412710505, 6520.934790652223], "value": 4688.23155266625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.09367739877, 658.3811217455591, 660.4155322539552, 662.5064327076329, 767.1637914673005, 12179.695507612314, 12598.559050433236, 14922.179280139588, 15119.546413607595, 15348.0, 14180.787288190686, 14246.074005189656, 14263.21552314625, 14288.499902503414, 14301.856981430183, 716.985660286794, 900.3427497926517, 917.2478567574592, 918.0635751533432, 922.2391526990226, 817.5013241922422, 881.1761003461752, 899.9685011024616, 911.6080085563206, 915.514777168102, 934.8784657994452, 946.564580293066, 953.0850383631722, 961.3318743473288, 963.3930623707055, 919.0717375450776, 926.2312280806914, 938.7043081429362, 953.5327689432163, 957.1194501059042, 689.3279052923409, 707.8655055539482, 712.7149140343852, 716.5306724095726, 717.0069453806516, 14966.775498367533, 15060.774088388684, 15233.238338083162, 15235.466758663393, 15261.38954441821, 12795.232286062866, 12844.743105137844, 12887.097903146783, 12898.0, 12900.935495322557, 10005.699829005142, 10072.94963525185, 10211.948940255252, 10365.170786337076, 10489.632862849763, 3461.6884480396634, 3516.8769093081874, 3525.4359302511475, 3526.1889765354113, 3533.9293214135573, 73641.52716945631, 81424.82189726284, 82096.17903820945, 83296.58351708263, 83361.0, 8002.634612218028, 8487.321014318839, 9112.544372781334, 9136.95431522838, 9313.90686093144, 19684.114214860365, 19691.310804121786, 19720.605587888163, 20625.484362890747, 21346.359609211748, 7626.0, 7633.809154771176, 7905.0, 7961.8407631848195, 8000.159983201796, 4064.288749468831, 4076.5515793262716, 4130.545639979599, 4148.543660197376, 4163.292240319153, 3545.096000519851, 3637.418013117888, 3640.3993341098953, 3640.4903313536124, 3644.0525463379713, 631.8609905820712, 637.6206157336377, 644.9097126402307, 656.2813718977711, 656.8719099775498, 557.701629628147, 581.7033313010395, 596.63307066154, 610.6336198280995, 622.8847663182326, 7715.575643339558, 7770.883436748453, 7914.2085791420395, 8197.754067377988, 8222.794430139294, 450.9425397442991, 507.56603104345254, 537.6559002238571, 590.052964991183, 608.3703367015119, 3619.4570814378053, 3873.24471728016, 3903.1217975955183, 3924.843006279774, 3932.8230229639735, 87223.0, 88112.0, 88777.55611221903, 89848.0, 89868.55065724629, 75217.62391188009, 76998.0, 77368.61315693498, 77451.0, 77722.0, 52000.21999670008, 66329.34176645623, 68251.0, 69218.30781692118, 69825.95261071088, 5803.912941305799, 6318.178636777189, 7584.393248540214, 7754.961225193838, 7799.5320280783335, 33450.163745906546, 34550.48174277337, 43721.56278437302, 43913.78043109764, 44584.331235030855, 62622.6868865671, 63401.36598634139, 63426.68286658537, 63783.0, 63876.0, 9890.703278901645, 10044.698659040241, 10146.594136234467, 10262.486875656337, 10394.324368915995, 11132.276402033842, 11175.608853690082, 11189.888101118884, 11335.829962550404, 11365.204435689422, 8334.458260213067, 8567.528785916586, 10204.183665306906, 10257.640982565872, 10838.620648277272, 10348.637797677045, 10698.144148467949, 10760.83858742135, 10870.836937445787, 10890.945545272223, 10237.283390162616, 10535.473226338805, 11091.667249982513, 11165.888341116484, 11469.662921348314, 8043.879341809995, 9452.669156579486, 9535.38020028696, 9811.509424528887, 9813.460259685786, 9417.434953902788, 9552.85670714926, 9574.377665451724, 9603.183729383081, 9658.9034109658], "value": 6666.963878370492, "unit": "score"}], "name": "dromaeo_css", "value": 7156.160532113841, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 158.0, 164.0, 115.0, 115.0, 125.0, 114.0, 117.0, 114.0, 114.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 144.0, 165.0, 123.0, 141.0, 139.0, 122.0, 170.0, 130.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 199.0, 211.0, 229.0, 208.0, 204.0, 254.0, 196.0, 201.0, 199.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 86.0, 66.0, 169.0, 73.0, 78.0, 87.0, 96.0, 134.0, 58.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 115.0, 163.0, 118.0, 83.0, 86.0, 149.0, 65.0, 110.0, 162.0], "value": 113.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 89.0, 85.0, 89.0, 88.0, 77.0, 131.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 107.0, 97.0, 100.0, 149.0, 97.0, 95.0, 95.0], "value": 102.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 77.0, 98.0, 151.0, 144.0, 121.0, 94.0, 126.0, 155.0, 93.0], "value": 121.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 63.0, 61.0, 61.0, 61.0, 77.0, 62.0, 60.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 71.0, 68.0, 81.0, 74.0, 72.0, 68.0, 67.0, 67.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 122.0, 86.0, 87.0, 88.0, 90.0, 88.0, 89.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 159.0, 172.0, 169.0, 188.0, 177.0, 150.0, 150.0, 203.0, 188.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 164.0, 173.0, 175.0, 174.0, 173.0, 174.0, 174.0, 172.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 72.0, 69.0, 70.0, 71.0, 80.0, 103.0, 82.0, 71.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1645.2, "alertThreshold": 2.0}]} 03:55:35 INFO - Return code: 0 03:55:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:55:35 ERROR - # TBPL SUCCESS # 03:55:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:55:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:55:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:55:35 INFO - 2016-04-15 03:55:35.100 screenresolution[1705:10765] starting screenresolution argv=screenresolution get 03:55:35 INFO - 2016-04-15 03:55:35.103 screenresolution[1705:10765] Display 0: 1600x1200x32@60 03:55:35 INFO - 2016-04-15 03:55:35.109 screenresolution[1706:10768] starting screenresolution argv=screenresolution list 03:55:35 INFO - Available Modes on Display 0 03:55:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:55:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:55:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:55:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:55:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:55:35 INFO - Intel Iris: 03:55:35 INFO - Chipset Model: Intel Iris 03:55:35 INFO - Type: GPU 03:55:35 INFO - Bus: Built-In 03:55:35 INFO - VRAM (Dynamic, Max): 1536 MB 03:55:35 INFO - Vendor: Intel (0x8086) 03:55:35 INFO - Device ID: 0x0a2e 03:55:35 INFO - Revision ID: 0x0009 03:55:35 INFO - Displays: 03:55:35 INFO - Display: 03:55:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:55:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:55:35 INFO - Display Serial Number: 1600x1200 60 03:55:35 INFO - Main Display: Yes 03:55:35 INFO - Mirror: Off 03:55:35 INFO - Online: Yes 03:55:35 INFO - Rotation: Supported 03:55:35 INFO - Return code: 0 03:55:35 INFO - Running post-action listener: _resource_record_post_action 03:55:35 INFO - Running post-run listener: _resource_record_post_run 03:55:36 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37897728; Write bytes: 697930240; Read time: 396; Write time: 1955 03:55:36 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381622784; Write bytes: 376604160; Read time: 28289; Write time: 749 03:55:36 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36099584; Write bytes: 299584512; Read time: 376; Write time: 1161 03:55:36 INFO - Running post-run listener: _upload_blobber_files 03:55:36 INFO - Blob upload gear active. 03:55:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:36 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 03:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:55:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:37 INFO - (blobuploader) - INFO - Done attempting. 03:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:38 INFO - (blobuploader) - INFO - Done attempting. 03:55:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:38 INFO - Return code: 0 03:55:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750eeb65e610089cd6f00d8c4e6ec3f55dbff6b1d509d63eb9f85dab4a9d06b2717fbe851926883156267ae0b7afe8a8cad9efb4ff198819036efc7aa32b3dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5537535a2f335d677f3f3c2259702478017b8d42ed4c9560922cb8f3e3e8cfa2f405d52badbbbf13d3aebb161970c24841743bb18dc48f1b51e138979e43d808"} 03:55:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:38 INFO - Contents: 03:55:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750eeb65e610089cd6f00d8c4e6ec3f55dbff6b1d509d63eb9f85dab4a9d06b2717fbe851926883156267ae0b7afe8a8cad9efb4ff198819036efc7aa32b3dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5537535a2f335d677f3f3c2259702478017b8d42ed4c9560922cb8f3e3e8cfa2f405d52badbbbf13d3aebb161970c24841743bb18dc48f1b51e138979e43d808"} 03:55:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:38 INFO - Copying logs to upload dir... 03:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.125218 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-15 03:55:39.057089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:55:39.064359) ========= 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.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750eeb65e610089cd6f00d8c4e6ec3f55dbff6b1d509d63eb9f85dab4a9d06b2717fbe851926883156267ae0b7afe8a8cad9efb4ff198819036efc7aa32b3dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5537535a2f335d677f3f3c2259702478017b8d42ed4c9560922cb8f3e3e8cfa2f405d52badbbbf13d3aebb161970c24841743bb18dc48f1b51e138979e43d808"} build_url:https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010764 build_url: 'https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/750eeb65e610089cd6f00d8c4e6ec3f55dbff6b1d509d63eb9f85dab4a9d06b2717fbe851926883156267ae0b7afe8a8cad9efb4ff198819036efc7aa32b3dc6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5537535a2f335d677f3f3c2259702478017b8d42ed4c9560922cb8f3e3e8cfa2f405d52badbbbf13d3aebb161970c24841743bb18dc48f1b51e138979e43d808"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:55:39.092919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:55:39.096233) ========= 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.OQF3vpx1jo/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.2kkw1TU121/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005107 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:55:39.144863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:55:39.148191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:55:39.148591) ========= ========= Total master_lag: 0.17 =========