builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0006 starttime: 1461678626.8 results: success (0) buildid: 20160426050421 builduid: 1ac734c921a740f99b1bbd84a3177622 revision: 9cd07d2cca91f58712f1f3dc4f5e040568bd295d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:26.800868) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:26.801748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-04-26 06:50:26.802225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 5 secs) (at 2016-04-26 06:50:32.800456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:32.804394) ========= 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.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-26 06:50:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.4M=0.001s 2016-04-26 06:50:32 (14.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123673 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:32.981859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:32.985223) ========= 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.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.026385 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:33.163739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 06:50:33.164084) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9cd07d2cca91f58712f1f3dc4f5e040568bd295d --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 9cd07d2cca91f58712f1f3dc4f5e040568bd295d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-26 06:50:33,304 truncating revision to first 12 chars 2016-04-26 06:50:33,305 Setting DEBUG logging. 2016-04-26 06:50:33,305 attempt 1/10 2016-04-26 06:50:33,305 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9cd07d2cca91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 06:50:34,349 unpacking tar archive at: fx-team-9cd07d2cca91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.286457 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 06:50:34.498600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:34.498919) ========= script_repo_revision: 9cd07d2cca91f58712f1f3dc4f5e040568bd295d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:50:34.499301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-26 06:50:34.499560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-04-26 06:50:37.760754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-04-26 06:50:37.761061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:50:38 INFO - MultiFileLogger online at 20160426 06:50:38 in /builds/slave/test 06:50:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:50:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:38 INFO - {'append_to_log': False, 06:50:38 INFO - 'base_work_dir': '/builds/slave/test', 06:50:38 INFO - 'blob_upload_branch': 'Fx-Team', 06:50:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:38 INFO - 'branch': 'Fx-Team', 06:50:38 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:38 INFO - 'config_files': ('talos/mac_config.py',), 06:50:38 INFO - 'default_actions': ('clobber', 06:50:38 INFO - 'read-buildbot-config', 06:50:38 INFO - 'download-and-extract', 06:50:38 INFO - 'populate-webroot', 06:50:38 INFO - 'create-virtualenv', 06:50:38 INFO - 'install', 06:50:38 INFO - 'run-tests'), 06:50:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:38 INFO - 'download_minidump_stackwalk': True, 06:50:38 INFO - 'download_symbols': 'ondemand', 06:50:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:38 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:38 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:38 INFO - 'installer_path': 'installer.exe', 06:50:38 INFO - 'log_level': 'info', 06:50:38 INFO - 'log_name': 'talos', 06:50:38 INFO - 'log_to_console': True, 06:50:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:50:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:50:38 INFO - 'opt_config_files': (), 06:50:38 INFO - 'pip_index': False, 06:50:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:38 INFO - 'cmd': ('bash', 06:50:38 INFO - '-c', 06:50:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:38 INFO - 'enabled': True, 06:50:38 INFO - 'halt_on_failure': False, 06:50:38 INFO - 'name': 'check_screen_resolution'},), 06:50:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:38 INFO - 'cmd': ('bash', 06:50:38 INFO - '-c', 06:50:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:38 INFO - 'enabled': True, 06:50:38 INFO - 'halt_on_failure': False, 06:50:38 INFO - 'name': 'check_screen_resolution'},), 06:50:38 INFO - 'run_cmd_checks_enabled': True, 06:50:38 INFO - 'sps_profile': False, 06:50:38 INFO - 'sps_profile_interval': 0, 06:50:38 INFO - 'suite': 'dromaeojs', 06:50:38 INFO - 'system_bits': '32', 06:50:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:38 INFO - 'title': 't-yosemite-r7-0006', 06:50:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:38 INFO - 'use_talos_json': True, 06:50:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:38 INFO - 'work_dir': 'build'} 06:50:38 INFO - ##### 06:50:38 INFO - ##### Running clobber step. 06:50:38 INFO - ##### 06:50:38 INFO - Running pre-action listener: _resource_record_pre_action 06:50:38 INFO - Running main action method: clobber 06:50:38 INFO - rmtree: /builds/slave/test/build 06:50:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:39 INFO - Running post-action listener: _resource_record_post_action 06:50:39 INFO - ##### 06:50:39 INFO - ##### Running read-buildbot-config step. 06:50:39 INFO - ##### 06:50:39 INFO - Running pre-action listener: _resource_record_pre_action 06:50:39 INFO - Running main action method: read_buildbot_config 06:50:39 INFO - Using buildbot properties: 06:50:39 INFO - { 06:50:39 INFO - "project": "", 06:50:39 INFO - "product": "firefox", 06:50:39 INFO - "script_repo_revision": "production", 06:50:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:50:39 INFO - "repository": "", 06:50:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:50:39 INFO - "buildid": "20160426050421", 06:50:39 INFO - "pgo_build": "False", 06:50:39 INFO - "basedir": "/builds/slave/test", 06:50:39 INFO - "buildnumber": 774, 06:50:39 INFO - "slavename": "t-yosemite-r7-0006", 06:50:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:50:39 INFO - "platform": "yosemite_r7", 06:50:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:50:39 INFO - "branch": "fx-team", 06:50:39 INFO - "repo_path": "integration/fx-team", 06:50:39 INFO - "revision": "9cd07d2cca91f58712f1f3dc4f5e040568bd295d", 06:50:39 INFO - "stage_platform": "macosx64", 06:50:39 INFO - "builduid": "1ac734c921a740f99b1bbd84a3177622", 06:50:39 INFO - "slavebuilddir": "test" 06:50:39 INFO - } 06:50:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 06:50:39 INFO - Running post-action listener: _resource_record_post_action 06:50:39 INFO - ##### 06:50:39 INFO - ##### Running download-and-extract step. 06:50:39 INFO - ##### 06:50:39 INFO - Running pre-action listener: _resource_record_pre_action 06:50:39 INFO - Running main action method: download_and_extract 06:50:39 INFO - mkdir: /builds/slave/test/build/tests 06:50: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')]} 06:50:39 INFO - https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 06:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 06:50:42 INFO - Downloaded 1199 bytes. 06:50:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 06:50:42 INFO - Using the following test package requirements: 06:50:42 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:50:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 06:50:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 06:50:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'jsshell-mac.zip'], 06:50:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 06:50:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 06:50:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 06:50:42 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 06:50:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 06:50:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 06:50:42 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 06:50:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:42 INFO - https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:50:43 INFO - Downloaded 18114074 bytes. 06:50:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:50:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:50:46 INFO - Return code: 0 06:50:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:46 INFO - https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 06:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:50:48 INFO - Downloaded 18114074 bytes. 06:50:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:50:51 INFO - Return code: 0 06:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:51 INFO - https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 06:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:50:53 INFO - Downloaded 10840145 bytes. 06:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:50:54 INFO - Return code: 0 06:50: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')]} 06:50:54 INFO - https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 06:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 06:50:57 INFO - Downloaded 110120806 bytes. 06:50:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:50:57 INFO - mkdir: /builds/slave/test/properties 06:50:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:57 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:57 INFO - Contents: 06:50:57 INFO - build_url:https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - Running post-action listener: set_extra_try_arguments 06:50:58 INFO - ##### 06:50:58 INFO - ##### Running populate-webroot step. 06:50:58 INFO - ##### 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: populate_webroot 06:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:58 INFO - '--tppagecycles', 06:50:58 INFO - '7'], 06:50:58 INFO - 'tests': ['tsvgm']}}, 06:50:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:50:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['damp', 'tps']}, 06:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'tests': ['damp', 'tps']}, 06:50:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['dromaeo_dom']}, 06:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['a11yr', 06:50:58 INFO - 'ts_paint', 06:50:58 INFO - 'tpaint', 06:50:58 INFO - 'sessionrestore', 06:50:58 INFO - 'sessionrestore_no_auto_restore', 06:50:58 INFO - 'tabpaint']}, 06:50:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['tsvgx', 06:50:58 INFO - 'tsvgr_opacity', 06:50:58 INFO - 'tart', 06:50:58 INFO - 'tscrollx', 06:50:58 INFO - 'cart']}, 06:50:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:50:58 INFO - 'tsvgr_opacity', 06:50:58 INFO - 'tart', 06:50:58 INFO - 'tscrollx', 06:50:58 INFO - 'cart']}, 06:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'talos_options': ['--disable-e10s'], 06:50:58 INFO - 'tests': ['tp5o']}, 06:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'tests': ['tp5o']}, 06:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'talos_options': ['--disable-e10s', 06:50:58 INFO - '--xperf_path', 06:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:58 INFO - 'tests': ['tp5n']}, 06:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:58 INFO - 'talos_options': ['--xperf_path', 06:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:58 INFO - 'tests': ['tp5n']}}, 06:50:58 INFO - 'talos.zip': {'path': '', 06:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:58 INFO - Running post-action listener: _resource_record_post_action 06:50:58 INFO - ##### 06:50:58 INFO - ##### Running create-virtualenv step. 06:50:58 INFO - ##### 06:50:58 INFO - Running pre-action listener: _resource_record_pre_action 06:50:58 INFO - Running main action method: create_virtualenv 06:50:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:58 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 06:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:58 INFO - Using real prefix '/tools/python27' 06:50:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:02 INFO - Installing pip.................done. 06:51:02 INFO - Return code: 0 06:51:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51: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', 'pip>=1.5'] in /builds/slave/test/build 06:51: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 pip>=1.5 06:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:02 INFO - 'HOME': '/Users/cltbld', 06:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:02 INFO - 'LOGNAME': 'cltbld', 06:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:02 INFO - 'MOZ_NO_REMOTE': '1', 06:51:02 INFO - 'NO_EM_RESTART': '1', 06:51:02 INFO - 'PAGER': '/bin/cat', 06:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:02 INFO - 'PWD': '/builds/slave/test', 06:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:02 INFO - 'SHELL': '/bin/bash', 06:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:02 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:02 INFO - 'USER': 'cltbld', 06:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:02 INFO - 'XPC_FLAGS': '0x0', 06:51:02 INFO - 'XPC_SERVICE_NAME': '0', 06:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:02 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 06:51:02 INFO - Cleaning up... 06:51:02 INFO - Return code: 0 06:51:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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', '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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:51: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 psutil>=0.7.1 06:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:02 INFO - 'HOME': '/Users/cltbld', 06:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:02 INFO - 'LOGNAME': 'cltbld', 06:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:02 INFO - 'MOZ_NO_REMOTE': '1', 06:51:02 INFO - 'NO_EM_RESTART': '1', 06:51:02 INFO - 'PAGER': '/bin/cat', 06:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:02 INFO - 'PWD': '/builds/slave/test', 06:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:02 INFO - 'SHELL': '/bin/bash', 06:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:02 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:02 INFO - 'USER': 'cltbld', 06:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:02 INFO - 'XPC_FLAGS': '0x0', 06:51:02 INFO - 'XPC_SERVICE_NAME': '0', 06:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:02 INFO - Downloading/unpacking psutil>=0.7.1 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:05 INFO - Installing collected packages: psutil 06:51:05 INFO - Running setup.py install for psutil 06:51:05 INFO - building 'psutil._psutil_osx' extension 06:51:05 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 06:51:06 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 06:51:06 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 06:51:06 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 06:51:06 INFO - building 'psutil._psutil_posix' extension 06:51:06 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 06:51:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:51:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:51:06 INFO - ^ 06:51:06 INFO - 1 warning generated. 06:51:06 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 06:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:06 INFO - Successfully installed psutil 06:51:06 INFO - Cleaning up... 06:51:07 INFO - Return code: 0 06:51:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:07 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:07 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 06:51:07 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 06:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:07 INFO - 'HOME': '/Users/cltbld', 06:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:07 INFO - 'LOGNAME': 'cltbld', 06:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:07 INFO - 'MOZ_NO_REMOTE': '1', 06:51:07 INFO - 'NO_EM_RESTART': '1', 06:51:07 INFO - 'PAGER': '/bin/cat', 06:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:07 INFO - 'PWD': '/builds/slave/test', 06:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:07 INFO - 'SHELL': '/bin/bash', 06:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:07 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:07 INFO - 'USER': 'cltbld', 06:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:07 INFO - 'XPC_FLAGS': '0x0', 06:51:07 INFO - 'XPC_SERVICE_NAME': '0', 06:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:51:09 INFO - Installing collected packages: mozsystemmonitor 06:51:09 INFO - Running setup.py install for mozsystemmonitor 06:51:10 INFO - Successfully installed mozsystemmonitor 06:51:10 INFO - Cleaning up... 06:51:10 INFO - Return code: 0 06:51:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:10 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')]} 06:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:10 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')]} 06:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:10 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:10 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 06:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:10 INFO - 'HOME': '/Users/cltbld', 06:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:10 INFO - 'LOGNAME': 'cltbld', 06:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:10 INFO - 'MOZ_NO_REMOTE': '1', 06:51:10 INFO - 'NO_EM_RESTART': '1', 06:51:10 INFO - 'PAGER': '/bin/cat', 06:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:10 INFO - 'PWD': '/builds/slave/test', 06:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:10 INFO - 'SHELL': '/bin/bash', 06:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:10 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:10 INFO - 'USER': 'cltbld', 06:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:10 INFO - 'XPC_FLAGS': '0x0', 06:51:10 INFO - 'XPC_SERVICE_NAME': '0', 06:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:12 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:14 INFO - Downloading docopt-0.6.1.tar.gz 06:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:14 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:14 INFO - Running setup.py install for blobuploader 06:51:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:14 INFO - Running setup.py install for requests 06:51:14 INFO - Running setup.py install for docopt 06:51:15 INFO - Successfully installed blobuploader requests docopt 06:51:15 INFO - Cleaning up... 06:51:15 INFO - Return code: 0 06:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:15 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:15 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 06:51:15 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 06:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:15 INFO - 'HOME': '/Users/cltbld', 06:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:15 INFO - 'LOGNAME': 'cltbld', 06:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:15 INFO - 'MOZ_NO_REMOTE': '1', 06:51:15 INFO - 'NO_EM_RESTART': '1', 06:51:15 INFO - 'PAGER': '/bin/cat', 06:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:15 INFO - 'PWD': '/builds/slave/test', 06:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:15 INFO - 'SHELL': '/bin/bash', 06:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:15 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:15 INFO - 'USER': 'cltbld', 06:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:15 INFO - 'XPC_FLAGS': '0x0', 06:51:15 INFO - 'XPC_SERVICE_NAME': '0', 06:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-8p7jDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Yz_MeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-pX69ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-XFMYkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-059AwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:15 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-UXkQpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-XaqW38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-gX5VIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jAaYLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-VIjpnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-grUqv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-m8H0xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Co5xK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-uFE29u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:16 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-eE9IzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-CE_Lcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:17 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-amq1Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:51:17 INFO - Running setup.py install for manifestparser 06:51:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:51:17 INFO - Running setup.py install for mozcrash 06:51:17 INFO - Running setup.py install for mozdebug 06:51:17 INFO - Running setup.py install for mozdevice 06:51:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:51:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:51:17 INFO - Running setup.py install for mozfile 06:51:17 INFO - Running setup.py install for mozhttpd 06:51:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Running setup.py install for mozinfo 06:51:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Running setup.py install for mozInstall 06:51:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Running setup.py install for mozleak 06:51:18 INFO - Running setup.py install for mozlog 06:51:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Running setup.py install for moznetwork 06:51:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:51:18 INFO - Running setup.py install for mozprocess 06:51:19 INFO - Running setup.py install for mozprofile 06:51:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:51:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:51:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:51:19 INFO - Running setup.py install for mozrunner 06:51:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:51:19 INFO - Running setup.py install for mozscreenshot 06:51:19 INFO - Running setup.py install for moztest 06:51:19 INFO - Running setup.py install for mozversion 06:51:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:51:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:19 INFO - Cleaning up... 06:51:19 INFO - Return code: 0 06:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:19 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:19 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 06:51:19 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 06:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:19 INFO - 'HOME': '/Users/cltbld', 06:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:19 INFO - 'LOGNAME': 'cltbld', 06:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:19 INFO - 'MOZ_NO_REMOTE': '1', 06:51:19 INFO - 'NO_EM_RESTART': '1', 06:51:19 INFO - 'PAGER': '/bin/cat', 06:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:19 INFO - 'PWD': '/builds/slave/test', 06:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:19 INFO - 'SHELL': '/bin/bash', 06:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:19 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:19 INFO - 'USER': 'cltbld', 06:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:19 INFO - 'XPC_FLAGS': '0x0', 06:51:19 INFO - 'XPC_SERVICE_NAME': '0', 06:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Y4ZK3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fMnRI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-adeZxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-R7G9h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FBADAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-iCp8BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-CwcvFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-wSiQTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:51:20 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)) 06:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:51:20 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-K3FD3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-l49hvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-xrpMdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-dlXm6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-6kzWgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FTXWrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-6YNqiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-vnWUmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:51:21 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)) 06:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:51:21 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-UL8U2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:51:21 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)) 06:51:21 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)) 06:51:21 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)) 06:51:21 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)) 06:51:21 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)) 06:51:21 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)) 06:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:24 INFO - Downloading blessings-1.6.tar.gz 06:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:24 INFO - Installing collected packages: blessings 06:51:24 INFO - Running setup.py install for blessings 06:51:24 INFO - Successfully installed blessings 06:51:24 INFO - Cleaning up... 06:51:24 INFO - Return code: 0 06:51:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:24 INFO - Reading from file tmpfile_stdout 06:51:24 INFO - Current package versions: 06:51:24 INFO - blessings == 1.6 06:51:24 INFO - blobuploader == 1.2.4 06:51:24 INFO - docopt == 0.6.1 06:51:24 INFO - manifestparser == 1.1 06:51:24 INFO - mozInstall == 1.12 06:51:24 INFO - mozcrash == 0.17 06:51:24 INFO - mozdebug == 0.1 06:51:24 INFO - mozdevice == 0.48 06:51:24 INFO - mozfile == 1.2 06:51:24 INFO - mozhttpd == 0.7 06:51:24 INFO - mozinfo == 0.9 06:51:24 INFO - mozleak == 0.1 06:51:24 INFO - mozlog == 3.1 06:51:24 INFO - moznetwork == 0.27 06:51:24 INFO - mozprocess == 0.22 06:51:24 INFO - mozprofile == 0.28 06:51:24 INFO - mozrunner == 6.11 06:51:24 INFO - mozscreenshot == 0.1 06:51:24 INFO - mozsystemmonitor == 0.0 06:51:24 INFO - moztest == 0.7 06:51:24 INFO - mozversion == 1.4 06:51:24 INFO - psutil == 3.1.1 06:51:24 INFO - requests == 1.2.3 06:51:24 INFO - wsgiref == 0.1.2 06:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:24 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:24 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 06:51:24 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 06:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:24 INFO - 'HOME': '/Users/cltbld', 06:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:24 INFO - 'LOGNAME': 'cltbld', 06:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:24 INFO - 'MOZ_NO_REMOTE': '1', 06:51:24 INFO - 'NO_EM_RESTART': '1', 06:51:24 INFO - 'PAGER': '/bin/cat', 06:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:24 INFO - 'PWD': '/builds/slave/test', 06:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:24 INFO - 'SHELL': '/bin/bash', 06:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:24 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:24 INFO - 'USER': 'cltbld', 06:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:24 INFO - 'XPC_FLAGS': '0x0', 06:51:24 INFO - 'XPC_SERVICE_NAME': '0', 06:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 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)) 06:51:25 INFO - Cleaning up... 06:51:25 INFO - Return code: 0 06:51:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:25 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:25 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 06:51:25 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 06:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:25 INFO - 'HOME': '/Users/cltbld', 06:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:25 INFO - 'LOGNAME': 'cltbld', 06:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:25 INFO - 'MOZ_NO_REMOTE': '1', 06:51:25 INFO - 'NO_EM_RESTART': '1', 06:51:25 INFO - 'PAGER': '/bin/cat', 06:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:25 INFO - 'PWD': '/builds/slave/test', 06:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:25 INFO - 'SHELL': '/bin/bash', 06:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:25 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:25 INFO - 'USER': 'cltbld', 06:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:25 INFO - 'XPC_FLAGS': '0x0', 06:51:25 INFO - 'XPC_SERVICE_NAME': '0', 06:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:25 INFO - Downloading/unpacking jsonschema 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:27 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:28 INFO - warning: no files found matching '*.txt' 06:51:28 INFO - no previously-included directories found matching 'build' 06:51:28 INFO - no previously-included directories found matching 'dist' 06:51:28 INFO - no previously-included directories found matching '.git*' 06:51:28 INFO - Installing collected packages: jsonschema, functools32 06:51:28 INFO - Running setup.py install for functools32 06:51:28 INFO - warning: no files found matching '*.txt' 06:51:28 INFO - no previously-included directories found matching 'build' 06:51:28 INFO - no previously-included directories found matching 'dist' 06:51:28 INFO - no previously-included directories found matching '.git*' 06:51:28 INFO - Successfully installed jsonschema functools32 06:51:28 INFO - Cleaning up... 06:51:28 INFO - Return code: 0 06:51:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:28 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 0x1050afa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050bf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96b0c81f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, '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.1gIXkpVquo/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.vA7AyGjFvx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 06:51:28 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 06:51:28 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 06:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:28 INFO - 'HOME': '/Users/cltbld', 06:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:28 INFO - 'LOGNAME': 'cltbld', 06:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:28 INFO - 'MOZ_NO_REMOTE': '1', 06:51:28 INFO - 'NO_EM_RESTART': '1', 06:51:28 INFO - 'PAGER': '/bin/cat', 06:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:28 INFO - 'PWD': '/builds/slave/test', 06:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:28 INFO - 'SHELL': '/bin/bash', 06:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:51:28 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:28 INFO - 'USER': 'cltbld', 06:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:28 INFO - 'XPC_FLAGS': '0x0', 06:51:28 INFO - 'XPC_SERVICE_NAME': '0', 06:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:28 INFO - Downloading/unpacking flake8 06:51:28 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 06:51:28 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 06:51:28 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 06:51:28 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 06:51:28 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 06:51:28 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 06:51:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:31 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 06:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:32 INFO - no previously-included directories found matching 'docs/_build' 06:51:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:32 INFO - Running setup.py install for pep8 06:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:32 INFO - no previously-included directories found matching 'docs/_build' 06:51:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:51:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:32 INFO - Cleaning up... 06:51:32 INFO - Return code: 0 06:51:32 INFO - Running post-action listener: _resource_record_post_action 06:51:32 INFO - Running post-action listener: _start_resource_monitoring 06:51:32 INFO - Starting resource monitoring. 06:51:32 INFO - ##### 06:51:32 INFO - ##### Running install step. 06:51:32 INFO - ##### 06:51:32 INFO - Running pre-action listener: _resource_record_pre_action 06:51:32 INFO - Running main action method: install 06:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:33 INFO - Reading from file tmpfile_stdout 06:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:33 INFO - Reading from file tmpfile_stdout 06:51:33 INFO - Output received: 06:51:33 INFO - Usage: mozinstall [options] installer 06:51:33 INFO - Options: 06:51:33 INFO - -h, --help show this help message and exit 06:51:33 INFO - -d DEST, --destination=DEST 06:51:33 INFO - Directory to install application into. [default: 06:51:33 INFO - "/builds/slave/test"] 06:51:33 INFO - --app=APP Application being installed. [default: firefox] 06:51:33 INFO - mkdir: /builds/slave/test/build/application 06:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:52:06 INFO - Reading from file tmpfile_stdout 06:52:06 INFO - Output received: 06:52:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:52:06 INFO - Running post-action listener: _resource_record_post_action 06:52:06 INFO - ##### 06:52:06 INFO - ##### Running run-tests step. 06:52:06 INFO - ##### 06:52:06 INFO - Running pre-action listener: _resource_record_pre_action 06:52:06 INFO - Running main action method: run_tests 06:52:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:52:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:52:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:52:06 INFO - 2016-04-26 06:52:06.794 screenresolution[1643:7845] starting screenresolution argv=screenresolution get 06:52:06 INFO - 2016-04-26 06:52:06.797 screenresolution[1643:7845] Display 0: 1600x1200x32@60 06:52:06 INFO - 2016-04-26 06:52:06.803 screenresolution[1644:7847] starting screenresolution argv=screenresolution list 06:52:06 INFO - Available Modes on Display 0 06:52:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:52:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:52:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:52:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:52:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:52:07 INFO - Intel Iris: 06:52:07 INFO - Chipset Model: Intel Iris 06:52:07 INFO - Type: GPU 06:52:07 INFO - Bus: Built-In 06:52:07 INFO - VRAM (Dynamic, Max): 1536 MB 06:52:07 INFO - Vendor: Intel (0x8086) 06:52:07 INFO - Device ID: 0x0a2e 06:52:07 INFO - Revision ID: 0x0009 06:52:07 INFO - Displays: 06:52:07 INFO - Display: 06:52:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:52:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:52:07 INFO - Display Serial Number: 1600x1200 60 06:52:07 INFO - Main Display: Yes 06:52:07 INFO - Mirror: Off 06:52:07 INFO - Online: Yes 06:52:07 INFO - Rotation: Supported 06:52:07 INFO - Return code: 0 06:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:52:07 INFO - Python 2.7.3 06:52:07 INFO - Return code: 0 06:52:07 INFO - grabbing minidump binary from tooltool 06:52: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')]} 06:52:07 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 0x104f4ee00>, '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 0x104d77db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:52:07 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 06:52:07 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 06:52:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:07 INFO - Return code: 0 06:52:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:52:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:52:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:52:08 INFO - Return code: 0 06:52:08 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:52:08 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1gIXkpVquo/Render', 06:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:08 INFO - 'HOME': '/Users/cltbld', 06:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:08 INFO - 'LOGNAME': 'cltbld', 06:52:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:52:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:08 INFO - 'MOZ_NO_REMOTE': '1', 06:52:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:52:08 INFO - 'NO_EM_RESTART': '1', 06:52:08 INFO - 'PAGER': '/bin/cat', 06:52:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:08 INFO - 'PWD': '/builds/slave/test', 06:52:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:08 INFO - 'SHELL': '/bin/bash', 06:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA7AyGjFvx/Listeners', 06:52:08 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 06:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:08 INFO - 'USER': 'cltbld', 06:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:08 INFO - 'XPC_FLAGS': '0x0', 06:52:08 INFO - 'XPC_SERVICE_NAME': '0', 06:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:52:08 INFO - mozversion application_buildid: 20160426050421 06:52:08 INFO - mozversion application_changeset: 9cd07d2cca91f58712f1f3dc4f5e040568bd295d 06:52:08 INFO - mozversion application_display_name: Nightly 06:52:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:08 INFO - mozversion application_name: Firefox 06:52:08 INFO - mozversion application_remotingname: firefox 06:52:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:52:08 INFO - mozversion application_vendor: Mozilla 06:52:08 INFO - mozversion application_version: 49.0a1 06:52:08 INFO - mozversion platform_buildid: 20160426050421 06:52:08 INFO - mozversion platform_changeset: 9cd07d2cca91f58712f1f3dc4f5e040568bd295d 06:52:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:52:08 INFO - mozversion platform_version: 49.0a1 06:52:08 INFO - using testdate: 1461678728 06:52:08 INFO - actual date: 1461678728 06:52:08 INFO - starting webserver on 'localhost:49275' 06:52:08 INFO - SUITE-START | Running 2 tests 06:52:08 INFO - TEST-START | dromaeo_css 06:52:08 INFO - operating with platform_type : mac_ 06:52:08 INFO - Initialising browser for dromaeo_css test... 06:52:08 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpvE5eL4/profile http://localhost:49275/getInfo.html) 06:52:10 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:52:10 INFO - PROCESS | 1662 | colorDepth:24 06:52:10 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:52:10 INFO - PROCESS | 1662 | __metrics 06:52:10 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:52:10 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:52:11 INFO - TEST-INFO | 1662: exit 0 06:52:11 INFO - Browser initialized. 06:52:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:11 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpvE5eL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:23 INFO - PROCESS | 1664 | RSS: Main: 239210496 06:52:23 INFO - PROCESS | 1664 | 06:53:14 INFO - PROCESS | 1664 | 1461678794663 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] 06:55:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 06:55:26 INFO - PROCESS | 1664 | RSS: Main: 328867840 06:55:26 INFO - PROCESS | 1664 | 06:58:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 06:58:29 INFO - PROCESS | 1664 | RSS: Main: 373960704 06:58:29 INFO - PROCESS | 1664 | 07:01:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 07:01:32 INFO - PROCESS | 1664 | RSS: Main: 374910976 07:01:32 INFO - PROCESS | 1664 | 07:04:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 07:04:35 INFO - PROCESS | 1664 | RSS: Main: 377028608 07:04:35 INFO - PROCESS | 1664 | 07:07:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 07:07:39 INFO - PROCESS | 1664 | RSS: Main: 341434368 07:07:39 INFO - PROCESS | 1664 | 07:10:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 07:10:43 INFO - PROCESS | 1664 | RSS: Main: 384413696 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | __start_tp_report 07:10:43 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 07:10:43 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 07:10:43 INFO - PROCESS | 1664 | |i|pagename|runs| 07:10:43 INFO - PROCESS | 1664 | |0;dojo.html;3375.561177046984;3437.6046754623226;3439.501272315514;3459.740519461041;3503.1942653189767;4663.790129444174;5573.024720673876;5631.774729010835;5660.377358490573;5694.2312787773635;5605.467480589347;5626.831195064145;5686.3744988051285;5815.5638327125425;5827.1550625159325;5074.112030394685;5113.795448182068;5124.769385377667;5126.974365128169;5179.119549676545;5210.739463026853;5214.921776173361;5229.927864787709;5249.8950020999555;5308.23030660554;5111.1566591512355;5123.948760512384;5165.793368265265;5219.06056909758;5257.0274499217385;5189.351331083614;5203.739813009334;5220.2430647556275;5220.791168353261;5226.764795584208;5144.768485418165;5189;5202.167653175474;5223.582113430916;5240.659357141812;5485.314335708036;5587.189857470644;5597.244372009808;5610.961972035187;5698.572607054446;6171.039359226593;6208.068789681539;6223.688815559204;6223.68881555925;6236.158118653969;6221.097940798559;6270.592411493284;6271.78048768291;6300.87398252037;6309.71606277714;5701.828945131652;5747.885042299215;5813.476787089182;5815.534757219412;5818.069108942549;6230.345813689497;6254.937450625526;6258.687065646699;6259.061140828821;6265.655388953652;6078.817635470943;6129.816105516842;6133.693315334215;6141.170941922873;6141.324454310023;6069.605475644069;6145.310039739107;6147.139400483936;6149.923763341398;6265.624062556261;6110.022396416552;6114.540688159395;6137.662428566472;6137.877242455215;6167.722452489559;6202.100695399142;6225.097360882647;6229.563930524911;6235.438810506986;6256.749730010749;4228.9154216915485;4890.608751299958;4903.26451032348;4919.827806026772;4928.408590969035;4362.76004819738;4366.607005369532;4457.77711114443;4480.39514665516;4486.1252055849445;5657.15142728594;5657.547396208293;5659.773609055592;5674.375818659944;5694.402087780723;5855.560832937546;5882;6247;6255.280642726054;6280.246370435577;5418.539424148913;5532.446755324516;5540;5544.750486228129;5560.110382338807;5269.420363759983;5353.491418315254;5420.810271640474;5428.212909128154;5448.128299472065;6212.502999760009;6261.530385221035;6262.15460912771;6295.24457065146;6302.810915672537;6225.835825425805;6270.7491700331475;6276.215473065867;6283.654399008098;6286.559940804283;6144.801763656044;6206.317305096526;6253.37466253371;6255.124282600348;6266.905996410149;6090.458580988912;6105.48103411215;6130.080487926846;6134.263888333428;6148.077788331607;6169.691515424301;6182.505399568114;6206.534509911684;6241.843953901189;6243.219597550306;5934.940650593611;6014.849628759316;6031.276246850406;6132.5400594956445;6142.846428839136;6099.329073801967;6110.022396416552;6116.3272040076445;6125.264968203844;6129.08063790435;5966.791162309472;5977.312609049841;5977.790777322773;5987.520998320211;5996.310424301087;5899.911501327398;5942.286925568959;6030.969845150922;6120.2947619997085;6139.631622102688;5952.404759524013;5971.462568368867;5974.2233509643465;5981.52147828164;6030.155778190969 07:10:43 INFO - PROCESS | 1664 | |1;ext.html;472.4307209812177;503.71791796593885;504.2134270537961;510.12768166435393;601.5037593984963;28730.856345718268;36094;37073.443898341546;37159;37224.069398265055;40421.393679094836;41073.97315067125;41134.17731645365;41187.79406102965;41306;9198.402103863227;9417.858732119024;9422.199113075398;9424.858627120599;9431.104045115702;9206.631734730636;9291.349605527615;9344.2524598032;9352.438853668767;9383.81232375352;9325.860112098324;9391.62433502659;9393.29550283728;9395.483248421335;9396.436213827157;9260.351775375726;9275.721728348093;9335.673251436236;9338.393004454689;9373.109554592269;9270.629174832999;9390.014048524874;9392.48341341226;9396.718098457057;9440.339176257665;37649;38137.61862381369;38163.23673526542;38214.617853821386;38230.617693822984;3311.172206948263;3375.3586818504405;3464.9653503464897;3655.1593133579427;3776.2636285924254;26916.865415672994;27491.725082749315;27629.447411051668;27678.861605692044;27777.86111069452;2639.018859329913;2671.7461841125064;2678.531257030012;2709.4716530276605;2805.9719402805913;350066;352926;353222;353537;355908;32501.674983249864;54187;54459;54584.72707636436;54792.17811732827;34289.48565771515;34487.310253794785;34490.655093448746;34491.31017379638;34559.96320110401;14313.85686143146;14542.345594448276;14565.854341456661;14587.124772513684;14602.634934126732;10410.47947602632;12461.252324860356;12491.000719942384;12514.937425312997;12543.8710516054;7851.411144164211;7967.641456134488;7969.960150199212;7972.521648701097;8037.598120093972;2959.674435812059;3308.123347312964;3381.458966565338;3382.797032178077;3412.334594753999;947.2422062350092;978.3591747405461;985.5860538573672;987.4026214140486;991.9603215871284;22912.31263062111;28513.572296415572;28631.57052644212;28757.42485150327;28987.7101228985;946.7633091727068;1017.6031347774374;1054.8892366301582;1109.290054365207;1163.0927876256533;11130.888691113147;13934.512292069932;14035.78946315806;14289.857101428852;14347;459520;461863;469004;471052;472129;52752.47247527552;53486.465135348146;53555.92888142215;53574.196387054224;53640;1321.2666969831644;1329.2489743295007;1476.3282706368577;1484.4952716076587;1493.2309860421892;26776.866115670076;27026.411544840063;27256.41243545029;27312.629979204026;27990;38741.418878717406;39465.01337466586;39696.00759981023;39991.40012899867;40054.79972600118;385691;387921;388239;389882;390475;20855.270065547633;21533.89233053825;23335;23952.56284622928;23982.40043998914;38498.422523662724;38865.6113438862;38900.027499312746;39475.210495789346;40057.79971100242;32384;32942.50586241256;33128.83435582807;33133.66866331306;34119.147021323675;31940.5208921871;32118.83940580282;32480;32708;32841.67158328386;32748.50877236891;33293.83353083219;34315.4852677215;34552.827235864665;34662;29509.409811803213;30282.940097096496;30361;30372.684780163825;30470.847645762515;22965.655515166953;23237.88381058084;25908.611370829076;28755.424891502473;29887.850560747927 07:10:43 INFO - PROCESS | 1664 | |2;jquery.html;388.7007004606453;392.7996721671947;393.0762707637052;394.77497826239056;403.197636702961;14644.414223431077;18894.716579251322;19507.5123121922;20122.59754804905;20157.899210503947;15443.45947891824;15853.365865365371;19483.805161948378;19751.111199995998;19902.90048549759;5578.525825304844;5849.912251316234;5874.823755287327;5894.58737888348;5902.675352855591;3997.2005598880196;4606.631469482433;5747.166660834177;5796.82609521715;5804.042333015047;6330.33531479195;6331.2719037310835;6332.176817013782;6335.873282534347;6345.841353966165;6240.31356550779;6306.400891915261;6310.305866354744;6312.210973628296;6321.683915804214;5352.866178345534;5498.202760599731;5531.9723401383135;5550;5552;23469.76530234693;23719.525609487715;24829.6275555865;24862.751372486226;24877.378065548324;2104.8105670489576;2141.4432247615578;2322.465832858435;2424.733279339271;2826.039146690135;13760.518381856687;14266.072705274124;14441.855581444157;14556.126632402089;14617.92691036538;1721.535185499908;1727.5422013166522;1757.7011907975675;1757.903315317657;1760.9119544022747;101079;106400.40399393938;106772.46613766959;106790.15739569836;108343.91656083417;10339.327943683636;10725.83911241332;10734.141268698486;10884.292520986111;10891.183161262938;13338.533151339656;13444.663883402798;13448.865511344957;13455.865441345657;13473.124246923919;6994.545354551938;7448.925510744823;7571.659275332623;8404.873926891101;8546.230839224376;6991.825204369829;8407.45351552147;8419.873701894476;8510.914890851136;8535.743927682179;5169.896602067937;6122.418370254819;6488.772892948724;6523.528912795157;6610.272869984298;1821.9817801822078;1849.4451664500596;1850.7316439116253;1874.1097978460396;1875.1842948317526;977.4233202410612;988.5205675247499;999.2206079258191;1003.7390278527489;1042.629866397418;19943.603947723812;20079.39761807148;20302.289419870234;20392.388228353175;20450.693239601416;970.8349580571179;974.7270764186039;1004.1765752083221;1009.9141572966233;1010.4038617215731;10760.300580462244;10898.07366373867;10900.34597924127;10910.963458471433;10958.671239862817;536047;551384;552996;579546;581812;101688;101905;103357;104884.90230195507;104927;1044.060345688871;1065.2543219746208;1068.8877667844765;1089.803835309652;1093.7375029992745;15780.60548486297;16630.91684541618;17473.038982856066;17690.91154544219;18125.546861328046;32375.67624323821;40161;41722.374164388166;45677.85805354892;46162;64158.679206603665;65441.672791635734;66155.66922165359;66616;67571;6392.840178995562;7661.463697541119;7738.226177382442;8150.510969341858;8272.04871439792;10351.84472232902;10764.838527421938;11850.992665623518;12090.51637934508;12097.516099355928;10165.745856353651;10212.846807297748;10618.309809862334;10776.568937242422;10854.945725271324;10033.548490318099;10043.045910638477;10139.543720532742;10342.37945723259;10421.478926053818;6037.577369584087;8031.598420078856;10412.167026638002;10497.685069447929;10873.401962891801;7150.141982962078;7917.445778795429;7922.207779222032;8004.559749213616;8339.291160251447;8069.475484093515;9999.500024998575;10365.74085647865;10719.517621706886;10733.892661073289 07:10:43 INFO - PROCESS | 1664 | |3;mootools.html;1422.8506006869286;1599.2883166990691;1609.283868678438;1859.8419134373578;1985.8113479219478;7725.227477252279;8536;8718.433301835375;8744.8688269676;8773.903262092239;8382.832343353144;8614.224719775235;8618.827623447527;8625.439346442492;8627.913720862789;2171.457135716071;2414.61366181411;2425.8544487330773;2472.8887200076038;2516.4338023944556;2494.887730052152;2529.178017144426;2529.6964364276314;2539.669842920418;2544.5165418570505;2098.9580208395823;2490.887910044043;2492.2024952015363;2497.825152239344;2498.837575557592;2061.175529788089;2139.850210485267;2353.9293821185393;2442.413820683041;2444.8533088014774;2463.064035666453;2476.2199907029226;2500.624906264057;2501.3371456564023;2505.974940250592;8860;8884.156005179497;8940.64237430502;8946.776330591787;8947.239484643813;4441.600255976945;5475.479829416199;5494.09347457669;5502.944970550283;5515.944840551623;3540.026377842599;3573.213892943574;3677.485152078711;3724.2923844469465;3729.6083911189207;1045.5974449836792;1066.2642776484279;1067.5302866738689;1078.5308390849927;1080.4057768227444;11426.08591312693;11562.132840036948;11568.652940411801;11583.420828958519;11590.768184636345;4543.250363689954;4561.954380456219;4690.9765451172525;4691.483936766953;4701.6003639690325;9243.95378023119;9260.907390926139;9267.304952128618;9271.76820579491;9301.906980930104;5295.814646487354;5305.708186049805;5328.733563321818;5347.0909945309395;5360.115580929181;4235.2800023996;4460.710053846489;4562.361269422284;4575.542445755398;4992.326035985096;3605.9819700901853;3653.926921461556;3685.355062863988;3719.8698045568276;3727.3290807654885;1201.6635342104225;1206.5535751771724;1219.7011732125686;1221.7434338788776;1233.216907263876;823.9958800206081;848.8090179709516;894.6689724801735;895.5164211325941;945.744648944781;5478.561715062785;5695.943040569541;5790.314528207688;5865.442782935615;5962;910.2808781062886;918.5085979001202;920.2362039507193;924.690228773355;935.3639525122845;3680.595134535199;3774.037620406779;3789.5642001170218;3792.58281589025;3826.8086595670106;10331.431771252654;10873.184511161695;10905.890941090645;10918.672439826818;10937.726556835984;10396.012378824;10645.893541064645;10868.184886133571;10870.130389568816;10960.013598776148;8003.279704826594;8165.755027349189;8326.45878017927;8355.415120941598;8435.114312997048;5635;5671.404502527175;5675.31896172462;5776.768929242951;5867.090600956859;9626;10007.199424046205;10205.591776328863;10244.64143754965;10274.537645805807;10344.431056291976;10428.061474467335;10430.113440357654;10455.372677639367;10464.372137671764;6406.935930640634;6659.101021362054;6806.591604503746;6932.168139823253;7091.11361079865;7007;8323.458975166595;8424.957875210584;8425.789355266168;8447.662093516436;7245.891311630225;7345.265473452612;7370.6314684266645;7493.175750667531;7555.584442855696;6178.7219575120125;7069.22238553769;7220.422366210795;7249.963750181215;7266.491345605757;5601.887962240814;6742.6291553965;6891.207511136284;6901.206361268318;6928.792136235921;4702.670813043054;4722;4803.207470767285;4867.561919427269;4965.106280869478;4813.4945830687275;4870.9269360960325;4871.123197824426;4913.312136300992;5065.113605119016 07:10:43 INFO - PROCESS | 1664 | |4;prototype.html;318.2378204200939;318.91070500259934;326.2561360098975;327.3240757835071;331.7279830538959;5229.529342359187;5230.42465328814;5277.868053298669;5280.445553216915;5296.788128474856;4675.018246168309;5061.468545802693;5244.187150991593;5308.522232999029;5334.199870019499;3342.983285083571;3375.71306438953;3758.951371502524;3991.9201615967663;3999.5800440953717;3313.486409606515;3589.856405743767;3809.4285857121513;3906.61696365217;3917.7061720371084;3980.4825372701507;4044.777537235451;4072.2059198456313;4074.127739943333;4085.8569950051756;3996.9400458993136;4063.573324800898;4066.877993660195;4075.2257071156682;4124.8556300529635;3380.729541636688;3487.511748355232;3563.2160924596806;3574.4459608760685;3615.313090512794;4114.835406583763;5011.924821127686;5050.39395272566;5054.9494505054845;5082.695038297714;4027.677785777131;4453.953320969569;4627.652926030528;4655.208614535537;4695.3661255730385;4785.880352991168;4879.341288925985;5396.892062158774;5490.56075513958;5525.475079867406;3910.843566257346;3912;3919;3921.784301863396;3941.507311586052;5378.892422151535;5513.5864810139;5607.43925607436;5776.855578610526;5777.653340799566;3539.486774417695;3934.213157368538;3959.664167736324;3965.2267807777207;4036.535798383165;3780.527434070741;3979.741316814456;4022.3966405039478;4026.8187931543152;4031.7703100554613;3776.6412190841825;4623.722576645412;4645.349651048856;4652.55800698933;4659.161350956861;5472.781088756406;5510.173473978935;5544.63959842609;5559;5636.774529018793;1242.6085782978332;1314.6976195475095;1359.9664255166144;1491.8060652115155;1494.290212149242;789.3251270163927;884.2086332732168;958.3529389170078;1008.2186305613209;1011.4790882695418;5023.221400682827;5560.694161821058;5566.151726066227;5572.414896435897;5657.745401456944;4658.95341046592;5855.502282306052;6018.21763170785;6101.840650276433;6206.72069756862;3899.883003509899;5251.501107394792;5361.624686271924;5538.667679939216;5591.608587398843;3314.436545787222;3321.8837340692958;3331.4003479373946;3338.1487720631085;3362.260302733395;5247.291615631841;5256.763445644955;6308.706715123389;6581.012848072732;6640.302768209365;5196.662216955961;5929.288485381781;5944.256967879015;5999.760009599654;6025.698715064317;5697.145428185805;5882.882342353215;6001.639901605918;6065.757369705162;6068.4538391544975;4913;5552.916706249329;5756.539476841926;5829.8251052468495;5831.620944638585;5305.363356397257;5724.856878578069;5756.56825738063;5771.7114144293455;5803.361630220588;4531.501534831232;4957.7273249971595;5126.410462796826;5268.841934741964;5701.4298570142655;3298.861892647033;3381.7970921744773;3417.760756747004;3819.7708137511836;3851.614838516126;4839.975800120977;5057.216131499624;5214.165733482625;5563.108543095367;5618.606697531297;3958.6239307265764;4941.802327906988;5597.748101335368;5629.380768115586;5640.54875609942;4703.929441058455;5622.959752445647;5632.887342253214;5654.547636189012;5685.431456854447;5144.2252422915535;5204.531592156724;5549.972250138723;5551.306086739158;5561.221429000024;4893.74887551716;5589.357223919302;5615.298087739033;5619.747111379916;5665.886682266414;4958.479359667183;5186.222066690027;5453.263809385682;5506.704770279189;5525.806596769094 07:10:43 INFO - PROCESS | 1664 | |5;yui.html;721.1850608812042;729.1468981291891;740.2523451314171;743.3867059675769;756.2588663110148;14513.637159071028;14960.401583936657;15039.699206015874;15040.947133700633;15083.849161508395;13775.897928165748;13852.099613525113;13863.514776982807;13866.722665546684;13881.236531990737;704.8132244955091;729.7883613752006;871.790770215147;890.3722875372847;911.4166933162782;890.7951171230621;894.6332003878412;899.0290486274807;902.0798785239052;902.1339514066505;965.2615748952057;969.4328817641688;971.4754032822267;971.5822196455522;972.290228133463;748.9026426564538;934.7522906429801;963.5663951221943;966.0146650416606;981.2297346582898;719.8668246374385;721.6463932672953;721.72935149319;721.7365661533555;722.5267449820376;14723.705525889422;14825.925870370687;14829.036112652642;14844.851551484455;14850.480233191787;12066.22476830334;12285.14004019719;12400.937995309965;12623.684407889785;12676.2394256344;9600.939200684497;10055.59777608902;10074.848877266846;10391.37651740898;10472.738181545446;3405.455127179664;3446.724262059054;3494.5631796025496;3523.489094081344;3558.822058897045;73965;74365.25634743637;74435.13912152185;74661.25338746597;75025.62487187529;9106;9169.128932751379;9382.765430864283;9838.16375608067;10138.239632027628;19835;20115.19539218415;20125.09437075335;20129.496762581053;20131.597368052557;7374.446916481285;7374.777271827382;7474.177840437547;7561.168271490132;7589.8861517077285;4087.325591277406;4151.8546850860075;4166.229247589205;4211.136716973075;4242.575742425733;3420.7776494528275;3480.129967508123;3480.3561341151462;3482.669146431085;3487.3199726053176;649.133406901782;660.725798793505;692.6086760980131;698.0401947322432;698.2703075286338;565.457161125316;570.9029464990879;587.4389957590491;600.8107446154447;600.9158717779515;7945.364370850318;8159.959200203961;8231.794205144919;8363.372747043873;8416.747497575083;495.3510900720068;526.5892603769066;560.8177342363748;581.668448984075;589.3340525206489;3658.1951970566433;3874.4769456123627;3877.1276462795645;3982.38273067675;4051.148241093221;96137.51931240299;100194.49513762069;101285.98714012913;101293;101794.49102754438;78331.60834195792;79830;80560.75980355393;82785.58607206926;83237.58381208056;69056.6547167261;74325.5134897299;74550;74778.94905206708;75176.24823751692;7689;7793.29860312552;7885.1720569339395;7904.091029531677;7962.601869906597;40713.38929916113;41277.587224127376;41824.163516728884;42497.15005699931;47819.76090119527;61056;62425.68787156035;62634.68682656557;62702.686486567276;63600.045999310976;10329.225308102074;10461.9476902615;10546.20903432261;10901.34591924487;11325.943370283096;11971.64085077449;12029;12309.26144431337;12445.564405245774;12523.311217883103;11404.087672986307;11418.65932394601;11419.714507137389;11466.77066458683;11563.248388854698;11157.944210279222;11198.496067676811;11222.607208747655;11409.657710268706;11606.94196529012;10582.365058096231;11206.144697720516;11379.26034807768;11419.942900285445;11523.711907202052;9027.277817774693;9427.293422261295;9545.90454095478;9740.561674724797;9928.007199280015;8568.700095496628;10036.247281454067;10049.902278837651;10055.189390931446;10060.162254271152 07:10:43 INFO - PROCESS | 1664 | __end_tp_report 07:10:43 INFO - PROCESS | 1664 | __start_cc_report 07:10:43 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1385 07:10:43 INFO - PROCESS | 1664 | __end_cc_report 07:10:43 INFO - PROCESS | 1664 | __startTimestamp1461679843109__endTimestamp 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | ------- Summary: start ------- 07:10:43 INFO - PROCESS | 1664 | Number of tests: 6 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5710.40 Median:5971.46 stddev:635.44 (10.6%) stddev-sans-first:610.42 07:10:43 INFO - PROCESS | 1664 | Values: 3375.6 3437.6 3439.5 3459.7 3503.2 4663.8 5573.0 5631.8 5660.4 5694.2 5605.5 5626.8 5686.4 5815.6 5827.2 5074.1 5113.8 5124.8 5127.0 5179.1 5210.7 5214.9 5229.9 5249.9 5308.2 5111.2 5123.9 5165.8 5219.1 5257.0 5189.4 5203.7 5220.2 5220.8 5226.8 5144.8 5189.0 5202.2 5223.6 5240.7 5485.3 5587.2 5597.2 5611.0 5698.6 6171.0 6208.1 6223.7 6223.7 6236.2 6221.1 6270.6 6271.8 6300.9 6309.7 5701.8 5747.9 5813.5 5815.5 5818.1 6230.3 6254.9 6258.7 6259.1 6265.7 6078.8 6129.8 6133.7 6141.2 6141.3 6069.6 6145.3 6147.1 6149.9 6265.6 6110.0 6114.5 6137.7 6137.9 6167.7 6202.1 6225.1 6229.6 6235.4 6256.7 4228.9 4890.6 4903.3 4919.8 4928.4 4362.8 4366.6 4457.8 4480.4 4486.1 5657.2 5657.5 5659.8 5674.4 5694.4 5855.6 5882.0 6247.0 6255.3 6280.2 5418.5 5532.4 5540.0 5544.8 5560.1 5269.4 5353.5 5420.8 5428.2 5448.1 6212.5 6261.5 6262.2 6295.2 6302.8 6225.8 6270.7 6276.2 6283.7 6286.6 6144.8 6206.3 6253.4 6255.1 6266.9 6090.5 6105.5 6130.1 6134.3 6148.1 6169.7 6182.5 6206.5 6241.8 6243.2 5934.9 6014.8 6031.3 6132.5 6142.8 6099.3 6110.0 6116.3 6125.3 6129.1 5966.8 5977.3 5977.8 5987.5 5996.3 5899.9 5942.3 6031.0 6120.3 6139.6 5952.4 5971.5 5974.2 5981.5 6030.2 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:53017.25 Median:353074.00 stddev:107684.51 (30.5%) stddev-sans-first:107914.33 07:10:43 INFO - PROCESS | 1664 | Values: 472.4 503.7 504.2 510.1 601.5 28730.9 36094.0 37073.4 37159.0 37224.1 40421.4 41074.0 41134.2 41187.8 41306.0 9198.4 9417.9 9422.2 9424.9 9431.1 9206.6 9291.3 9344.3 9352.4 9383.8 9325.9 9391.6 9393.3 9395.5 9396.4 9260.4 9275.7 9335.7 9338.4 9373.1 9270.6 9390.0 9392.5 9396.7 9440.3 37649.0 38137.6 38163.2 38214.6 38230.6 3311.2 3375.4 3465.0 3655.2 3776.3 26916.9 27491.7 27629.4 27678.9 27777.9 2639.0 2671.7 2678.5 2709.5 2806.0 350066.0 352926.0 353222.0 353537.0 355908.0 32501.7 54187.0 54459.0 54584.7 54792.2 34289.5 34487.3 34490.7 34491.3 34560.0 14313.9 14542.3 14565.9 14587.1 14602.6 10410.5 12461.3 12491.0 12514.9 12543.9 7851.4 7967.6 7970.0 7972.5 8037.6 2959.7 3308.1 3381.5 3382.8 3412.3 947.2 978.4 985.6 987.4 992.0 22912.3 28513.6 28631.6 28757.4 28987.7 946.8 1017.6 1054.9 1109.3 1163.1 11130.9 13934.5 14035.8 14289.9 14347.0 459520.0 461863.0 469004.0 471052.0 472129.0 52752.5 53486.5 53555.9 53574.2 53640.0 1321.3 1329.2 1476.3 1484.5 1493.2 26776.9 27026.4 27256.4 27312.6 27990.0 38741.4 39465.0 39696.0 39991.4 40054.8 385691.0 387921.0 388239.0 389882.0 390475.0 20855.3 21533.9 23335.0 23952.6 23982.4 38498.4 38865.6 38900.0 39475.2 40057.8 32384.0 32942.5 33128.8 33133.7 34119.1 31940.5 32118.8 32480.0 32708.0 32841.7 32748.5 33293.8 34315.5 34552.8 34662.0 29509.4 30282.9 30361.0 30372.7 30470.8 22965.7 23237.9 25908.6 28755.4 29887.9 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:32004.49 Median:11277.75 stddev:92908.45 (823.8%) stddev-sans-first:93138.76 07:10:43 INFO - PROCESS | 1664 | Values: 388.7 392.8 393.1 394.8 403.2 14644.4 18894.7 19507.5 20122.6 20157.9 15443.5 15853.4 19483.8 19751.1 19902.9 5578.5 5849.9 5874.8 5894.6 5902.7 3997.2 4606.6 5747.2 5796.8 5804.0 6330.3 6331.3 6332.2 6335.9 6345.8 6240.3 6306.4 6310.3 6312.2 6321.7 5352.9 5498.2 5532.0 5550.0 5552.0 23469.8 23719.5 24829.6 24862.8 24877.4 2104.8 2141.4 2322.5 2424.7 2826.0 13760.5 14266.1 14441.9 14556.1 14617.9 1721.5 1727.5 1757.7 1757.9 1760.9 101079.0 106400.4 106772.5 106790.2 108343.9 10339.3 10725.8 10734.1 10884.3 10891.2 13338.5 13444.7 13448.9 13455.9 13473.1 6994.5 7448.9 7571.7 8404.9 8546.2 6991.8 8407.5 8419.9 8510.9 8535.7 5169.9 6122.4 6488.8 6523.5 6610.3 1822.0 1849.4 1850.7 1874.1 1875.2 977.4 988.5 999.2 1003.7 1042.6 19943.6 20079.4 20302.3 20392.4 20450.7 970.8 974.7 1004.2 1009.9 1010.4 10760.3 10898.1 10900.3 10911.0 10958.7 536047.0 551384.0 552996.0 579546.0 581812.0 101688.0 101905.0 103357.0 104884.9 104927.0 1044.1 1065.3 1068.9 1089.8 1093.7 15780.6 16630.9 17473.0 17690.9 18125.5 32375.7 40161.0 41722.4 45677.9 46162.0 64158.7 65441.7 66155.7 66616.0 67571.0 6392.8 7661.5 7738.2 8150.5 8272.0 10351.8 10764.8 11851.0 12090.5 12097.5 10165.7 10212.8 10618.3 10776.6 10854.9 10033.5 10043.0 10139.5 10342.4 10421.5 6037.6 8031.6 10412.2 10497.7 10873.4 7150.1 7917.4 7922.2 8004.6 8339.3 8069.5 9999.5 10365.7 10719.5 10733.9 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5640.01 Median:4762.60 stddev:3171.74 (66.6%) stddev-sans-first:3164.81 07:10:43 INFO - PROCESS | 1664 | Values: 1422.9 1599.3 1609.3 1859.8 1985.8 7725.2 8536.0 8718.4 8744.9 8773.9 8382.8 8614.2 8618.8 8625.4 8627.9 2171.5 2414.6 2425.9 2472.9 2516.4 2494.9 2529.2 2529.7 2539.7 2544.5 2099.0 2490.9 2492.2 2497.8 2498.8 2061.2 2139.9 2353.9 2442.4 2444.9 2463.1 2476.2 2500.6 2501.3 2506.0 8860.0 8884.2 8940.6 8946.8 8947.2 4441.6 5475.5 5494.1 5502.9 5515.9 3540.0 3573.2 3677.5 3724.3 3729.6 1045.6 1066.3 1067.5 1078.5 1080.4 11426.1 11562.1 11568.7 11583.4 11590.8 4543.3 4562.0 4691.0 4691.5 4701.6 9244.0 9260.9 9267.3 9271.8 9301.9 5295.8 5305.7 5328.7 5347.1 5360.1 4235.3 4460.7 4562.4 4575.5 4992.3 3606.0 3653.9 3685.4 3719.9 3727.3 1201.7 1206.6 1219.7 1221.7 1233.2 824.0 848.8 894.7 895.5 945.7 5478.6 5695.9 5790.3 5865.4 5962.0 910.3 918.5 920.2 924.7 935.4 3680.6 3774.0 3789.6 3792.6 3826.8 10331.4 10873.2 10905.9 10918.7 10937.7 10396.0 10645.9 10868.2 10870.1 10960.0 8003.3 8165.8 8326.5 8355.4 8435.1 5635.0 5671.4 5675.3 5776.8 5867.1 9626.0 10007.2 10205.6 10244.6 10274.5 10344.4 10428.1 10430.1 10455.4 10464.4 6406.9 6659.1 6806.6 6932.2 7091.1 7007.0 8323.5 8425.0 8425.8 8447.7 7245.9 7345.3 7370.6 7493.2 7555.6 6178.7 7069.2 7220.4 7250.0 7266.5 5601.9 6742.6 6891.2 6901.2 6928.8 4702.7 4722.0 4803.2 4867.6 4965.1 4813.5 4870.9 4871.1 4913.3 5065.1 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4542.02 Median:5056.08 stddev:1389.97 (27.5%) stddev-sans-first:1357.24 07:10:43 INFO - PROCESS | 1664 | Values: 318.2 318.9 326.3 327.3 331.7 5229.5 5230.4 5277.9 5280.4 5296.8 4675.0 5061.5 5244.2 5308.5 5334.2 3343.0 3375.7 3759.0 3991.9 3999.6 3313.5 3589.9 3809.4 3906.6 3917.7 3980.5 4044.8 4072.2 4074.1 4085.9 3996.9 4063.6 4066.9 4075.2 4124.9 3380.7 3487.5 3563.2 3574.4 3615.3 4114.8 5011.9 5050.4 5054.9 5082.7 4027.7 4454.0 4627.7 4655.2 4695.4 4785.9 4879.3 5396.9 5490.6 5525.5 3910.8 3912.0 3919.0 3921.8 3941.5 5378.9 5513.6 5607.4 5776.9 5777.7 3539.5 3934.2 3959.7 3965.2 4036.5 3780.5 3979.7 4022.4 4026.8 4031.8 3776.6 4623.7 4645.3 4652.6 4659.2 5472.8 5510.2 5544.6 5559.0 5636.8 1242.6 1314.7 1360.0 1491.8 1494.3 789.3 884.2 958.4 1008.2 1011.5 5023.2 5560.7 5566.2 5572.4 5657.7 4659.0 5855.5 6018.2 6101.8 6206.7 3899.9 5251.5 5361.6 5538.7 5591.6 3314.4 3321.9 3331.4 3338.1 3362.3 5247.3 5256.8 6308.7 6581.0 6640.3 5196.7 5929.3 5944.3 5999.8 6025.7 5697.1 5882.9 6001.6 6065.8 6068.5 4913.0 5552.9 5756.5 5829.8 5831.6 5305.4 5724.9 5756.6 5771.7 5803.4 4531.5 4957.7 5126.4 5268.8 5701.4 3298.9 3381.8 3417.8 3819.8 3851.6 4840.0 5057.2 5214.2 5563.1 5618.6 3958.6 4941.8 5597.7 5629.4 5640.5 4703.9 5623.0 5632.9 5654.5 5685.4 5144.2 5204.5 5550.0 5551.3 5561.2 4893.7 5589.4 5615.3 5619.7 5665.9 4958.5 5186.2 5453.3 5506.7 5525.8 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18107.78 Median:563.14 stddev:25873.88 (4594.6%) stddev-sans-first:25913.53 07:10:43 INFO - PROCESS | 1664 | Values: 721.2 729.1 740.3 743.4 756.3 14513.6 14960.4 15039.7 15040.9 15083.8 13775.9 13852.1 13863.5 13866.7 13881.2 704.8 729.8 871.8 890.4 911.4 890.8 894.6 899.0 902.1 902.1 965.3 969.4 971.5 971.6 972.3 748.9 934.8 963.6 966.0 981.2 719.9 721.6 721.7 721.7 722.5 14723.7 14825.9 14829.0 14844.9 14850.5 12066.2 12285.1 12400.9 12623.7 12676.2 9600.9 10055.6 10074.8 10391.4 10472.7 3405.5 3446.7 3494.6 3523.5 3558.8 73965.0 74365.3 74435.1 74661.3 75025.6 9106.0 9169.1 9382.8 9838.2 10138.2 19835.0 20115.2 20125.1 20129.5 20131.6 7374.4 7374.8 7474.2 7561.2 7589.9 4087.3 4151.9 4166.2 4211.1 4242.6 3420.8 3480.1 3480.4 3482.7 3487.3 649.1 660.7 692.6 698.0 698.3 565.5 570.9 587.4 600.8 600.9 7945.4 8160.0 8231.8 8363.4 8416.7 495.4 526.6 560.8 581.7 589.3 3658.2 3874.5 3877.1 3982.4 4051.1 96137.5 100194.5 101286.0 101293.0 101794.5 78331.6 79830.0 80560.8 82785.6 83237.6 69056.7 74325.5 74550.0 74778.9 75176.2 7689.0 7793.3 7885.2 7904.1 7962.6 40713.4 41277.6 41824.2 42497.2 47819.8 61056.0 62425.7 62634.7 62702.7 63600.0 10329.2 10461.9 10546.2 10901.3 11325.9 11971.6 12029.0 12309.3 12445.6 12523.3 11404.1 11418.7 11419.7 11466.8 11563.2 11157.9 11198.5 11222.6 11409.7 11606.9 10582.4 11206.1 11379.3 11419.9 11523.7 9027.3 9427.3 9545.9 9740.6 9928.0 8568.7 10036.2 10049.9 10055.2 10060.2 07:10:43 INFO - PROCESS | 1664 | -------- Summary: end -------- 07:10:43 INFO - PROCESS | 1664 | 07:10:43 INFO - TEST-INFO | 1664: exit 0 07:10:43 INFO - TEST-OK | dromaeo_css | took 1115238ms 07:10:43 INFO - TEST-START | kraken 07:10:43 INFO - operating with platform_type : mac_ 07:10:43 INFO - Initialising browser for kraken test... 07:10:43 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp1wLx62/profile http://localhost:49275/getInfo.html) 07:10:45 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 07:10:45 INFO - PROCESS | 1670 | colorDepth:24 07:10:45 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 07:10:45 INFO - PROCESS | 1670 | __metrics 07:10:45 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:10:45 ERROR - PROCESS | 1670 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:10:46 INFO - TEST-INFO | 1670: exit 0 07:10:46 INFO - Browser initialized. 07:10:46 INFO - Running cycle 1/1 for kraken test... 07:10:46 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp1wLx62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:58 INFO - PROCESS | 1672 | RSS: Main: 239636480 07:10:58 INFO - PROCESS | 1672 | 07:11:01 INFO - PROCESS | 1672 | 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) 07:11:02 INFO - PROCESS | 1672 | RSS: Main: 287395840 07:11:02 INFO - PROCESS | 1672 | 07:11:04 INFO - PROCESS | 1672 | 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) 07:11:05 INFO - PROCESS | 1672 | RSS: Main: 299851776 07:11:05 INFO - PROCESS | 1672 | 07:11:08 INFO - PROCESS | 1672 | 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) 07:11:09 INFO - PROCESS | 1672 | RSS: Main: 386199552 07:11:09 INFO - PROCESS | 1672 | 07:11:11 INFO - PROCESS | 1672 | 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) 07:11:12 INFO - PROCESS | 1672 | RSS: Main: 287363072 07:11:12 INFO - PROCESS | 1672 | 07:11:14 INFO - PROCESS | 1672 | 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) 07:11:15 INFO - PROCESS | 1672 | RSS: Main: 292028416 07:11:15 INFO - PROCESS | 1672 | 07:11:17 INFO - PROCESS | 1672 | 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) 07:11:18 INFO - PROCESS | 1672 | RSS: Main: 329482240 07:11:18 INFO - PROCESS | 1672 | 07:11:21 INFO - PROCESS | 1672 | 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) 07:11:21 INFO - PROCESS | 1672 | RSS: Main: 332300288 07:11:21 INFO - PROCESS | 1672 | 07:11:24 INFO - PROCESS | 1672 | 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) 07:11:25 INFO - PROCESS | 1672 | RSS: Main: 329875456 07:11:25 INFO - PROCESS | 1672 | 07:11:26 INFO - PROCESS | 1672 | 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) 07:11:27 INFO - PROCESS | 1672 | RSS: Main: 321908736 07:11:27 INFO - PROCESS | 1672 | 07:11:29 INFO - PROCESS | 1672 | 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) 07:11:29 INFO - PROCESS | 1672 | RSS: Main: 329265152 07:11:29 INFO - PROCESS | 1672 | 07:11:32 INFO - PROCESS | 1672 | 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) 07:11:32 INFO - PROCESS | 1672 | RSS: Main: 330629120 07:11:32 INFO - PROCESS | 1672 | 07:11:35 INFO - PROCESS | 1672 | 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) 07:11:36 INFO - PROCESS | 1672 | RSS: Main: 326680576 07:11:36 INFO - PROCESS | 1672 | 07:11:39 INFO - PROCESS | 1672 | 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) 07:11:40 INFO - PROCESS | 1672 | RSS: Main: 326352896 07:11:40 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | 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) 07:11:42 INFO - PROCESS | 1672 | RSS: Main: 391098368 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | __start_tp_report 07:11:42 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 07:11:42 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 07:11:42 INFO - PROCESS | 1672 | |i|pagename|runs| 07:11:42 INFO - PROCESS | 1672 | |0;ai-astar;113;113;109;115;112;114;113;113;106;113 07:11:42 INFO - PROCESS | 1672 | |1;audio-beat-detection;159;122;145;168;118;141;142;133;213;146 07:11:42 INFO - PROCESS | 1672 | |2;audio-dft;189;185;186;188;185;186;183;187;184;185 07:11:42 INFO - PROCESS | 1672 | |3;audio-fft;78;71;87;97;76;82;82;99;87;55 07:11:42 INFO - PROCESS | 1672 | |4;audio-oscillator;90;102;135;79;83;80;128;78;78;128 07:11:42 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;87;85;87;86;87;83;89;86;89;85 07:11:42 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;94;95;94;93;94;95;94;94;93 07:11:42 INFO - PROCESS | 1672 | |7;imaging-desaturate;85;87;85;84;85;84;87;86;86;89 07:11:42 INFO - PROCESS | 1672 | |8;json-parse-financial;61;61;60;61;60;59;59;79;59;58 07:11:42 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;63;74;76;72;72;65;69;66;66;67 07:11:42 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;83;83;83;82;83;86;87;103;103;84 07:11:42 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;153;162;157;136;139;139;141;157;198;163 07:11:42 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;203;201;262;210;204;201;201;200;198;195 07:11:42 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;70;70;70;69;71;68;72;72;71;68 07:11:42 INFO - PROCESS | 1672 | __end_tp_report 07:11:42 INFO - PROCESS | 1672 | __start_cc_report 07:11:42 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,2031 07:11:42 INFO - PROCESS | 1672 | __end_cc_report 07:11:42 INFO - PROCESS | 1672 | __startTimestamp1461679902351__endTimestamp 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | ------- Summary: start ------- 07:11:42 INFO - PROCESS | 1672 | Number of tests: 14 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.64 (2.3%) stddev-sans-first:2.78 07:11:42 INFO - PROCESS | 1672 | Values: 113.0 113.0 109.0 115.0 112.0 114.0 113.0 113.0 106.0 113.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:145.50 stddev:27.16 (18.7%) stddev-sans-first:28.55 07:11:42 INFO - PROCESS | 1672 | Values: 159.0 122.0 145.0 168.0 118.0 141.0 142.0 133.0 213.0 146.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.00 stddev:1.81 (1.0%) stddev-sans-first:1.51 07:11:42 INFO - PROCESS | 1672 | Values: 189.0 185.0 186.0 188.0 185.0 186.0 183.0 187.0 184.0 185.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:81.40 Median:84.50 stddev:12.75 (15.1%) stddev-sans-first:13.46 07:11:42 INFO - PROCESS | 1672 | Values: 78.0 71.0 87.0 97.0 76.0 82.0 82.0 99.0 87.0 55.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:78.50 stddev:23.47 (29.9%) stddev-sans-first:24.71 07:11:42 INFO - PROCESS | 1672 | Values: 90.0 102.0 135.0 79.0 83.0 80.0 128.0 78.0 78.0 128.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 07:11:42 INFO - PROCESS | 1672 | Values: 87.0 85.0 87.0 86.0 87.0 83.0 89.0 86.0 89.0 85.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 07:11:42 INFO - PROCESS | 1672 | Values: 93.0 94.0 95.0 94.0 93.0 94.0 95.0 94.0 94.0 93.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.62 07:11:42 INFO - PROCESS | 1672 | Values: 85.0 87.0 85.0 84.0 85.0 84.0 87.0 86.0 86.0 89.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:60.50 stddev:6.17 (10.2%) stddev-sans-first:6.53 07:11:42 INFO - PROCESS | 1672 | Values: 61.0 61.0 60.0 61.0 60.0 59.0 59.0 79.0 59.0 58.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:70.50 stddev:4.29 (6.1%) stddev-sans-first:3.97 07:11:42 INFO - PROCESS | 1672 | Values: 63.0 74.0 76.0 72.0 72.0 65.0 69.0 66.0 66.0 67.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:83.00 stddev:8.21 (9.9%) stddev-sans-first:8.53 07:11:42 INFO - PROCESS | 1672 | Values: 83.0 83.0 83.0 82.0 83.0 86.0 87.0 103.0 103.0 84.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:157.00 stddev:18.38 (11.7%) stddev-sans-first:19.49 07:11:42 INFO - PROCESS | 1672 | Values: 153.0 162.0 157.0 136.0 139.0 139.0 141.0 157.0 198.0 163.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.50 Median:202.00 stddev:19.55 (9.7%) stddev-sans-first:20.66 07:11:42 INFO - PROCESS | 1672 | Values: 203.0 201.0 262.0 210.0 204.0 201.0 201.0 200.0 198.0 195.0 07:11:42 INFO - PROCESS | 1672 | 07:11:42 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.45 (2.1%) stddev-sans-first:1.54 07:11:42 INFO - PROCESS | 1672 | Values: 70.0 70.0 70.0 69.0 71.0 68.0 72.0 72.0 71.0 68.0 07:11:42 INFO - PROCESS | 1672 | -------- Summary: end -------- 07:11:42 INFO - PROCESS | 1672 | 07:11:43 INFO - TEST-INFO | 1672: exit 0 07:11:43 INFO - TEST-OK | kraken | took 59472ms 07:11:43 INFO - SUITE-END | took 1174s 07:11:43 INFO - Completed test suite (00:19:35) 07:11:43 INFO - javascript benchmark 07:11:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.561177046984, 3437.6046754623226, 3439.501272315514, 3459.740519461041, 3503.1942653189767, 4663.790129444174, 5573.024720673876, 5631.774729010835, 5660.377358490573, 5694.2312787773635, 5605.467480589347, 5626.831195064145, 5686.3744988051285, 5815.5638327125425, 5827.1550625159325, 5074.112030394685, 5113.795448182068, 5124.769385377667, 5126.974365128169, 5179.119549676545, 5210.739463026853, 5214.921776173361, 5229.927864787709, 5249.8950020999555, 5308.23030660554, 5111.1566591512355, 5123.948760512384, 5165.793368265265, 5219.06056909758, 5257.0274499217385, 5189.351331083614, 5203.739813009334, 5220.2430647556275, 5220.791168353261, 5226.764795584208, 5144.768485418165, 5189.0, 5202.167653175474, 5223.582113430916, 5240.659357141812, 5485.314335708036, 5587.189857470644, 5597.244372009808, 5610.961972035187, 5698.572607054446, 6171.039359226593, 6208.068789681539, 6223.688815559204, 6223.68881555925, 6236.158118653969, 6221.097940798559, 6270.592411493284, 6271.78048768291, 6300.87398252037, 6309.71606277714, 5701.828945131652, 5747.885042299215, 5813.476787089182, 5815.534757219412, 5818.069108942549, 6230.345813689497, 6254.937450625526, 6258.687065646699, 6259.061140828821, 6265.655388953652, 6078.817635470943, 6129.816105516842, 6133.693315334215, 6141.170941922873, 6141.324454310023, 6069.605475644069, 6145.310039739107, 6147.139400483936, 6149.923763341398, 6265.624062556261, 6110.022396416552, 6114.540688159395, 6137.662428566472, 6137.877242455215, 6167.722452489559, 6202.100695399142, 6225.097360882647, 6229.563930524911, 6235.438810506986, 6256.749730010749, 4228.9154216915485, 4890.608751299958, 4903.26451032348, 4919.827806026772, 4928.408590969035, 4362.76004819738, 4366.607005369532, 4457.77711114443, 4480.39514665516, 4486.1252055849445, 5657.15142728594, 5657.547396208293, 5659.773609055592, 5674.375818659944, 5694.402087780723, 5855.560832937546, 5882.0, 6247.0, 6255.280642726054, 6280.246370435577, 5418.539424148913, 5532.446755324516, 5540.0, 5544.750486228129, 5560.110382338807, 5269.420363759983, 5353.491418315254, 5420.810271640474, 5428.212909128154, 5448.128299472065, 6212.502999760009, 6261.530385221035, 6262.15460912771, 6295.24457065146, 6302.810915672537, 6225.835825425805, 6270.7491700331475, 6276.215473065867, 6283.654399008098, 6286.559940804283, 6144.801763656044, 6206.317305096526, 6253.37466253371, 6255.124282600348, 6266.905996410149, 6090.458580988912, 6105.48103411215, 6130.080487926846, 6134.263888333428, 6148.077788331607, 6169.691515424301, 6182.505399568114, 6206.534509911684, 6241.843953901189, 6243.219597550306, 5934.940650593611, 6014.849628759316, 6031.276246850406, 6132.5400594956445, 6142.846428839136, 6099.329073801967, 6110.022396416552, 6116.3272040076445, 6125.264968203844, 6129.08063790435, 5966.791162309472, 5977.312609049841, 5977.790777322773, 5987.520998320211, 5996.310424301087, 5899.911501327398, 5942.286925568959, 6030.969845150922, 6120.2947619997085, 6139.631622102688, 5952.404759524013, 5971.462568368867, 5974.2233509643465, 5981.52147828164, 6030.155778190969], "value": 5670.261658013194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.4307209812177, 503.71791796593885, 504.2134270537961, 510.12768166435393, 601.5037593984963, 28730.856345718268, 36094.0, 37073.443898341546, 37159.0, 37224.069398265055, 40421.393679094836, 41073.97315067125, 41134.17731645365, 41187.79406102965, 41306.0, 9198.402103863227, 9417.858732119024, 9422.199113075398, 9424.858627120599, 9431.104045115702, 9206.631734730636, 9291.349605527615, 9344.2524598032, 9352.438853668767, 9383.81232375352, 9325.860112098324, 9391.62433502659, 9393.29550283728, 9395.483248421335, 9396.436213827157, 9260.351775375726, 9275.721728348093, 9335.673251436236, 9338.393004454689, 9373.109554592269, 9270.629174832999, 9390.014048524874, 9392.48341341226, 9396.718098457057, 9440.339176257665, 37649.0, 38137.61862381369, 38163.23673526542, 38214.617853821386, 38230.617693822984, 3311.172206948263, 3375.3586818504405, 3464.9653503464897, 3655.1593133579427, 3776.2636285924254, 26916.865415672994, 27491.725082749315, 27629.447411051668, 27678.861605692044, 27777.86111069452, 2639.018859329913, 2671.7461841125064, 2678.531257030012, 2709.4716530276605, 2805.9719402805913, 350066.0, 352926.0, 353222.0, 353537.0, 355908.0, 32501.674983249864, 54187.0, 54459.0, 54584.72707636436, 54792.17811732827, 34289.48565771515, 34487.310253794785, 34490.655093448746, 34491.31017379638, 34559.96320110401, 14313.85686143146, 14542.345594448276, 14565.854341456661, 14587.124772513684, 14602.634934126732, 10410.47947602632, 12461.252324860356, 12491.000719942384, 12514.937425312997, 12543.8710516054, 7851.411144164211, 7967.641456134488, 7969.960150199212, 7972.521648701097, 8037.598120093972, 2959.674435812059, 3308.123347312964, 3381.458966565338, 3382.797032178077, 3412.334594753999, 947.2422062350092, 978.3591747405461, 985.5860538573672, 987.4026214140486, 991.9603215871284, 22912.31263062111, 28513.572296415572, 28631.57052644212, 28757.42485150327, 28987.7101228985, 946.7633091727068, 1017.6031347774374, 1054.8892366301582, 1109.290054365207, 1163.0927876256533, 11130.888691113147, 13934.512292069932, 14035.78946315806, 14289.857101428852, 14347.0, 459520.0, 461863.0, 469004.0, 471052.0, 472129.0, 52752.47247527552, 53486.465135348146, 53555.92888142215, 53574.196387054224, 53640.0, 1321.2666969831644, 1329.2489743295007, 1476.3282706368577, 1484.4952716076587, 1493.2309860421892, 26776.866115670076, 27026.411544840063, 27256.41243545029, 27312.629979204026, 27990.0, 38741.418878717406, 39465.01337466586, 39696.00759981023, 39991.40012899867, 40054.79972600118, 385691.0, 387921.0, 388239.0, 389882.0, 390475.0, 20855.270065547633, 21533.89233053825, 23335.0, 23952.56284622928, 23982.40043998914, 38498.422523662724, 38865.6113438862, 38900.027499312746, 39475.210495789346, 40057.79971100242, 32384.0, 32942.50586241256, 33128.83435582807, 33133.66866331306, 34119.147021323675, 31940.5208921871, 32118.83940580282, 32480.0, 32708.0, 32841.67158328386, 32748.50877236891, 33293.83353083219, 34315.4852677215, 34552.827235864665, 34662.0, 29509.409811803213, 30282.940097096496, 30361.0, 30372.684780163825, 30470.847645762515, 22965.655515166953, 23237.88381058084, 25908.611370829076, 28755.424891502473, 29887.850560747927], "value": 17052.656250359167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7007004606453, 392.7996721671947, 393.0762707637052, 394.77497826239056, 403.197636702961, 14644.414223431077, 18894.716579251322, 19507.5123121922, 20122.59754804905, 20157.899210503947, 15443.45947891824, 15853.365865365371, 19483.805161948378, 19751.111199995998, 19902.90048549759, 5578.525825304844, 5849.912251316234, 5874.823755287327, 5894.58737888348, 5902.675352855591, 3997.2005598880196, 4606.631469482433, 5747.166660834177, 5796.82609521715, 5804.042333015047, 6330.33531479195, 6331.2719037310835, 6332.176817013782, 6335.873282534347, 6345.841353966165, 6240.31356550779, 6306.400891915261, 6310.305866354744, 6312.210973628296, 6321.683915804214, 5352.866178345534, 5498.202760599731, 5531.9723401383135, 5550.0, 5552.0, 23469.76530234693, 23719.525609487715, 24829.6275555865, 24862.751372486226, 24877.378065548324, 2104.8105670489576, 2141.4432247615578, 2322.465832858435, 2424.733279339271, 2826.039146690135, 13760.518381856687, 14266.072705274124, 14441.855581444157, 14556.126632402089, 14617.92691036538, 1721.535185499908, 1727.5422013166522, 1757.7011907975675, 1757.903315317657, 1760.9119544022747, 101079.0, 106400.40399393938, 106772.46613766959, 106790.15739569836, 108343.91656083417, 10339.327943683636, 10725.83911241332, 10734.141268698486, 10884.292520986111, 10891.183161262938, 13338.533151339656, 13444.663883402798, 13448.865511344957, 13455.865441345657, 13473.124246923919, 6994.545354551938, 7448.925510744823, 7571.659275332623, 8404.873926891101, 8546.230839224376, 6991.825204369829, 8407.45351552147, 8419.873701894476, 8510.914890851136, 8535.743927682179, 5169.896602067937, 6122.418370254819, 6488.772892948724, 6523.528912795157, 6610.272869984298, 1821.9817801822078, 1849.4451664500596, 1850.7316439116253, 1874.1097978460396, 1875.1842948317526, 977.4233202410612, 988.5205675247499, 999.2206079258191, 1003.7390278527489, 1042.629866397418, 19943.603947723812, 20079.39761807148, 20302.289419870234, 20392.388228353175, 20450.693239601416, 970.8349580571179, 974.7270764186039, 1004.1765752083221, 1009.9141572966233, 1010.4038617215731, 10760.300580462244, 10898.07366373867, 10900.34597924127, 10910.963458471433, 10958.671239862817, 536047.0, 551384.0, 552996.0, 579546.0, 581812.0, 101688.0, 101905.0, 103357.0, 104884.90230195507, 104927.0, 1044.060345688871, 1065.2543219746208, 1068.8877667844765, 1089.803835309652, 1093.7375029992745, 15780.60548486297, 16630.91684541618, 17473.038982856066, 17690.91154544219, 18125.546861328046, 32375.67624323821, 40161.0, 41722.374164388166, 45677.85805354892, 46162.0, 64158.679206603665, 65441.672791635734, 66155.66922165359, 66616.0, 67571.0, 6392.840178995562, 7661.463697541119, 7738.226177382442, 8150.510969341858, 8272.04871439792, 10351.84472232902, 10764.838527421938, 11850.992665623518, 12090.51637934508, 12097.516099355928, 10165.745856353651, 10212.846807297748, 10618.309809862334, 10776.568937242422, 10854.945725271324, 10033.548490318099, 10043.045910638477, 10139.543720532742, 10342.37945723259, 10421.478926053818, 6037.577369584087, 8031.598420078856, 10412.167026638002, 10497.685069447929, 10873.401962891801, 7150.141982962078, 7917.445778795429, 7922.207779222032, 8004.559749213616, 8339.291160251447, 8069.475484093515, 9999.500024998575, 10365.74085647865, 10719.517621706886, 10733.892661073289], "value": 9252.358467905702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.8506006869286, 1599.2883166990691, 1609.283868678438, 1859.8419134373578, 1985.8113479219478, 7725.227477252279, 8536.0, 8718.433301835375, 8744.8688269676, 8773.903262092239, 8382.832343353144, 8614.224719775235, 8618.827623447527, 8625.439346442492, 8627.913720862789, 2171.457135716071, 2414.61366181411, 2425.8544487330773, 2472.8887200076038, 2516.4338023944556, 2494.887730052152, 2529.178017144426, 2529.6964364276314, 2539.669842920418, 2544.5165418570505, 2098.9580208395823, 2490.887910044043, 2492.2024952015363, 2497.825152239344, 2498.837575557592, 2061.175529788089, 2139.850210485267, 2353.9293821185393, 2442.413820683041, 2444.8533088014774, 2463.064035666453, 2476.2199907029226, 2500.624906264057, 2501.3371456564023, 2505.974940250592, 8860.0, 8884.156005179497, 8940.64237430502, 8946.776330591787, 8947.239484643813, 4441.600255976945, 5475.479829416199, 5494.09347457669, 5502.944970550283, 5515.944840551623, 3540.026377842599, 3573.213892943574, 3677.485152078711, 3724.2923844469465, 3729.6083911189207, 1045.5974449836792, 1066.2642776484279, 1067.5302866738689, 1078.5308390849927, 1080.4057768227444, 11426.08591312693, 11562.132840036948, 11568.652940411801, 11583.420828958519, 11590.768184636345, 4543.250363689954, 4561.954380456219, 4690.9765451172525, 4691.483936766953, 4701.6003639690325, 9243.95378023119, 9260.907390926139, 9267.304952128618, 9271.76820579491, 9301.906980930104, 5295.814646487354, 5305.708186049805, 5328.733563321818, 5347.0909945309395, 5360.115580929181, 4235.2800023996, 4460.710053846489, 4562.361269422284, 4575.542445755398, 4992.326035985096, 3605.9819700901853, 3653.926921461556, 3685.355062863988, 3719.8698045568276, 3727.3290807654885, 1201.6635342104225, 1206.5535751771724, 1219.7011732125686, 1221.7434338788776, 1233.216907263876, 823.9958800206081, 848.8090179709516, 894.6689724801735, 895.5164211325941, 945.744648944781, 5478.561715062785, 5695.943040569541, 5790.314528207688, 5865.442782935615, 5962.0, 910.2808781062886, 918.5085979001202, 920.2362039507193, 924.690228773355, 935.3639525122845, 3680.595134535199, 3774.037620406779, 3789.5642001170218, 3792.58281589025, 3826.8086595670106, 10331.431771252654, 10873.184511161695, 10905.890941090645, 10918.672439826818, 10937.726556835984, 10396.012378824, 10645.893541064645, 10868.184886133571, 10870.130389568816, 10960.013598776148, 8003.279704826594, 8165.755027349189, 8326.45878017927, 8355.415120941598, 8435.114312997048, 5635.0, 5671.404502527175, 5675.31896172462, 5776.768929242951, 5867.090600956859, 9626.0, 10007.199424046205, 10205.591776328863, 10244.64143754965, 10274.537645805807, 10344.431056291976, 10428.061474467335, 10430.113440357654, 10455.372677639367, 10464.372137671764, 6406.935930640634, 6659.101021362054, 6806.591604503746, 6932.168139823253, 7091.11361079865, 7007.0, 8323.458975166595, 8424.957875210584, 8425.789355266168, 8447.662093516436, 7245.891311630225, 7345.265473452612, 7370.6314684266645, 7493.175750667531, 7555.584442855696, 6178.7219575120125, 7069.22238553769, 7220.422366210795, 7249.963750181215, 7266.491345605757, 5601.887962240814, 6742.6291553965, 6891.207511136284, 6901.206361268318, 6928.792136235921, 4702.670813043054, 4722.0, 4803.207470767285, 4867.561919427269, 4965.106280869478, 4813.4945830687275, 4870.9269360960325, 4871.123197824426, 4913.312136300992, 5065.113605119016], "value": 4543.853305624696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.2378204200939, 318.91070500259934, 326.2561360098975, 327.3240757835071, 331.7279830538959, 5229.529342359187, 5230.42465328814, 5277.868053298669, 5280.445553216915, 5296.788128474856, 4675.018246168309, 5061.468545802693, 5244.187150991593, 5308.522232999029, 5334.199870019499, 3342.983285083571, 3375.71306438953, 3758.951371502524, 3991.9201615967663, 3999.5800440953717, 3313.486409606515, 3589.856405743767, 3809.4285857121513, 3906.61696365217, 3917.7061720371084, 3980.4825372701507, 4044.777537235451, 4072.2059198456313, 4074.127739943333, 4085.8569950051756, 3996.9400458993136, 4063.573324800898, 4066.877993660195, 4075.2257071156682, 4124.8556300529635, 3380.729541636688, 3487.511748355232, 3563.2160924596806, 3574.4459608760685, 3615.313090512794, 4114.835406583763, 5011.924821127686, 5050.39395272566, 5054.9494505054845, 5082.695038297714, 4027.677785777131, 4453.953320969569, 4627.652926030528, 4655.208614535537, 4695.3661255730385, 4785.880352991168, 4879.341288925985, 5396.892062158774, 5490.56075513958, 5525.475079867406, 3910.843566257346, 3912.0, 3919.0, 3921.784301863396, 3941.507311586052, 5378.892422151535, 5513.5864810139, 5607.43925607436, 5776.855578610526, 5777.653340799566, 3539.486774417695, 3934.213157368538, 3959.664167736324, 3965.2267807777207, 4036.535798383165, 3780.527434070741, 3979.741316814456, 4022.3966405039478, 4026.8187931543152, 4031.7703100554613, 3776.6412190841825, 4623.722576645412, 4645.349651048856, 4652.55800698933, 4659.161350956861, 5472.781088756406, 5510.173473978935, 5544.63959842609, 5559.0, 5636.774529018793, 1242.6085782978332, 1314.6976195475095, 1359.9664255166144, 1491.8060652115155, 1494.290212149242, 789.3251270163927, 884.2086332732168, 958.3529389170078, 1008.2186305613209, 1011.4790882695418, 5023.221400682827, 5560.694161821058, 5566.151726066227, 5572.414896435897, 5657.745401456944, 4658.95341046592, 5855.502282306052, 6018.21763170785, 6101.840650276433, 6206.72069756862, 3899.883003509899, 5251.501107394792, 5361.624686271924, 5538.667679939216, 5591.608587398843, 3314.436545787222, 3321.8837340692958, 3331.4003479373946, 3338.1487720631085, 3362.260302733395, 5247.291615631841, 5256.763445644955, 6308.706715123389, 6581.012848072732, 6640.302768209365, 5196.662216955961, 5929.288485381781, 5944.256967879015, 5999.760009599654, 6025.698715064317, 5697.145428185805, 5882.882342353215, 6001.639901605918, 6065.757369705162, 6068.4538391544975, 4913.0, 5552.916706249329, 5756.539476841926, 5829.8251052468495, 5831.620944638585, 5305.363356397257, 5724.856878578069, 5756.56825738063, 5771.7114144293455, 5803.361630220588, 4531.501534831232, 4957.7273249971595, 5126.410462796826, 5268.841934741964, 5701.4298570142655, 3298.861892647033, 3381.7970921744773, 3417.760756747004, 3819.7708137511836, 3851.614838516126, 4839.975800120977, 5057.216131499624, 5214.165733482625, 5563.108543095367, 5618.606697531297, 3958.6239307265764, 4941.802327906988, 5597.748101335368, 5629.380768115586, 5640.54875609942, 4703.929441058455, 5622.959752445647, 5632.887342253214, 5654.547636189012, 5685.431456854447, 5144.2252422915535, 5204.531592156724, 5549.972250138723, 5551.306086739158, 5561.221429000024, 4893.74887551716, 5589.357223919302, 5615.298087739033, 5619.747111379916, 5665.886682266414, 4958.479359667183, 5186.222066690027, 5453.263809385682, 5506.704770279189, 5525.806596769094], "value": 4113.513552881569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1850608812042, 729.1468981291891, 740.2523451314171, 743.3867059675769, 756.2588663110148, 14513.637159071028, 14960.401583936657, 15039.699206015874, 15040.947133700633, 15083.849161508395, 13775.897928165748, 13852.099613525113, 13863.514776982807, 13866.722665546684, 13881.236531990737, 704.8132244955091, 729.7883613752006, 871.790770215147, 890.3722875372847, 911.4166933162782, 890.7951171230621, 894.6332003878412, 899.0290486274807, 902.0798785239052, 902.1339514066505, 965.2615748952057, 969.4328817641688, 971.4754032822267, 971.5822196455522, 972.290228133463, 748.9026426564538, 934.7522906429801, 963.5663951221943, 966.0146650416606, 981.2297346582898, 719.8668246374385, 721.6463932672953, 721.72935149319, 721.7365661533555, 722.5267449820376, 14723.705525889422, 14825.925870370687, 14829.036112652642, 14844.851551484455, 14850.480233191787, 12066.22476830334, 12285.14004019719, 12400.937995309965, 12623.684407889785, 12676.2394256344, 9600.939200684497, 10055.59777608902, 10074.848877266846, 10391.37651740898, 10472.738181545446, 3405.455127179664, 3446.724262059054, 3494.5631796025496, 3523.489094081344, 3558.822058897045, 73965.0, 74365.25634743637, 74435.13912152185, 74661.25338746597, 75025.62487187529, 9106.0, 9169.128932751379, 9382.765430864283, 9838.16375608067, 10138.239632027628, 19835.0, 20115.19539218415, 20125.09437075335, 20129.496762581053, 20131.597368052557, 7374.446916481285, 7374.777271827382, 7474.177840437547, 7561.168271490132, 7589.8861517077285, 4087.325591277406, 4151.8546850860075, 4166.229247589205, 4211.136716973075, 4242.575742425733, 3420.7776494528275, 3480.129967508123, 3480.3561341151462, 3482.669146431085, 3487.3199726053176, 649.133406901782, 660.725798793505, 692.6086760980131, 698.0401947322432, 698.2703075286338, 565.457161125316, 570.9029464990879, 587.4389957590491, 600.8107446154447, 600.9158717779515, 7945.364370850318, 8159.959200203961, 8231.794205144919, 8363.372747043873, 8416.747497575083, 495.3510900720068, 526.5892603769066, 560.8177342363748, 581.668448984075, 589.3340525206489, 3658.1951970566433, 3874.4769456123627, 3877.1276462795645, 3982.38273067675, 4051.148241093221, 96137.51931240299, 100194.49513762069, 101285.98714012913, 101293.0, 101794.49102754438, 78331.60834195792, 79830.0, 80560.75980355393, 82785.58607206926, 83237.58381208056, 69056.6547167261, 74325.5134897299, 74550.0, 74778.94905206708, 75176.24823751692, 7689.0, 7793.29860312552, 7885.1720569339395, 7904.091029531677, 7962.601869906597, 40713.38929916113, 41277.587224127376, 41824.163516728884, 42497.15005699931, 47819.76090119527, 61056.0, 62425.68787156035, 62634.68682656557, 62702.686486567276, 63600.045999310976, 10329.225308102074, 10461.9476902615, 10546.20903432261, 10901.34591924487, 11325.943370283096, 11971.64085077449, 12029.0, 12309.26144431337, 12445.564405245774, 12523.311217883103, 11404.087672986307, 11418.65932394601, 11419.714507137389, 11466.77066458683, 11563.248388854698, 11157.944210279222, 11198.496067676811, 11222.607208747655, 11409.657710268706, 11606.94196529012, 10582.365058096231, 11206.144697720516, 11379.26034807768, 11419.942900285445, 11523.711907202052, 9027.277817774693, 9427.293422261295, 9545.90454095478, 9740.561674724797, 9928.007199280015, 8568.700095496628, 10036.247281454067, 10049.902278837651, 10055.189390931446, 10060.162254271152], "value": 6837.464780348993, "unit": "score"}], "name": "dromaeo_css", "value": 6966.852142205598, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 109.0, 115.0, 112.0, 114.0, 113.0, 113.0, 106.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 145.0, 168.0, 118.0, 141.0, 142.0, 133.0, 213.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 186.0, 188.0, 185.0, 186.0, 183.0, 187.0, 184.0, 185.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 87.0, 97.0, 76.0, 82.0, 82.0, 99.0, 87.0, 55.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 102.0, 135.0, 79.0, 83.0, 80.0, 128.0, 78.0, 78.0, 128.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 86.0, 87.0, 83.0, 89.0, 86.0, 89.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 84.0, 85.0, 84.0, 87.0, 86.0, 86.0, 89.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 60.0, 59.0, 59.0, 79.0, 59.0, 58.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 74.0, 76.0, 72.0, 72.0, 65.0, 69.0, 66.0, 66.0, 67.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 83.0, 86.0, 87.0, 103.0, 103.0, 84.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 162.0, 157.0, 136.0, 139.0, 139.0, 141.0, 157.0, 198.0, 163.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 201.0, 262.0, 210.0, 204.0, 201.0, 201.0, 200.0, 198.0, 195.0], "value": 207.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 71.0, 68.0, 72.0, 72.0, 71.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1542.6999999999998, "alertThreshold": 2.0}]} 07:11:43 INFO - Return code: 0 07:11:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:43 ERROR - # TBPL SUCCESS # 07:11:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:43 INFO - 2016-04-26 07:11:43.660 screenresolution[1676:9892] starting screenresolution argv=screenresolution get 07:11:43 INFO - 2016-04-26 07:11:43.663 screenresolution[1676:9892] Display 0: 1600x1200x32@60 07:11:43 INFO - 2016-04-26 07:11:43.669 screenresolution[1677:9895] starting screenresolution argv=screenresolution list 07:11:43 INFO - Available Modes on Display 0 07:11:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:43 INFO - Intel Iris: 07:11:43 INFO - Chipset Model: Intel Iris 07:11:43 INFO - Type: GPU 07:11:43 INFO - Bus: Built-In 07:11:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:43 INFO - Vendor: Intel (0x8086) 07:11:43 INFO - Device ID: 0x0a2e 07:11:43 INFO - Revision ID: 0x0009 07:11:43 INFO - Displays: 07:11:43 INFO - Display: 07:11:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:43 INFO - Display Serial Number: 1600x1200 60 07:11:43 INFO - Main Display: Yes 07:11:43 INFO - Mirror: Off 07:11:43 INFO - Online: Yes 07:11:43 INFO - Rotation: Supported 07:11:43 INFO - Return code: 0 07:11:43 INFO - Running post-action listener: _resource_record_post_action 07:11:43 INFO - Running post-run listener: _resource_record_post_run 07:11:44 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37893632; Write bytes: 694807040; Read time: 397; Write time: 2036 07:11:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 374295040; Write bytes: 369330176; Read time: 27943; Write time: 665 07:11:44 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31731200; Write bytes: 296010240; Read time: 312; Write time: 1317 07:11:44 INFO - Running post-run listener: _upload_blobber_files 07:11:44 INFO - Blob upload gear active. 07:11:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:44 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 07:11:44 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'] 07:11:44 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 07:11:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:46 INFO - (blobuploader) - INFO - Done attempting. 07:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:47 INFO - (blobuploader) - INFO - Done attempting. 07:11:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:47 INFO - Return code: 0 07:11:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/860172710cd59388060c17d5bbd390fa3e67b16f98f828648e94d4b4e4d7bb946547dfe1076b557655e69c98dbf0e4dce15538ff6a55499846146922dca17ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad3b516f6c6fb04ba126fa743d9396236016ced3e6b3562f0c3ceb88812acd14ea0bb0badc5ee59d041fdaa0b882aff468980e409a1a23ffb2b3a08c61ba290"} 07:11:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:47 INFO - Contents: 07:11:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/860172710cd59388060c17d5bbd390fa3e67b16f98f828648e94d4b4e4d7bb946547dfe1076b557655e69c98dbf0e4dce15538ff6a55499846146922dca17ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad3b516f6c6fb04ba126fa743d9396236016ced3e6b3562f0c3ceb88812acd14ea0bb0badc5ee59d041fdaa0b882aff468980e409a1a23ffb2b3a08c61ba290"} 07:11:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:47 INFO - Copying logs to upload dir... 07:11:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.771922 ========= master_lag: 26.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 36 secs) (at 2016-04-26 07:12:13.876787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 24 secs) (at 2016-04-26 07:12:13.881566) ========= 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.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/860172710cd59388060c17d5bbd390fa3e67b16f98f828648e94d4b4e4d7bb946547dfe1076b557655e69c98dbf0e4dce15538ff6a55499846146922dca17ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad3b516f6c6fb04ba126fa743d9396236016ced3e6b3562f0c3ceb88812acd14ea0bb0badc5ee59d041fdaa0b882aff468980e409a1a23ffb2b3a08c61ba290"} build_url:https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/TKGE5LGfRHy4TG6uIK9rfw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/860172710cd59388060c17d5bbd390fa3e67b16f98f828648e94d4b4e4d7bb946547dfe1076b557655e69c98dbf0e4dce15538ff6a55499846146922dca17ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bad3b516f6c6fb04ba126fa743d9396236016ced3e6b3562f0c3ceb88812acd14ea0bb0badc5ee59d041fdaa0b882aff468980e409a1a23ffb2b3a08c61ba290"}' ========= master_lag: 24.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 24 secs) (at 2016-04-26 07:12:38.220222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 30 secs) (at 2016-04-26 07:12:38.220648) ========= 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.1gIXkpVquo/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.vA7AyGjFvx/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005403 ========= master_lag: 30.62 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 30 secs) (at 2016-04-26 07:13:08.843536) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-26 07:13:08.843860) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-26 07:13:14.793358) ========= ========= Total master_lag: 81.54 =========