builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1461919703.48 results: success (0) buildid: 20160429005149 builduid: a391dd05d7e24640b686e37e22258edb revision: 82551043fdd59d193bc2a357f33f8d2ffd78acd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:23.483676) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:23.484755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:23.485114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:24.296247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:24.296697) ========= 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.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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-29 01:48:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-04-29 01:48:24 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135240 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:24.480561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:24.480946) ========= 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.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.027523 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:24.546735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-29 01:48:24.547111) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 82551043fdd59d193bc2a357f33f8d2ffd78acd2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 82551043fdd59d193bc2a357f33f8d2ffd78acd2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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-29 01:48:24,624 truncating revision to first 12 chars 2016-04-29 01:48:24,624 Setting DEBUG logging. 2016-04-29 01:48:24,624 attempt 1/10 2016-04-29 01:48:24,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/82551043fdd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 01:48:26,058 unpacking tar archive at: mozilla-beta-82551043fdd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677348 ========= master_lag: 1.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-29 01:48:27.718344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:27.718663) ========= script_repo_revision: 82551043fdd59d193bc2a357f33f8d2ffd78acd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 01:48:27.719064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-04-29 01:48:27.723394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-04-29 01:48:34.698178) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-29 01:48:34.698456) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:48:34 INFO - MultiFileLogger online at 20160429 01:48:34 in /builds/slave/test 01:48:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:48:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:48:34 INFO - {'append_to_log': False, 01:48:34 INFO - 'base_work_dir': '/builds/slave/test', 01:48:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:48:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:48:34 INFO - 'branch': 'Mozilla-Beta', 01:48:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:48:34 INFO - 'config_files': ('talos/mac_config.py',), 01:48:34 INFO - 'default_actions': ('clobber', 01:48:34 INFO - 'read-buildbot-config', 01:48:34 INFO - 'download-and-extract', 01:48:34 INFO - 'populate-webroot', 01:48:34 INFO - 'create-virtualenv', 01:48:34 INFO - 'install', 01:48:34 INFO - 'run-tests'), 01:48:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:48:34 INFO - 'download_minidump_stackwalk': True, 01:48:34 INFO - 'download_symbols': 'ondemand', 01:48:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:48:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:48:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:48:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:48:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:48:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:48:34 INFO - 'installer_path': 'installer.exe', 01:48:34 INFO - 'log_level': 'info', 01:48:34 INFO - 'log_name': 'talos', 01:48:34 INFO - 'log_to_console': True, 01:48:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:48:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:48:34 INFO - 'opt_config_files': (), 01:48:34 INFO - 'pip_index': False, 01:48:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:34 INFO - 'cmd': ('bash', 01:48:34 INFO - '-c', 01:48:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:34 INFO - 'enabled': True, 01:48:34 INFO - 'halt_on_failure': False, 01:48:34 INFO - 'name': 'check_screen_resolution'},), 01:48:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:34 INFO - 'cmd': ('bash', 01:48:34 INFO - '-c', 01:48:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:34 INFO - 'enabled': True, 01:48:34 INFO - 'halt_on_failure': False, 01:48:34 INFO - 'name': 'check_screen_resolution'},), 01:48:34 INFO - 'run_cmd_checks_enabled': True, 01:48:34 INFO - 'sps_profile': False, 01:48:34 INFO - 'sps_profile_interval': 0, 01:48:34 INFO - 'suite': 'dromaeojs', 01:48:34 INFO - 'system_bits': '32', 01:48:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:48:34 INFO - 'title': 't-yosemite-r7-0146', 01:48:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:48:34 INFO - 'use_talos_json': True, 01:48:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:48:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:48:34 INFO - 'work_dir': 'build'} 01:48:34 INFO - ##### 01:48:34 INFO - ##### Running clobber step. 01:48:34 INFO - ##### 01:48:34 INFO - Running pre-action listener: _resource_record_pre_action 01:48:34 INFO - Running main action method: clobber 01:48:34 INFO - rmtree: /builds/slave/test/build 01:48:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:48:36 INFO - Running post-action listener: _resource_record_post_action 01:48:36 INFO - ##### 01:48:36 INFO - ##### Running read-buildbot-config step. 01:48:36 INFO - ##### 01:48:36 INFO - Running pre-action listener: _resource_record_pre_action 01:48:36 INFO - Running main action method: read_buildbot_config 01:48:36 INFO - Using buildbot properties: 01:48:36 INFO - { 01:48:36 INFO - "project": "", 01:48:36 INFO - "product": "firefox", 01:48:36 INFO - "script_repo_revision": "production", 01:48:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:48:36 INFO - "repository": "", 01:48:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:48:36 INFO - "buildid": "20160429005149", 01:48:36 INFO - "pgo_build": "False", 01:48:36 INFO - "basedir": "/builds/slave/test", 01:48:36 INFO - "buildnumber": 163, 01:48:36 INFO - "slavename": "t-yosemite-r7-0146", 01:48:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:48:36 INFO - "platform": "yosemite_r7", 01:48:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:48:36 INFO - "branch": "mozilla-beta", 01:48:36 INFO - "repo_path": "releases/mozilla-beta", 01:48:36 INFO - "revision": "82551043fdd59d193bc2a357f33f8d2ffd78acd2", 01:48:36 INFO - "stage_platform": "macosx64", 01:48:36 INFO - "builduid": "a391dd05d7e24640b686e37e22258edb", 01:48:36 INFO - "slavebuilddir": "test" 01:48:36 INFO - } 01:48:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 01:48:36 INFO - Running post-action listener: _resource_record_post_action 01:48:36 INFO - ##### 01:48:36 INFO - ##### Running download-and-extract step. 01:48:36 INFO - ##### 01:48:36 INFO - Running pre-action listener: _resource_record_pre_action 01:48:36 INFO - Running main action method: download_and_extract 01:48:36 INFO - mkdir: /builds/slave/test/build/tests 01:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:36 INFO - https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 01:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 01:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 01:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 01:48:38 INFO - Downloaded 1241 bytes. 01:48:38 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 01:48:38 INFO - Using the following test package requirements: 01:48:38 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 01:48:38 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 01:48:38 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 01:48:38 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:48:38 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 01:48:38 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 01:48:38 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 01:48:38 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 01:48:38 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 01:48:38 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 01:48:38 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 01:48:38 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 01:48:38 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 01:48:38 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')]} 01:48:38 INFO - https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 01:48:39 INFO - Downloaded 17745611 bytes. 01:48:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:42 INFO - Return code: 0 01:48:42 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:48: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')]} 01:48:42 INFO - https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 01:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 01:48:43 INFO - Downloaded 17745611 bytes. 01:48:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:47 INFO - Return code: 0 01:48:47 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')]} 01:48:47 INFO - https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 01:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 01:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 01:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 01:48:49 INFO - Downloaded 10845194 bytes. 01:48:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:48:49 INFO - Return code: 0 01:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:49 INFO - https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:48:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 01:48:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 01:48:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 01:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 01:48:53 INFO - Downloaded 88300345 bytes. 01:48:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 01:48:53 INFO - mkdir: /builds/slave/test/properties 01:48:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:48:53 INFO - Writing to file /builds/slave/test/properties/build_url 01:48:53 INFO - Contents: 01:48:53 INFO - build_url:https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 01:48:54 INFO - Running post-action listener: _resource_record_post_action 01:48:54 INFO - Running post-action listener: set_extra_try_arguments 01:48:54 INFO - ##### 01:48:54 INFO - ##### Running populate-webroot step. 01:48:54 INFO - ##### 01:48:54 INFO - Running pre-action listener: _resource_record_pre_action 01:48:54 INFO - Running main action method: populate_webroot 01:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:48:54 INFO - '--tppagecycles', 01:48:54 INFO - '7'], 01:48:54 INFO - 'tests': ['tsvgm']}}, 01:48:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:48:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:48:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:48:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'tests': ['damp', 'tps']}, 01:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['damp', 'tps']}, 01:48:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:48:54 INFO - 'other': {'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'other_l64': {'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'other_nol64': {'tests': ['a11yr', 01:48:54 INFO - 'ts_paint', 01:48:54 INFO - 'tpaint', 01:48:54 INFO - 'sessionrestore', 01:48:54 INFO - 'sessionrestore_no_auto_restore', 01:48:54 INFO - 'tabpaint']}, 01:48:54 INFO - 'svgr': {'tests': ['tsvgx', 01:48:54 INFO - 'tsvgr_opacity', 01:48:54 INFO - 'tart', 01:48:54 INFO - 'tscrollx', 01:48:54 INFO - 'cart']}, 01:48:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['tsvgx', 01:48:54 INFO - 'tsvgr_opacity', 01:48:54 INFO - 'tart', 01:48:54 INFO - 'tscrollx', 01:48:54 INFO - 'cart']}, 01:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'tests': ['tp5o']}, 01:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'talos_options': ['--e10s'], 01:48:54 INFO - 'tests': ['tp5o']}, 01:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'talos_options': ['--xperf_path', 01:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:54 INFO - 'tests': ['tp5n']}, 01:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:54 INFO - 'talos_options': ['--e10s', 01:48:54 INFO - '--xperf_path', 01:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:54 INFO - 'tests': ['tp5n']}}, 01:48:54 INFO - 'talos.zip': {'path': '', 01:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:48:54 INFO - Running post-action listener: _resource_record_post_action 01:48:54 INFO - ##### 01:48:54 INFO - ##### Running create-virtualenv step. 01:48:54 INFO - ##### 01:48:54 INFO - Running pre-action listener: _resource_record_pre_action 01:48:54 INFO - Running main action method: create_virtualenv 01:48:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:48:54 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 01:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:48:54 INFO - Using real prefix '/tools/python27' 01:48:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:48:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:58 INFO - Installing pip.................done. 01:48:58 INFO - Return code: 0 01:48:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:58 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')]} 01:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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')]} 01:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:48:58 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 01:48:58 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 01:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:58 INFO - 'HOME': '/Users/cltbld', 01:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:58 INFO - 'LOGNAME': 'cltbld', 01:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:58 INFO - 'MOZ_NO_REMOTE': '1', 01:48:58 INFO - 'NO_EM_RESTART': '1', 01:48:58 INFO - 'PAGER': '/bin/cat', 01:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:58 INFO - 'PWD': '/builds/slave/test', 01:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:58 INFO - 'SHELL': '/bin/bash', 01:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:48:58 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:58 INFO - 'USER': 'cltbld', 01:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:58 INFO - 'XPC_FLAGS': '0x0', 01:48:58 INFO - 'XPC_SERVICE_NAME': '0', 01:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:58 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 01:48:58 INFO - Cleaning up... 01:48:58 INFO - Return code: 0 01:48:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:48:58 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')]} 01:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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')]} 01:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:58 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:48:58 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 01:48:58 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 01:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:58 INFO - 'HOME': '/Users/cltbld', 01:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:58 INFO - 'LOGNAME': 'cltbld', 01:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:58 INFO - 'MOZ_NO_REMOTE': '1', 01:48:58 INFO - 'NO_EM_RESTART': '1', 01:48:58 INFO - 'PAGER': '/bin/cat', 01:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:58 INFO - 'PWD': '/builds/slave/test', 01:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:58 INFO - 'SHELL': '/bin/bash', 01:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:48:58 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:58 INFO - 'USER': 'cltbld', 01:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:58 INFO - 'XPC_FLAGS': '0x0', 01:48:58 INFO - 'XPC_SERVICE_NAME': '0', 01:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:58 INFO - Downloading/unpacking psutil>=0.7.1 01:48:58 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 01:48:58 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 01:48:58 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 01:48:58 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 01:48:58 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 01:48:58 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 01:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:01 INFO - Installing collected packages: psutil 01:49:01 INFO - Running setup.py install for psutil 01:49:01 INFO - building 'psutil._psutil_osx' extension 01:49:01 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 01:49:02 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 01:49:02 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 01:49:02 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 01:49:02 INFO - building 'psutil._psutil_posix' extension 01:49:02 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 01:49:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:49:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:49:02 INFO - ^ 01:49:02 INFO - 1 warning generated. 01:49:02 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 01:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:02 INFO - Successfully installed psutil 01:49:02 INFO - Cleaning up... 01:49:02 INFO - Return code: 0 01:49:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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', '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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:49: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 mozsystemmonitor==0.0.0 01:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:02 INFO - 'HOME': '/Users/cltbld', 01:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:02 INFO - 'LOGNAME': 'cltbld', 01:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:02 INFO - 'MOZ_NO_REMOTE': '1', 01:49:02 INFO - 'NO_EM_RESTART': '1', 01:49:02 INFO - 'PAGER': '/bin/cat', 01:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:02 INFO - 'PWD': '/builds/slave/test', 01:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:02 INFO - 'SHELL': '/bin/bash', 01:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:02 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:02 INFO - 'USER': 'cltbld', 01:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:02 INFO - 'XPC_FLAGS': '0x0', 01:49:02 INFO - 'XPC_SERVICE_NAME': '0', 01:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:49:05 INFO - Installing collected packages: mozsystemmonitor 01:49:05 INFO - Running setup.py install for mozsystemmonitor 01:49:05 INFO - Successfully installed mozsystemmonitor 01:49:05 INFO - Cleaning up... 01:49:05 INFO - Return code: 0 01:49:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:49:05 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')]} 01:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:06 INFO - 'HOME': '/Users/cltbld', 01:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:06 INFO - 'LOGNAME': 'cltbld', 01:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:06 INFO - 'MOZ_NO_REMOTE': '1', 01:49:06 INFO - 'NO_EM_RESTART': '1', 01:49:06 INFO - 'PAGER': '/bin/cat', 01:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:06 INFO - 'PWD': '/builds/slave/test', 01:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:06 INFO - 'SHELL': '/bin/bash', 01:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:06 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:06 INFO - 'USER': 'cltbld', 01:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:06 INFO - 'XPC_FLAGS': '0x0', 01:49:06 INFO - 'XPC_SERVICE_NAME': '0', 01:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 01:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:49:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:49:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:10 INFO - Downloading docopt-0.6.1.tar.gz 01:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:49:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:49:10 INFO - Running setup.py install for blobuploader 01:49:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:49:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:49:10 INFO - Running setup.py install for requests 01:49:11 INFO - Running setup.py install for docopt 01:49:11 INFO - Successfully installed blobuploader requests docopt 01:49:11 INFO - Cleaning up... 01:49:11 INFO - Return code: 0 01:49:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:11 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:11 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 01:49:11 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 01:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:11 INFO - 'HOME': '/Users/cltbld', 01:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:11 INFO - 'LOGNAME': 'cltbld', 01:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:11 INFO - 'MOZ_NO_REMOTE': '1', 01:49:11 INFO - 'NO_EM_RESTART': '1', 01:49:11 INFO - 'PAGER': '/bin/cat', 01:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:11 INFO - 'PWD': '/builds/slave/test', 01:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:11 INFO - 'SHELL': '/bin/bash', 01:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:11 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:11 INFO - 'USER': 'cltbld', 01:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:11 INFO - 'XPC_FLAGS': '0x0', 01:49:11 INFO - 'XPC_SERVICE_NAME': '0', 01:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:11 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-XHMM15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:11 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-GvNNkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:11 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-9E_GUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:11 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-BIShL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Ijixks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-24ZeS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-buUWoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-T4tPjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-AGhnWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ZkIP6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-0dgX_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WrSBnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-f6zVh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:12 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-hQQoIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:13 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-OhqJx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:13 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NToWZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:13 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ldPRKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:49:13 INFO - Running setup.py install for manifestparser 01:49:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:49:13 INFO - Running setup.py install for mozcrash 01:49:13 INFO - Running setup.py install for mozdebug 01:49:13 INFO - Running setup.py install for mozdevice 01:49:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:49:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:49:13 INFO - Running setup.py install for mozfile 01:49:14 INFO - Running setup.py install for mozhttpd 01:49:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Running setup.py install for mozinfo 01:49:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Running setup.py install for mozInstall 01:49:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Running setup.py install for mozleak 01:49:14 INFO - Running setup.py install for mozlog 01:49:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:49:14 INFO - Running setup.py install for moznetwork 01:49:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Running setup.py install for mozprocess 01:49:15 INFO - Running setup.py install for mozprofile 01:49:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Running setup.py install for mozrunner 01:49:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Running setup.py install for mozscreenshot 01:49:15 INFO - Running setup.py install for moztest 01:49:15 INFO - Running setup.py install for mozversion 01:49:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:49:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:49:15 INFO - Cleaning up... 01:49:15 INFO - Return code: 0 01:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:15 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:15 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 01:49:15 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 01:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:15 INFO - 'HOME': '/Users/cltbld', 01:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:15 INFO - 'LOGNAME': 'cltbld', 01:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:15 INFO - 'MOZ_NO_REMOTE': '1', 01:49:15 INFO - 'NO_EM_RESTART': '1', 01:49:15 INFO - 'PAGER': '/bin/cat', 01:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:15 INFO - 'PWD': '/builds/slave/test', 01:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:15 INFO - 'SHELL': '/bin/bash', 01:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:15 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:15 INFO - 'USER': 'cltbld', 01:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:15 INFO - 'XPC_FLAGS': '0x0', 01:49:15 INFO - 'XPC_SERVICE_NAME': '0', 01:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-4siUw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-IxXiF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-pvnA94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-BBgaSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ew6Uxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-N7lZlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-muvmAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:49:16 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)) 01:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:49:16 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3FoC2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-VZTkO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-fN3KrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qkcorf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-FAzwaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-C4tMfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DL61i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-28_zPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-n3ap77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:49:17 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)) 01:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:49:17 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-PnvjmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:49:18 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)) 01:49:18 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)) 01:49:18 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)) 01:49:18 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)) 01:49:18 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)) 01:49:18 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)) 01:49:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:49:18 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 01:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:18 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 01:49:18 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 01:49:18 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 01:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:20 INFO - Downloading blessings-1.6.tar.gz 01:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:49:20 INFO - Installing collected packages: blessings 01:49:20 INFO - Running setup.py install for blessings 01:49:20 INFO - Successfully installed blessings 01:49:20 INFO - Cleaning up... 01:49:20 INFO - Return code: 0 01:49:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:21 INFO - Reading from file tmpfile_stdout 01:49:21 INFO - Current package versions: 01:49:21 INFO - blessings == 1.6 01:49:21 INFO - blobuploader == 1.2.4 01:49:21 INFO - docopt == 0.6.1 01:49:21 INFO - manifestparser == 1.1 01:49:21 INFO - mozInstall == 1.12 01:49:21 INFO - mozcrash == 0.17 01:49:21 INFO - mozdebug == 0.1 01:49:21 INFO - mozdevice == 0.48 01:49:21 INFO - mozfile == 1.2 01:49:21 INFO - mozhttpd == 0.7 01:49:21 INFO - mozinfo == 0.9 01:49:21 INFO - mozleak == 0.1 01:49:21 INFO - mozlog == 3.1 01:49:21 INFO - moznetwork == 0.27 01:49:21 INFO - mozprocess == 0.22 01:49:21 INFO - mozprofile == 0.28 01:49:21 INFO - mozrunner == 6.11 01:49:21 INFO - mozscreenshot == 0.1 01:49:21 INFO - mozsystemmonitor == 0.0 01:49:21 INFO - moztest == 0.7 01:49:21 INFO - mozversion == 1.4 01:49:21 INFO - psutil == 3.1.1 01:49:21 INFO - requests == 1.2.3 01:49:21 INFO - wsgiref == 0.1.2 01:49:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:21 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 01:49:21 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 01:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:21 INFO - 'HOME': '/Users/cltbld', 01:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:21 INFO - 'LOGNAME': 'cltbld', 01:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:21 INFO - 'MOZ_NO_REMOTE': '1', 01:49:21 INFO - 'NO_EM_RESTART': '1', 01:49:21 INFO - 'PAGER': '/bin/cat', 01:49:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:21 INFO - 'PWD': '/builds/slave/test', 01:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:21 INFO - 'SHELL': '/bin/bash', 01:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:21 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:21 INFO - 'USER': 'cltbld', 01:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:21 INFO - 'XPC_FLAGS': '0x0', 01:49:21 INFO - 'XPC_SERVICE_NAME': '0', 01:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 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)) 01:49:21 INFO - Cleaning up... 01:49:21 INFO - Return code: 0 01:49:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:21 INFO - 'HOME': '/Users/cltbld', 01:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:21 INFO - 'LOGNAME': 'cltbld', 01:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:21 INFO - 'MOZ_NO_REMOTE': '1', 01:49:21 INFO - 'NO_EM_RESTART': '1', 01:49:21 INFO - 'PAGER': '/bin/cat', 01:49:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:21 INFO - 'PWD': '/builds/slave/test', 01:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:21 INFO - 'SHELL': '/bin/bash', 01:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:21 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:21 INFO - 'USER': 'cltbld', 01:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:21 INFO - 'XPC_FLAGS': '0x0', 01:49:21 INFO - 'XPC_SERVICE_NAME': '0', 01:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:21 INFO - Downloading/unpacking jsonschema 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:49:24 INFO - Downloading/unpacking functools32 (from jsonschema) 01:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:24 INFO - Downloading functools32-3.2.3-2.tar.gz 01:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:49:24 INFO - warning: no files found matching '*.txt' 01:49:24 INFO - no previously-included directories found matching 'build' 01:49:24 INFO - no previously-included directories found matching 'dist' 01:49:24 INFO - no previously-included directories found matching '.git*' 01:49:24 INFO - Installing collected packages: jsonschema, functools32 01:49:24 INFO - Running setup.py install for functools32 01:49:24 INFO - warning: no files found matching '*.txt' 01:49:24 INFO - no previously-included directories found matching 'build' 01:49:24 INFO - no previously-included directories found matching 'dist' 01:49:24 INFO - no previously-included directories found matching '.git*' 01:49:24 INFO - Successfully installed jsonschema functools32 01:49:24 INFO - Cleaning up... 01:49:24 INFO - Return code: 0 01:49:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:49: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')]} 01:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:24 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 0x10a613a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a61a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9615c2170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, '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.PCEaVfC2HE/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.K0wihzZJDj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 01:49:24 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 01:49:24 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 01:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:24 INFO - 'HOME': '/Users/cltbld', 01:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:24 INFO - 'LOGNAME': 'cltbld', 01:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:24 INFO - 'MOZ_NO_REMOTE': '1', 01:49:24 INFO - 'NO_EM_RESTART': '1', 01:49:24 INFO - 'PAGER': '/bin/cat', 01:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:24 INFO - 'PWD': '/builds/slave/test', 01:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:24 INFO - 'SHELL': '/bin/bash', 01:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:24 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:24 INFO - 'USER': 'cltbld', 01:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:24 INFO - 'XPC_FLAGS': '0x0', 01:49:24 INFO - 'XPC_SERVICE_NAME': '0', 01:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:25 INFO - Downloading/unpacking flake8 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:28 INFO - no previously-included directories found matching 'docs/_build' 01:49:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:28 INFO - Running setup.py install for pep8 01:49:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:28 INFO - no previously-included directories found matching 'docs/_build' 01:49:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:49:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:28 INFO - Cleaning up... 01:49:29 INFO - Return code: 0 01:49:29 INFO - Running post-action listener: _resource_record_post_action 01:49:29 INFO - Running post-action listener: _start_resource_monitoring 01:49:29 INFO - Starting resource monitoring. 01:49:29 INFO - ##### 01:49:29 INFO - ##### Running install step. 01:49:29 INFO - ##### 01:49:29 INFO - Running pre-action listener: _resource_record_pre_action 01:49:29 INFO - Running main action method: install 01:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:29 INFO - Reading from file tmpfile_stdout 01:49:29 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:49:29 INFO - Reading from file tmpfile_stdout 01:49:29 INFO - Output received: 01:49:29 INFO - Usage: mozinstall [options] installer 01:49:29 INFO - Options: 01:49:29 INFO - -h, --help show this help message and exit 01:49:29 INFO - -d DEST, --destination=DEST 01:49:29 INFO - Directory to install application into. [default: 01:49:29 INFO - "/builds/slave/test"] 01:49:29 INFO - --app=APP Application being installed. [default: firefox] 01:49:29 INFO - mkdir: /builds/slave/test/build/application 01:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:49:52 INFO - Reading from file tmpfile_stdout 01:49:52 INFO - Output received: 01:49:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:49:52 INFO - Running post-action listener: _resource_record_post_action 01:49:52 INFO - ##### 01:49:52 INFO - ##### Running run-tests step. 01:49:52 INFO - ##### 01:49:52 INFO - Running pre-action listener: _resource_record_pre_action 01:49:52 INFO - Running main action method: run_tests 01:49:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:52 INFO - 2016-04-29 01:49:52.397 screenresolution[1637:7593] starting screenresolution argv=screenresolution get 01:49:52 INFO - 2016-04-29 01:49:52.400 screenresolution[1637:7593] Display 0: 1600x1200x32@60 01:49:52 INFO - 2016-04-29 01:49:52.406 screenresolution[1638:7596] starting screenresolution argv=screenresolution list 01:49:52 INFO - Available Modes on Display 0 01:49:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:52 INFO - Intel Iris: 01:49:52 INFO - Chipset Model: Intel Iris 01:49:52 INFO - Type: GPU 01:49:52 INFO - Bus: Built-In 01:49:52 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:52 INFO - Vendor: Intel (0x8086) 01:49:52 INFO - Device ID: 0x0a2e 01:49:52 INFO - Revision ID: 0x0009 01:49:52 INFO - Displays: 01:49:52 INFO - Display: 01:49:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:52 INFO - Display Serial Number: 1600x1200 60 01:49:52 INFO - Main Display: Yes 01:49:52 INFO - Mirror: Off 01:49:52 INFO - Online: Yes 01:49:52 INFO - Rotation: Supported 01:49:52 INFO - Return code: 0 01:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:52 INFO - Python 2.7.3 01:49:52 INFO - Return code: 0 01:49:52 INFO - grabbing minidump binary from tooltool 01:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:52 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 0x10a4b7d30>, '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 0x10a31bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a4aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:52 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 01:49:52 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 01:49:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:52 INFO - Return code: 0 01:49:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:49:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:49:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:49:53 INFO - Return code: 0 01:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 01:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 01:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PCEaVfC2HE/Render', 01:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:53 INFO - 'HOME': '/Users/cltbld', 01:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:53 INFO - 'LOGNAME': 'cltbld', 01:49:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:49:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:53 INFO - 'MOZ_NO_REMOTE': '1', 01:49:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:49:53 INFO - 'NO_EM_RESTART': '1', 01:49:53 INFO - 'PAGER': '/bin/cat', 01:49:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:53 INFO - 'PWD': '/builds/slave/test', 01:49:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:53 INFO - 'SHELL': '/bin/bash', 01:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K0wihzZJDj/Listeners', 01:49:53 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 01:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:53 INFO - 'USER': 'cltbld', 01:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:53 INFO - 'XPC_FLAGS': '0x0', 01:49:53 INFO - 'XPC_SERVICE_NAME': '0', 01:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 01:49:54 INFO - mozversion application_buildid: 20160429005149 01:49:54 INFO - mozversion application_changeset: 82551043fdd59d193bc2a357f33f8d2ffd78acd2 01:49:54 INFO - mozversion application_display_name: Firefox 01:49:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:54 INFO - mozversion application_name: Firefox 01:49:54 INFO - mozversion application_remotingname: firefox 01:49:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:49:54 INFO - mozversion application_vendor: Mozilla 01:49:54 INFO - mozversion application_version: 47.0 01:49:54 INFO - mozversion platform_buildid: 20160429005149 01:49:54 INFO - mozversion platform_changeset: 82551043fdd59d193bc2a357f33f8d2ffd78acd2 01:49:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:49:54 INFO - mozversion platform_version: 47.0 01:49:54 INFO - using testdate: 1461919794 01:49:54 INFO - actual date: 1461919794 01:49:54 INFO - starting webserver on 'localhost:49275' 01:49:54 INFO - SUITE-START | Running 2 tests 01:49:54 INFO - TEST-START | dromaeo_css 01:49:54 INFO - operating with platform_type : mac_ 01:49:54 INFO - Initialising browser for dromaeo_css test... 01:49:54 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpeWNedn/profile http://localhost:49275/getInfo.html) 01:49:56 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 01:49:56 INFO - PROCESS | 1656 | colorDepth:24 01:49:56 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 01:49:56 INFO - PROCESS | 1656 | __metrics 01:49:56 INFO - PROCESS | 1656 | 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" 01:49:56 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:49:57 INFO - TEST-INFO | 1656: exit 0 01:49:57 INFO - Browser initialized. 01:49:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:49:57 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpeWNedn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:09 INFO - PROCESS | 1659 | RSS: Main: 156721152 01:50:09 INFO - PROCESS | 1659 | 01:51:01 INFO - PROCESS | 1659 | 1461919861092 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] 01:53:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:53:11 INFO - PROCESS | 1659 | RSS: Main: 248532992 01:53:11 INFO - PROCESS | 1659 | 01:56:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 01:56:14 INFO - PROCESS | 1659 | RSS: Main: 293994496 01:56:14 INFO - PROCESS | 1659 | 01:59:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 01:59:16 INFO - PROCESS | 1659 | RSS: Main: 297226240 01:59:16 INFO - PROCESS | 1659 | 02:02:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 02:02:19 INFO - PROCESS | 1659 | RSS: Main: 255270912 02:02:19 INFO - PROCESS | 1659 | 02:05:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 02:05:23 INFO - PROCESS | 1659 | RSS: Main: 258351104 02:05:23 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 02:08:25 INFO - PROCESS | 1659 | RSS: Main: 304570368 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | __start_tp_report 02:08:25 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 02:08:25 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 02:08:25 INFO - PROCESS | 1659 | |i|pagename|runs| 02:08:25 INFO - PROCESS | 1659 | |0;dojo.html;3555.1823080691443;3634.7819130852135;3636.9818150909223;3653.1780349421383;3700.629937006298;5871.383504732005;5871.9412805871925;5884.146798714184;5888.205092312536;5988.041913293874;5865.677387743673;5901.380355062721;5904.350521442649;5919.585629005961;5930.140129681194;5192.532672059514;5280.287161233232;5301.072312345344;5348.117560602496;5403.945960540404;5287.444818294062;5395.325584301962;5402.37872644647;5411.080116380225;5423;5350.742575494755;5422.701751403672;5433.755481003344;5437.238786569884;5437.700926449063;5366.597505187126;5400.567954563626;5402.540784033362;5428.538574221196;5472.50747432733;5160.380754309469;5202.609804264695;5257.684538927639;5322.7338633068575;5349.759260833272;5804.912926306109;5814.709264536798;5815.651060936358;5826.650400975913;5856.941430585683;6279.434850863398;6352.237731472253;6352.904706429407;6367.426931576134;6368.267649220353;6229.87540249197;6231.6572588507615;6266.937330626681;6309.432151106423;6310.368963103699;5974.641521508724;5993.013300642319;6000.399960004008;6006.6696331701305;6051.334353221142;6324.936750632527;6372.235331760218;6380.330065343072;6382.234131904202;6383.106365108889;6089.939100609025;6141.955867502446;6243.344448832898;6284.4344009039405;6301.77943771975;6259.655718935503;6302.684865756693;6304.401081897213;6305.716242769086;6342.904856427157;6137.294211165684;6320.715567799368;6352.555321127476;6355.491560675227;6359.459445947146;6277.18396608438;6280.246370435486;6350.650714210763;6354.841128971812;6359.650219237987;4960.355153830051;4964.875878103004;4967.503249675004;4969.155243608595;4984.42679091909;4448.488423831301;4489.595936365743;4509.391232183613;4517.141743068806;4534.59188673021;5853;5870.501007414332;5878.617889837147;5885.264341957255;5889.617174883619;6248.625082495065;6311.715972781236;6325.873482530324;6333.778317758856;6364.172657554488;5971.313298970587;5983.282006159202;5996.190514280516;6002.969985150046;6059.909101363483;5392.110301800159;5399.568034557226;5454.018276710231;5469.972650136724;5472.452754724575;6405.19935008124;6470.1588793457495;6481.125048118538;6501.869962600722;6521.478281737354;6058.5153187745755;6296.275928268308;6311.968440157953;6332.240131184288;6339.207599050119;6313.558050936574;6383.2978372378075;6388.68056597159;6419.550631455753;6463.25672547663;6294.8111556653375;6327.905081423874;6352.745890164341;6360.459360954371;6366.522510811615;6350.618962862243;6351.618902865843;6365.458935990493;6373.681315934092;6380.266269378895;5210.192420174727;6080.270367555921;6104.694765261808;6266.592671476339;6281.3404592518955;6188.659623720739;6221.657808820558;6228.532860035606;6248.375162483715;6254.061890716429;6108.267007959073;6111.786087486917;6125.418085281891;6127.264728232641;6140.539459540463;6072.60528065692;6192.2569291683485;6204.069389591597;6205.2553693555255;6323.4625056868845;6092.9086063709965;6094.085887116968;6105.664188469676;6112.563547566408;6143.877122457615 02:08:25 INFO - PROCESS | 1659 | |1;ext.html;489.3760455419342;573.2347316332696;590.3476658292584;603.0742809786977;671.8790617688817;28088.578671319945;32700.672993270062;40571.59428405715;40746.79626601863;40866.38700419488;43914;44417.77791111048;44423.555764442346;44478;44643;9857.7535561611;10086.041826026552;10098;10104.292699511037;10109.342892711988;9828.655997040105;9844;9880.061394167542;9945.453000085028;9957.302988790787;10008.89991100087;10133.341332813381;10140.543675534582;10146.985301469831;10163.491825408737;10013.79972400548;10031.297809153362;10037.096661300482;10085.142762865165;10110.44392558409;9873.358231714916;10007.849882251772;10009.849852252222;10011.19910407173;10016.098551130433;42529.36205956913;43395.783021084695;43400;43437.78281108606;43456;3303.487959366302;3375.1730825947557;3452.9482057769155;3883.611638836122;4049.5747946465785;27599;28388.716112838814;28412.573811392846;28424.73115591713;29122.271943201376;2805.5230610796216;2827.7879159063154;2841.4459180459817;2930.3113768264443;2943.6877010444227;484025;493015;493936.9999999964;494866;495726;48003.27995080077;48522.75738621355;48527;73900;75212;47604;47719.522804771506;47961.5203847957;47994.5200547997;48017;14191.574252772434;17083.060431676127;17246.568835778955;17254.654906902044;17265.741013884803;13259.867401326057;13273.070885037954;13274.336283185801;13305.66735831612;13318.400671969785;13531.849792767725;15209.6197595061;15626.984246023972;15655.921720391552;15770.132642704531;5535.750891209906;6370.904436433457;6506.739730410825;6528.347165283433;6529.444997175198;985.7042887133831;1040.6877936618985;1049.3913530152645;1109.611635927419;1200.609801814414;30690.53964190539;30700;31348.529772053436;31358.47755361111;31661.683383166335;1088.5700148441322;1170.1867202294325;1176.4647085576041;1201.3512703140382;1275.7639836630253;12935.870641293466;13901.652458688412;15807.446739364066;15816.05103693782;15851.445199417965;511170;519223;520210;520653;521008;61335.38664613386;62788.68605656942;62790;62816.685916570124;62966.425839354386;1410.1609542322508;1417.6603110060894;1419.283261952728;1482.1033274868548;1524.2454984782382;26315.473690526465;30609.54085688761;31360.05919822409;32366.838165809022;32774.68901243924;59549;59929;60684;60910.390896090474;60946.39053609407;483736;487302;488518;489091.2181756416;489280;40760.59239407568;47234.055318892744;47840.282395764785;48015.519844802504;48819.5118048815;45430;46218.613441596804;46305.84235394142;47467.28799068086;47919.52080479151;35526.93419197428;37046.07384815401;38732.80633596814;39152;39421.80289098536;37802.62197378101;38287.80856095702;38618.84143475588;39130.80434597809;39497.60502394939;34184;38723.2255354897;42107;42110.57889421067;42249.577504224566;31660.208494787814;34048.97853064412;34293.82711112024;34692.785752498545;34968.30063398667;22622;25850;25898.093566725074;26062;26290.342741431617 02:08:25 INFO - PROCESS | 1659 | |2;jquery.html;384.4387194695744;385.32568005989526;388.21192978254135;393.5061497820235;393.661451152009;14717.558473245806;15339.23303834808;17247.051412172324;17782.733259001125;20444.386668399955;21165;21168.57662846742;22021.66967495489;22047.11811527541;22112.668309975365;5783.913241301384;5929.495992840613;6038.818835434922;6050.2437195350585;6051.788187413442;4115.403266526352;5782.421757824205;5880.26496687914;5929.555283353744;6034.577579569432;6015.729292181863;6016.27804663441;6018.8796224075495;6021.397860213965;6024.704688491974;5993.101034844764;6174.444300012998;6361.491080713532;6552.705128269239;6559.27847936729;5748.993926062923;5757.769689212427;5760.452756988079;5765.971170144123;5773.220615216934;18853.717194242097;19881.900590496956;25780.097696580717;26634.93460261587;26643.333916652045;1938.2440848069123;2156.105216335219;2267.671187677794;2272.488690044727;2385.355953892439;9847.359921605144;9946.154576860976;10317.38095714252;10417.791644167075;10460.581576736922;1808.3761102419644;1825.3596387163727;1865.9346922857635;1896.8672192946499;1910.694288913781;84806.57596711977;99891;105024.4748776259;108027;108249;11457.942710286561;11577.76844463106;11604.94197529007;11614.30314181135;11687.88312116885;12463.563775267821;12880.742385152433;12900.548480803127;14481.637959051108;14494.782578261334;8541.316694664536;8812.559372031374;8925.062868398854;8993.685221017233;8995;9156.587953542106;9179.541022948826;9210.401323913924;9243;9301.255899528021;4445.844395446144;4527.777500074962;4537;4537.2059889519205;4562.885927851764;1888.4712280561464;1946.3090602836073;1947.2405761752927;1975.190172029461;1981.959471277562;912.8493798523302;1020.9081182693593;1057.862477877871;1067.631667074858;1072.790805792863;20035.499112522302;20452.693209601868;20515.836427521124;20734.170633174504;20735.27426540094;1032.726327523207;1054.841773733946;1072.5763323487336;1096.17786660005;1111.7276267314398;10722.571097156182;11272.830907536394;11274.7181320466;11302.604408845651;11347.602833900939;650075;659495;659813;672080;673754;117548.41225793817;119801.80198197906;121810.39094804646;122547;126396.73603264033;970.1608108985677;1062.1608928946046;1078.6494389323502;1097.8023955688052;1109.5949978258038;18595.535111622317;18728.25086996505;19154;19170.712439313702;19410.8058919409;54501.72749136229;54825;56521.760847956546;56909;58316;79471.60264198642;79902.20097798947;79917;80229;81857.59071204606;7970.362371010421;7978.441509094308;8233.012038555173;8307.584620769057;8310.459820111673;9908.603655853685;13106.541271055466;13271.137376070525;13464.259465729087;13495.25776082325;11435.199536032398;11699.415029248334;11734.061275098142;11843.644690659294;11970.102242332034;11568.537258509565;11742.471588778697;11814.527418903148;11951.22317049389;12094.213876098025;12011.459484323052;12119.272843629411;12138.453769580214;12259.816102758645;12265;8776.990646075528;11695.415229238673;11940.582079627171;11981.880181198425;12369.93815030919;11710.4730287139;12054.75890482168;12070.577529786766;12089.972352350149;12337.444814983168 02:08:25 INFO - PROCESS | 1659 | |3;mootools.html;1486.7175236705018;1658.8838781285308;1684.8399402056807;2068.9068991895365;2127.5319429725464;8434.66261349546;9095.499747513884;9264;9264.166225039753;9270.49012304323;8960.551972401387;9258.166764991149;9263.722088337343;9269.814603707922;9276.118768716979;2584.4185058361813;2589.262060312811;2610.6997695265004;2616.725243849397;2621.698504671968;2534.5437821192177;2635.6441880346197;2639.6436481075098;2641.6565846439935;2652.8938842446278;2605.9218223453327;2625.514279858223;2645.5634820254636;2646.4310173312733;2651.3504191473116;2593.909213177539;2616.489784492015;2637.1033848491606;2640.6567146271054;2643.8810253538636;2611.8824652890667;2627.2906315294763;2642;2646.7485588869026;2652.9602055969176;9299.953500232456;9338.673146439842;9349.298802589765;9349.626014959393;9359;4643.605293550052;5826.563007774434;5896.115582662592;5905.468507834273;5908.615939963932;3713.795741234231;3796.2787070456525;3870.767753934773;3878.1661942682176;3881.204353107606;1076.7361996310954;1084.7613525024483;1086.1907878630393;1105.6959336182533;1126.6563698072084;12622.621321360373;12637.936810315981;12642.55751048718;12653.87346126536;12654.81017784734;4845.345878306454;5100.311457953203;5187.19598462239;5207.062728708869;5220.608454365938;10678.73303167427;10716.410597417062;10722.088622467021;10722.571097156026;10759.246852720235;5823.912641310384;5889.234399528034;5890.558208134407;5895.911561326584;5897.056470964711;4574.611158051536;4729.07782982322;5100.311457953203;5288.127458969227;5300.31095957523;4096.392684589618;4153.3769934510065;4192.7065105442325;4203.62167404935;4226.57734226581;1217.3243849663345;1353.15427857589;1378.5244090788663;1378.5244090788663;1390.5341710526884;1407.099456347938;1432.9426822926966;1452.353702602353;1461.8976671633097;1480.067557438828;8640.222379985831;8683.6526538939;8694.130586941255;8706.216440520257;8711.08533603975;528.183955788308;535.9785608575613;543.2259030880979;543.3778323819283;545.7653209120037;6435.613863168225;6463.418292353711;6477.125588045647;6494.675266236669;6495.4803615710625;11038.944805276084;11523.942380288045;11536.788637193142;11544.653660390202;11568.132390070778;11189.160812938899;11210.047145992681;11293.887061129448;11365.943170284261;11395.430228488542;8889.777755556033;8980.057094005166;8986.101389861093;8997.820043599091;9010.3242256831;8244.958775206085;8432.198941100585;8460.450070745383;8475.152484751723;8482.787930301793;10102.242331824995;10186.236032297755;10310.278280520291;10344.431056291976;10357.533910973874;10264.948675256575;10308.690739277834;10647.94676026615;10665.253432259668;10840.837387439036;7235.457340699574;7448.143463501767;7972.322352600094;8078.87881681787;8542.060373358801;8804.955975220082;8815.9861615915;8869.157430044135;8876.644934202559;8891.377603567948;7624.771256862303;7699.923000770144;7786.88319675194;7907.011623547057;7924.722634707758;7276.745313913988;7560.735374261874;7595.772126836204;7740.92259077402;7785.377169826514;8152.062512811102;8322.625481853453;8327.916720832714;8332.541710205996;8344.332453403835;7358.963205184154;7482.588457634883;7500.36246919018;7511.8497630046;7513.812154696177;7580.204078571891;7583.355414789805;7653.043369578802;7654.885176722465;7658.425618078778 02:08:25 INFO - PROCESS | 1659 | |4;prototype.html;335.92945481448896;337.51566502069534;344.10704222542495;345.8426415980728;350.47953788623903;6685.2980437054075;6706;6740.22487413947;6747.156605424322;6758.966205168979;5640.717964101799;6289.465395441393;6604.2074951005825;6610.702518386672;6650.201975762903;4732.7160370377715;4850.927236091461;4872.7563621818945;4886.926696099561;4974.457918045399;4870.415550133971;4894.3147959285725;4910.508949105097;4974.701517908937;5013.248012798073;4920.557149856512;4942.6293028022865;4944.406671199443;4954;4990.65065445419;4929.088118698017;4934.25986102084;4943.406791185045;4944.505549445063;4955.331030310898;3165.876113979527;3968.960310396888;4064.248114098901;4141.91716165675;4164;6214.906776398358;6244.313125556185;6257.5932564383165;6281.528885333572;6292.465140463066;5693.7437815298;5718.771249150029;5723.885522289573;5735.8528294341295;5737.88524229513;6933.583984960918;6937.445004399636;6940.410065144419;6943.9652801735665;6953.89569156463;4703.412073490814;4705.035467729107;4714.151452738506;4715.858524244244;4722.220833562458;5731.484166425;7398.260173982559;7422.369098626623;7453.739119130804;7459.328660420588;4604.700694454849;4676.789544470507;4679.789409476582;4682.297655351656;4694.953050469451;4788.856334309976;4793.688410253322;4794.808207671724;4799.256115302133;4802.327674125625;5641.01026455979;5653.547716182696;5662.66024038559;5665.206871038058;5673.971630141823;6141.8944589974235;6674.866502669919;6748.190217173872;7048.964755176191;7067.787966361017;1619.6922584708868;1656.097426902341;1656.1470842515873;1656.8177500474937;1661.4797460323668;1027.209049032241;1047.1616021080852;1060.6287799270349;1063.409807556798;1065.0574241795912;6120.234970628671;6722.596644201266;6728.495362847806;6745.662716864137;6756.155480564929;7004.964975175091;7230.240824713434;7235.89146162808;7381.630918454056;7402.592857392895;6755.560888542327;6770.763023294161;6774.762883299061;6778.847595908707;6798.694058767367;3848.8652897148463;3877.592852750477;3881.4177873319227;3887.7667339959694;3897.2595206910596;6193.659348735863;7351.264873512606;7642.273983971514;7643.656035478417;7644.503107298008;7544.170141284454;7554.546727196386;7559.962200188964;7576.090869095744;7589.1272503661685;6152;6460.806175814733;7331.816704582428;7600.1639819619795;7665.425093118039;7324.487285889936;7325.230850760593;7327.8534429312185;7328.120625524971;7345.118585769742;6927.930720692729;7175.677094530863;7198.49610527258;7199.1001124859395;7213.927860721536;7675.731349402968;7714.801281634707;7716.7684969451;7718;7751.41864360164;4681.789319480699;4710.269908164103;4726.338312636165;4726.36194113804;4728.692634978715;6046.788362407295;7305.780826575211;7321.194668586558;7338.192798792022;7338.743143989935;6786.321367863175;7034.718611255493;7046.647667616701;7049.647517624201;7050.541714788523;7035.366816986496;7056.15326160864;7083.256258092826;7100.112485939258;7144;6934.306569343227;6938.167419909643;6946.756863509753;6950.409215216561;6955.1653801544135;7052.471064670273;7078.398336141486;7082.575045497287;7084.397826184832;7091.326323999212;6653.367930046637;6927.064846245894;6931.757388491378;6947.68735406918;6977.686004129928 02:08:25 INFO - PROCESS | 1659 | |5;yui.html;724.214227563094;736.4587028534023;806.9112397636262;809.562836068523;819.1808191808192;15933.521994340173;16165.515034548953;16166.83833161668;16169.19154042296;16190.919045404771;14861.405543778235;14877.92561037196;14907.627309317273;14958.62603434912;14962.177080260608;804.6499772598909;819.2340161948567;978.8776402949632;980.181548407081;1006.6275478073123;794.4399198564997;868.7350358140765;1005.4620777883833;1008.596561375452;1009.581023875091;1050.5325130317012;1052.3317693264794;1054.9050585447308;1054.9103326217241;1058.3544038136731;847.9576021198947;1028.655400440853;1053.6048981631889;1054.4727636181908;1056.7146870344964;783.2950344689825;783.4124406694979;784.1061190243128;784.9489783164133;786.0214033528237;15742.449014284559;15866.603334916605;15871;15877.841221587867;15948.601284967852;13299.933500332532;13308.667283317898;13351.265680387574;13544;13683;10207.285490015702;10434.06093451593;10560.419176945265;10842.403667798348;10893.237473376867;3586.1572530455323;3608.1520842601967;3665.065408320888;3665.9450108248398;3766.886993390203;81840.59079704623;82594.9999999994;85253.14746852515;87795.12204877933;88355;9834.606615735434;9927.851082233772;9928.957459466796;9976.351537150062;10182.847257290998;22243.332700019026;22533.549329013327;23601.527969440514;23742.762572374402;23809.642855357182;7845.450818442654;7888.64501097452;7923.445358824827;7947.245011723992;7970.760877173694;4297.978510107492;4342.652587792969;4381.737095774264;4436.157130145262;4640.118377508263;3729.9627003730157;3731.7466220404117;3761.435784632327;3791.33651610967;3801.296760099335;577.4052725692543;669.394198250584;683.6205905722372;698.4307789151926;698.9580625162506;565.3470241870564;597.9820605381846;598.4583951523878;602.5330368964088;605.9939400605938;8064.677412903536;8324.417290789586;8432.03031651368;8442.113578074337;8642.740717778477;519.5090639345782;583.3612194646855;617.3240301869446;625.2902955145851;626.5582764151262;3942.9605703943166;3958.050067983663;3994.7603143811466;4043.6765058795227;4048.719692944778;96151;98749.50625246827;99204;100180.99819001717;100236.49881750545;81568;82885.3422931538;83774;84261.89345266417;85220;55493.99999999919;71483.64258178676;73525.89711154337;73772.63113684398;74415;7817.257360550739;7947.602619869099;8076.71731489395;8100.756977290691;8248.958755206186;50867.20230387216;51190.23214651709;51873.48126518686;51917.740411299215;52484.47515524796;64243;64407.677961611764;66242.33757662361;72604;75028.24971750213;10161.745956351151;10348.379097254188;10397.220208484243;10482.475876206006;10545.472726363805;11031.83452248233;11250.381229032482;11252.212345135762;11306.152038596974;11432.542698291974;10610.098141657736;10991.450427478434;11052.115830733683;11059.72350691239;11212.49543770516;10353.06822385989;10531.631392901212;10594.046535811814;10755;11521.596744113916;10086.646967356108;10119.848202277119;10135.138513226459;10286.2799604027;11030.613928512463;9164.541772911462;9235.538223088954;9363.531823408939;9557.330986830855;9631.229501639993;7548.811279718051;9146.58840352199;9180;9194.770130746518;9311.534423278674 02:08:25 INFO - PROCESS | 1659 | __end_tp_report 02:08:25 INFO - PROCESS | 1659 | __start_cc_report 02:08:25 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1128 02:08:25 INFO - PROCESS | 1659 | __end_cc_report 02:08:25 INFO - PROCESS | 1659 | __startTimestamp1461920905817__endTimestamp 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | ------- Summary: start ------- 02:08:25 INFO - PROCESS | 1659 | Number of tests: 6 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5871.77 Median:6104.69 stddev:620.90 (10.2%) stddev-sans-first:595.61 02:08:25 INFO - PROCESS | 1659 | Values: 3555.2 3634.8 3637.0 3653.2 3700.6 5871.4 5871.9 5884.1 5888.2 5988.0 5865.7 5901.4 5904.4 5919.6 5930.1 5192.5 5280.3 5301.1 5348.1 5403.9 5287.4 5395.3 5402.4 5411.1 5423.0 5350.7 5422.7 5433.8 5437.2 5437.7 5366.6 5400.6 5402.5 5428.5 5472.5 5160.4 5202.6 5257.7 5322.7 5349.8 5804.9 5814.7 5815.7 5826.7 5856.9 6279.4 6352.2 6352.9 6367.4 6368.3 6229.9 6231.7 6266.9 6309.4 6310.4 5974.6 5993.0 6000.4 6006.7 6051.3 6324.9 6372.2 6380.3 6382.2 6383.1 6089.9 6142.0 6243.3 6284.4 6301.8 6259.7 6302.7 6304.4 6305.7 6342.9 6137.3 6320.7 6352.6 6355.5 6359.5 6277.2 6280.2 6350.7 6354.8 6359.7 4960.4 4964.9 4967.5 4969.2 4984.4 4448.5 4489.6 4509.4 4517.1 4534.6 5853.0 5870.5 5878.6 5885.3 5889.6 6248.6 6311.7 6325.9 6333.8 6364.2 5971.3 5983.3 5996.2 6003.0 6059.9 5392.1 5399.6 5454.0 5470.0 5472.5 6405.2 6470.2 6481.1 6501.9 6521.5 6058.5 6296.3 6312.0 6332.2 6339.2 6313.6 6383.3 6388.7 6419.6 6463.3 6294.8 6327.9 6352.7 6360.5 6366.5 6350.6 6351.6 6365.5 6373.7 6380.3 5210.2 6080.3 6104.7 6266.6 6281.3 6188.7 6221.7 6228.5 6248.4 6254.1 6108.3 6111.8 6125.4 6127.3 6140.5 6072.6 6192.3 6204.1 6205.3 6323.5 6092.9 6094.1 6105.7 6112.6 6143.9 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:64958.75 Median:38045.22 stddev:132720.40 (348.8%) stddev-sans-first:133004.45 02:08:25 INFO - PROCESS | 1659 | Values: 489.4 573.2 590.3 603.1 671.9 28088.6 32700.7 40571.6 40746.8 40866.4 43914.0 44417.8 44423.6 44478.0 44643.0 9857.8 10086.0 10098.0 10104.3 10109.3 9828.7 9844.0 9880.1 9945.5 9957.3 10008.9 10133.3 10140.5 10147.0 10163.5 10013.8 10031.3 10037.1 10085.1 10110.4 9873.4 10007.8 10009.8 10011.2 10016.1 42529.4 43395.8 43400.0 43437.8 43456.0 3303.5 3375.2 3452.9 3883.6 4049.6 27599.0 28388.7 28412.6 28424.7 29122.3 2805.5 2827.8 2841.4 2930.3 2943.7 484025.0 493015.0 493937.0 494866.0 495726.0 48003.3 48522.8 48527.0 73900.0 75212.0 47604.0 47719.5 47961.5 47994.5 48017.0 14191.6 17083.1 17246.6 17254.7 17265.7 13259.9 13273.1 13274.3 13305.7 13318.4 13531.8 15209.6 15627.0 15655.9 15770.1 5535.8 6370.9 6506.7 6528.3 6529.4 985.7 1040.7 1049.4 1109.6 1200.6 30690.5 30700.0 31348.5 31358.5 31661.7 1088.6 1170.2 1176.5 1201.4 1275.8 12935.9 13901.7 15807.4 15816.1 15851.4 511170.0 519223.0 520210.0 520653.0 521008.0 61335.4 62788.7 62790.0 62816.7 62966.4 1410.2 1417.7 1419.3 1482.1 1524.2 26315.5 30609.5 31360.1 32366.8 32774.7 59549.0 59929.0 60684.0 60910.4 60946.4 483736.0 487302.0 488518.0 489091.2 489280.0 40760.6 47234.1 47840.3 48015.5 48819.5 45430.0 46218.6 46305.8 47467.3 47919.5 35526.9 37046.1 38732.8 39152.0 39421.8 37802.6 38287.8 38618.8 39130.8 39497.6 34184.0 38723.2 42107.0 42110.6 42249.6 31660.2 34049.0 34293.8 34692.8 34968.3 22622.0 25850.0 25898.1 26062.0 26290.3 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:36454.88 Median:20448.54 stddev:109666.08 (536.3%) stddev-sans-first:109940.28 02:08:25 INFO - PROCESS | 1659 | Values: 384.4 385.3 388.2 393.5 393.7 14717.6 15339.2 17247.1 17782.7 20444.4 21165.0 21168.6 22021.7 22047.1 22112.7 5783.9 5929.5 6038.8 6050.2 6051.8 4115.4 5782.4 5880.3 5929.6 6034.6 6015.7 6016.3 6018.9 6021.4 6024.7 5993.1 6174.4 6361.5 6552.7 6559.3 5749.0 5757.8 5760.5 5766.0 5773.2 18853.7 19881.9 25780.1 26634.9 26643.3 1938.2 2156.1 2267.7 2272.5 2385.4 9847.4 9946.2 10317.4 10417.8 10460.6 1808.4 1825.4 1865.9 1896.9 1910.7 84806.6 99891.0 105024.5 108027.0 108249.0 11457.9 11577.8 11604.9 11614.3 11687.9 12463.6 12880.7 12900.5 14481.6 14494.8 8541.3 8812.6 8925.1 8993.7 8995.0 9156.6 9179.5 9210.4 9243.0 9301.3 4445.8 4527.8 4537.0 4537.2 4562.9 1888.5 1946.3 1947.2 1975.2 1982.0 912.8 1020.9 1057.9 1067.6 1072.8 20035.5 20452.7 20515.8 20734.2 20735.3 1032.7 1054.8 1072.6 1096.2 1111.7 10722.6 11272.8 11274.7 11302.6 11347.6 650075.0 659495.0 659813.0 672080.0 673754.0 117548.4 119801.8 121810.4 122547.0 126396.7 970.2 1062.2 1078.6 1097.8 1109.6 18595.5 18728.3 19154.0 19170.7 19410.8 54501.7 54825.0 56521.8 56909.0 58316.0 79471.6 79902.2 79917.0 80229.0 81857.6 7970.4 7978.4 8233.0 8307.6 8310.5 9908.6 13106.5 13271.1 13464.3 13495.3 11435.2 11699.4 11734.1 11843.6 11970.1 11568.5 11742.5 11814.5 11951.2 12094.2 12011.5 12119.3 12138.5 12259.8 12265.0 8777.0 11695.4 11940.6 11981.9 12369.9 11710.5 12054.8 12070.6 12090.0 12337.4 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:6431.39 Median:5143.75 stddev:3418.04 (66.5%) stddev-sans-first:3407.42 02:08:25 INFO - PROCESS | 1659 | Values: 1486.7 1658.9 1684.8 2068.9 2127.5 8434.7 9095.5 9264.0 9264.2 9270.5 8960.6 9258.2 9263.7 9269.8 9276.1 2584.4 2589.3 2610.7 2616.7 2621.7 2534.5 2635.6 2639.6 2641.7 2652.9 2605.9 2625.5 2645.6 2646.4 2651.4 2593.9 2616.5 2637.1 2640.7 2643.9 2611.9 2627.3 2642.0 2646.7 2653.0 9300.0 9338.7 9349.3 9349.6 9359.0 4643.6 5826.6 5896.1 5905.5 5908.6 3713.8 3796.3 3870.8 3878.2 3881.2 1076.7 1084.8 1086.2 1105.7 1126.7 12622.6 12637.9 12642.6 12653.9 12654.8 4845.3 5100.3 5187.2 5207.1 5220.6 10678.7 10716.4 10722.1 10722.6 10759.2 5823.9 5889.2 5890.6 5895.9 5897.1 4574.6 4729.1 5100.3 5288.1 5300.3 4096.4 4153.4 4192.7 4203.6 4226.6 1217.3 1353.2 1378.5 1378.5 1390.5 1407.1 1432.9 1452.4 1461.9 1480.1 8640.2 8683.7 8694.1 8706.2 8711.1 528.2 536.0 543.2 543.4 545.8 6435.6 6463.4 6477.1 6494.7 6495.5 11038.9 11523.9 11536.8 11544.7 11568.1 11189.2 11210.0 11293.9 11365.9 11395.4 8889.8 8980.1 8986.1 8997.8 9010.3 8245.0 8432.2 8460.5 8475.2 8482.8 10102.2 10186.2 10310.3 10344.4 10357.5 10264.9 10308.7 10647.9 10665.3 10840.8 7235.5 7448.1 7972.3 8078.9 8542.1 8805.0 8816.0 8869.2 8876.6 8891.4 7624.8 7699.9 7786.9 7907.0 7924.7 7276.7 7560.7 7595.8 7740.9 7785.4 8152.1 8322.6 8327.9 8332.5 8344.3 7359.0 7482.6 7500.4 7511.8 7513.8 7580.2 7583.4 7653.0 7654.9 7658.4 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5769.18 Median:6630.45 stddev:1823.21 (27.5%) stddev-sans-first:1782.14 02:08:25 INFO - PROCESS | 1659 | Values: 335.9 337.5 344.1 345.8 350.5 6685.3 6706.0 6740.2 6747.2 6759.0 5640.7 6289.5 6604.2 6610.7 6650.2 4732.7 4850.9 4872.8 4886.9 4974.5 4870.4 4894.3 4910.5 4974.7 5013.2 4920.6 4942.6 4944.4 4954.0 4990.7 4929.1 4934.3 4943.4 4944.5 4955.3 3165.9 3969.0 4064.2 4141.9 4164.0 6214.9 6244.3 6257.6 6281.5 6292.5 5693.7 5718.8 5723.9 5735.9 5737.9 6933.6 6937.4 6940.4 6944.0 6953.9 4703.4 4705.0 4714.2 4715.9 4722.2 5731.5 7398.3 7422.4 7453.7 7459.3 4604.7 4676.8 4679.8 4682.3 4695.0 4788.9 4793.7 4794.8 4799.3 4802.3 5641.0 5653.5 5662.7 5665.2 5674.0 6141.9 6674.9 6748.2 7049.0 7067.8 1619.7 1656.1 1656.1 1656.8 1661.5 1027.2 1047.2 1060.6 1063.4 1065.1 6120.2 6722.6 6728.5 6745.7 6756.2 7005.0 7230.2 7235.9 7381.6 7402.6 6755.6 6770.8 6774.8 6778.8 6798.7 3848.9 3877.6 3881.4 3887.8 3897.3 6193.7 7351.3 7642.3 7643.7 7644.5 7544.2 7554.5 7560.0 7576.1 7589.1 6152.0 6460.8 7331.8 7600.2 7665.4 7324.5 7325.2 7327.9 7328.1 7345.1 6927.9 7175.7 7198.5 7199.1 7213.9 7675.7 7714.8 7716.8 7718.0 7751.4 4681.8 4710.3 4726.3 4726.4 4728.7 6046.8 7305.8 7321.2 7338.2 7338.7 6786.3 7034.7 7046.6 7049.6 7050.5 7035.4 7056.2 7083.3 7100.1 7144.0 6934.3 6938.2 6946.8 6950.4 6955.2 7052.5 7078.4 7082.6 7084.4 7091.3 6653.4 6927.1 6931.8 6947.7 6977.7 02:08:25 INFO - PROCESS | 1659 | 02:08:25 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:18919.18 Median:27753.66 stddev:27008.23 (97.3%) stddev-sans-first:27049.44 02:08:25 INFO - PROCESS | 1659 | Values: 724.2 736.5 806.9 809.6 819.2 15933.5 16165.5 16166.8 16169.2 16190.9 14861.4 14877.9 14907.6 14958.6 14962.2 804.6 819.2 978.9 980.2 1006.6 794.4 868.7 1005.5 1008.6 1009.6 1050.5 1052.3 1054.9 1054.9 1058.4 848.0 1028.7 1053.6 1054.5 1056.7 783.3 783.4 784.1 784.9 786.0 15742.4 15866.6 15871.0 15877.8 15948.6 13299.9 13308.7 13351.3 13544.0 13683.0 10207.3 10434.1 10560.4 10842.4 10893.2 3586.2 3608.2 3665.1 3665.9 3766.9 81840.6 82595.0 85253.1 87795.1 88355.0 9834.6 9927.9 9929.0 9976.4 10182.8 22243.3 22533.5 23601.5 23742.8 23809.6 7845.5 7888.6 7923.4 7947.2 7970.8 4298.0 4342.7 4381.7 4436.2 4640.1 3730.0 3731.7 3761.4 3791.3 3801.3 577.4 669.4 683.6 698.4 699.0 565.3 598.0 598.5 602.5 606.0 8064.7 8324.4 8432.0 8442.1 8642.7 519.5 583.4 617.3 625.3 626.6 3943.0 3958.1 3994.8 4043.7 4048.7 96151.0 98749.5 99204.0 100181.0 100236.5 81568.0 82885.3 83774.0 84261.9 85220.0 55494.0 71483.6 73525.9 73772.6 74415.0 7817.3 7947.6 8076.7 8100.8 8249.0 50867.2 51190.2 51873.5 51917.7 52484.5 64243.0 64407.7 66242.3 72604.0 75028.2 10161.7 10348.4 10397.2 10482.5 10545.5 11031.8 11250.4 11252.2 11306.2 11432.5 10610.1 10991.5 11052.1 11059.7 11212.5 10353.1 10531.6 10594.0 10755.0 11521.6 10086.6 10119.8 10135.1 10286.3 11030.6 9164.5 9235.5 9363.5 9557.3 9631.2 7548.8 9146.6 9180.0 9194.8 9311.5 02:08:25 INFO - PROCESS | 1659 | -------- Summary: end -------- 02:08:25 INFO - PROCESS | 1659 | 02:08:26 INFO - TEST-INFO | 1659: exit 0 02:08:26 INFO - TEST-OK | dromaeo_css | took 1112159ms 02:08:26 INFO - TEST-START | kraken 02:08:26 INFO - operating with platform_type : mac_ 02:08:26 INFO - Initialising browser for kraken test... 02:08:26 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmppye1Us/profile http://localhost:49275/getInfo.html) 02:08:28 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 02:08:28 INFO - PROCESS | 1668 | colorDepth:24 02:08:28 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 02:08:28 INFO - PROCESS | 1668 | __metrics 02:08:28 INFO - PROCESS | 1668 | 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" 02:08:28 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:28 INFO - TEST-INFO | 1668: exit 0 02:08:28 INFO - Browser initialized. 02:08:28 INFO - Running cycle 1/1 for kraken test... 02:08:29 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmppye1Us/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:40 INFO - PROCESS | 1671 | RSS: Main: 157192192 02:08:40 INFO - PROCESS | 1671 | 02:08:43 INFO - PROCESS | 1671 | 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) 02:08:44 INFO - PROCESS | 1671 | RSS: Main: 212312064 02:08:44 INFO - PROCESS | 1671 | 02:08:46 INFO - PROCESS | 1671 | 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) 02:08:47 INFO - PROCESS | 1671 | RSS: Main: 223047680 02:08:47 INFO - PROCESS | 1671 | 02:08:50 INFO - PROCESS | 1671 | 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) 02:08:51 INFO - PROCESS | 1671 | RSS: Main: 213655552 02:08:51 INFO - PROCESS | 1671 | 02:08:53 INFO - PROCESS | 1671 | 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) 02:08:53 INFO - PROCESS | 1671 | RSS: Main: 214573056 02:08:53 INFO - PROCESS | 1671 | 02:08:55 INFO - PROCESS | 1671 | 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) 02:08:56 INFO - PROCESS | 1671 | RSS: Main: 213934080 02:08:56 INFO - PROCESS | 1671 | 02:08:58 INFO - PROCESS | 1671 | 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) 02:08:59 INFO - PROCESS | 1671 | RSS: Main: 215453696 02:08:59 INFO - PROCESS | 1671 | 02:09:02 INFO - PROCESS | 1671 | 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) 02:09:02 INFO - PROCESS | 1671 | RSS: Main: 215457792 02:09:02 INFO - PROCESS | 1671 | 02:09:05 INFO - PROCESS | 1671 | 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) 02:09:06 INFO - PROCESS | 1671 | RSS: Main: 215789568 02:09:06 INFO - PROCESS | 1671 | 02:09:07 INFO - PROCESS | 1671 | 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) 02:09:08 INFO - PROCESS | 1671 | RSS: Main: 249692160 02:09:08 INFO - PROCESS | 1671 | 02:09:10 INFO - PROCESS | 1671 | 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) 02:09:10 INFO - PROCESS | 1671 | RSS: Main: 250707968 02:09:10 INFO - PROCESS | 1671 | 02:09:13 INFO - PROCESS | 1671 | 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) 02:09:13 INFO - PROCESS | 1671 | RSS: Main: 255647744 02:09:13 INFO - PROCESS | 1671 | 02:09:16 INFO - PROCESS | 1671 | 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) 02:09:16 INFO - PROCESS | 1671 | RSS: Main: 257114112 02:09:16 INFO - PROCESS | 1671 | 02:09:19 INFO - PROCESS | 1671 | 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) 02:09:19 INFO - PROCESS | 1671 | RSS: Main: 256958464 02:09:19 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | 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) 02:09:21 INFO - PROCESS | 1671 | RSS: Main: 320217088 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | __start_tp_report 02:09:21 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 02:09:21 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 02:09:21 INFO - PROCESS | 1671 | |i|pagename|runs| 02:09:21 INFO - PROCESS | 1671 | |0;ai-astar;113;108;111;110;112;113;120;111;115;162 02:09:21 INFO - PROCESS | 1671 | |1;audio-beat-detection;153;138;186;150;118;137;117;148;147;115 02:09:21 INFO - PROCESS | 1671 | |2;audio-dft;182;183;184;188;186;187;182;181;182;183 02:09:21 INFO - PROCESS | 1671 | |3;audio-fft;84;74;73;117;50;48;59;73;145;82 02:09:21 INFO - PROCESS | 1671 | |4;audio-oscillator;91;88;129;80;77;78;120;77;78;114 02:09:21 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;90;87;90;87;89;87;90;88;89;90 02:09:21 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;94;95;95;95;94;94;94;93;93 02:09:21 INFO - PROCESS | 1671 | |7;imaging-desaturate;85;95;128;85;84;84;88;96;133;133 02:09:21 INFO - PROCESS | 1671 | |8;json-parse-financial;52;57;58;57;59;57;58;57;52;50 02:09:21 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;62;61;67;71;70;67;64;64;65;66 02:09:21 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;79;95;67;81;68;90;68;77;97;108 02:09:21 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;117;133;125;130;111;118;117;116;116;121 02:09:21 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;136;123;133;134;134;126;134;136;131;133 02:09:21 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;62;60;59;65;63;68;66;81;96;79 02:09:21 INFO - PROCESS | 1671 | __end_tp_report 02:09:21 INFO - PROCESS | 1671 | __start_cc_report 02:09:21 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1214 02:09:21 INFO - PROCESS | 1671 | __end_cc_report 02:09:21 INFO - PROCESS | 1671 | __startTimestamp1461920961711__endTimestamp 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | ------- Summary: start ------- 02:09:21 INFO - PROCESS | 1671 | Number of tests: 14 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:117.50 Median:113.00 stddev:15.97 (14.1%) stddev-sans-first:16.85 02:09:21 INFO - PROCESS | 1671 | Values: 113.0 108.0 111.0 110.0 112.0 113.0 120.0 111.0 115.0 162.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.50 stddev:21.45 (14.5%) stddev-sans-first:22.30 02:09:21 INFO - PROCESS | 1671 | Values: 153.0 138.0 186.0 150.0 118.0 137.0 117.0 148.0 147.0 115.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.80 Median:183.50 stddev:2.39 (1.3%) stddev-sans-first:2.45 02:09:21 INFO - PROCESS | 1671 | Values: 182.0 183.0 184.0 188.0 186.0 187.0 182.0 181.0 182.0 183.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:80.50 Median:73.00 stddev:30.02 (41.1%) stddev-sans-first:31.81 02:09:21 INFO - PROCESS | 1671 | Values: 84.0 74.0 73.0 117.0 50.0 48.0 59.0 73.0 145.0 82.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:78.00 stddev:20.07 (25.7%) stddev-sans-first:21.27 02:09:21 INFO - PROCESS | 1671 | Values: 91.0 88.0 129.0 80.0 77.0 78.0 120.0 77.0 78.0 114.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:1.34 (1.5%) stddev-sans-first:1.33 02:09:21 INFO - PROCESS | 1671 | Values: 90.0 87.0 90.0 87.0 89.0 87.0 90.0 88.0 89.0 90.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 02:09:21 INFO - PROCESS | 1671 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 93.0 93.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:101.10 Median:85.00 stddev:21.34 (25.1%) stddev-sans-first:21.82 02:09:21 INFO - PROCESS | 1671 | Values: 85.0 95.0 128.0 85.0 84.0 84.0 88.0 96.0 133.0 133.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:3.13 (5.5%) stddev-sans-first:3.02 02:09:21 INFO - PROCESS | 1671 | Values: 52.0 57.0 58.0 57.0 59.0 57.0 58.0 57.0 52.0 50.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.50 stddev:3.20 (4.8%) stddev-sans-first:3.10 02:09:21 INFO - PROCESS | 1671 | Values: 62.0 61.0 67.0 71.0 70.0 67.0 64.0 64.0 65.0 66.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:14.05 (17.6%) stddev-sans-first:14.82 02:09:21 INFO - PROCESS | 1671 | Values: 79.0 95.0 67.0 81.0 68.0 90.0 68.0 77.0 97.0 108.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:119.50 stddev:6.90 (5.8%) stddev-sans-first:7.21 02:09:21 INFO - PROCESS | 1671 | Values: 117.0 133.0 125.0 130.0 111.0 118.0 117.0 116.0 116.0 121.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.00 Median:134.00 stddev:4.27 (3.2%) stddev-sans-first:4.28 02:09:21 INFO - PROCESS | 1671 | Values: 136.0 123.0 133.0 134.0 134.0 126.0 134.0 136.0 131.0 133.0 02:09:21 INFO - PROCESS | 1671 | 02:09:21 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:67.00 stddev:11.82 (17.6%) stddev-sans-first:12.18 02:09:21 INFO - PROCESS | 1671 | Values: 62.0 60.0 59.0 65.0 63.0 68.0 66.0 81.0 96.0 79.0 02:09:21 INFO - PROCESS | 1671 | -------- Summary: end -------- 02:09:21 INFO - PROCESS | 1671 | 02:09:22 INFO - TEST-INFO | 1671: exit 0 02:09:22 INFO - TEST-OK | kraken | took 56099ms 02:09:22 INFO - SUITE-END | took 1168s 02:09:22 INFO - Completed test suite (00:19:28) 02:09:22 INFO - javascript benchmark 02:09:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3555.1823080691443, 3634.7819130852135, 3636.9818150909223, 3653.1780349421383, 3700.629937006298, 5871.383504732005, 5871.9412805871925, 5884.146798714184, 5888.205092312536, 5988.041913293874, 5865.677387743673, 5901.380355062721, 5904.350521442649, 5919.585629005961, 5930.140129681194, 5192.532672059514, 5280.287161233232, 5301.072312345344, 5348.117560602496, 5403.945960540404, 5287.444818294062, 5395.325584301962, 5402.37872644647, 5411.080116380225, 5423.0, 5350.742575494755, 5422.701751403672, 5433.755481003344, 5437.238786569884, 5437.700926449063, 5366.597505187126, 5400.567954563626, 5402.540784033362, 5428.538574221196, 5472.50747432733, 5160.380754309469, 5202.609804264695, 5257.684538927639, 5322.7338633068575, 5349.759260833272, 5804.912926306109, 5814.709264536798, 5815.651060936358, 5826.650400975913, 5856.941430585683, 6279.434850863398, 6352.237731472253, 6352.904706429407, 6367.426931576134, 6368.267649220353, 6229.87540249197, 6231.6572588507615, 6266.937330626681, 6309.432151106423, 6310.368963103699, 5974.641521508724, 5993.013300642319, 6000.399960004008, 6006.6696331701305, 6051.334353221142, 6324.936750632527, 6372.235331760218, 6380.330065343072, 6382.234131904202, 6383.106365108889, 6089.939100609025, 6141.955867502446, 6243.344448832898, 6284.4344009039405, 6301.77943771975, 6259.655718935503, 6302.684865756693, 6304.401081897213, 6305.716242769086, 6342.904856427157, 6137.294211165684, 6320.715567799368, 6352.555321127476, 6355.491560675227, 6359.459445947146, 6277.18396608438, 6280.246370435486, 6350.650714210763, 6354.841128971812, 6359.650219237987, 4960.355153830051, 4964.875878103004, 4967.503249675004, 4969.155243608595, 4984.42679091909, 4448.488423831301, 4489.595936365743, 4509.391232183613, 4517.141743068806, 4534.59188673021, 5853.0, 5870.501007414332, 5878.617889837147, 5885.264341957255, 5889.617174883619, 6248.625082495065, 6311.715972781236, 6325.873482530324, 6333.778317758856, 6364.172657554488, 5971.313298970587, 5983.282006159202, 5996.190514280516, 6002.969985150046, 6059.909101363483, 5392.110301800159, 5399.568034557226, 5454.018276710231, 5469.972650136724, 5472.452754724575, 6405.19935008124, 6470.1588793457495, 6481.125048118538, 6501.869962600722, 6521.478281737354, 6058.5153187745755, 6296.275928268308, 6311.968440157953, 6332.240131184288, 6339.207599050119, 6313.558050936574, 6383.2978372378075, 6388.68056597159, 6419.550631455753, 6463.25672547663, 6294.8111556653375, 6327.905081423874, 6352.745890164341, 6360.459360954371, 6366.522510811615, 6350.618962862243, 6351.618902865843, 6365.458935990493, 6373.681315934092, 6380.266269378895, 5210.192420174727, 6080.270367555921, 6104.694765261808, 6266.592671476339, 6281.3404592518955, 6188.659623720739, 6221.657808820558, 6228.532860035606, 6248.375162483715, 6254.061890716429, 6108.267007959073, 6111.786087486917, 6125.418085281891, 6127.264728232641, 6140.539459540463, 6072.60528065692, 6192.2569291683485, 6204.069389591597, 6205.2553693555255, 6323.4625056868845, 6092.9086063709965, 6094.085887116968, 6105.664188469676, 6112.563547566408, 6143.877122457615], "unit": "score", "name": "dojo.html", "value": 5834.201760154561}, {"lowerIsBetter": false, "replicates": [489.3760455419342, 573.2347316332696, 590.3476658292584, 603.0742809786977, 671.8790617688817, 28088.578671319945, 32700.672993270062, 40571.59428405715, 40746.79626601863, 40866.38700419488, 43914.0, 44417.77791111048, 44423.555764442346, 44478.0, 44643.0, 9857.7535561611, 10086.041826026552, 10098.0, 10104.292699511037, 10109.342892711988, 9828.655997040105, 9844.0, 9880.061394167542, 9945.453000085028, 9957.302988790787, 10008.89991100087, 10133.341332813381, 10140.543675534582, 10146.985301469831, 10163.491825408737, 10013.79972400548, 10031.297809153362, 10037.096661300482, 10085.142762865165, 10110.44392558409, 9873.358231714916, 10007.849882251772, 10009.849852252222, 10011.19910407173, 10016.098551130433, 42529.36205956913, 43395.783021084695, 43400.0, 43437.78281108606, 43456.0, 3303.487959366302, 3375.1730825947557, 3452.9482057769155, 3883.611638836122, 4049.5747946465785, 27599.0, 28388.716112838814, 28412.573811392846, 28424.73115591713, 29122.271943201376, 2805.5230610796216, 2827.7879159063154, 2841.4459180459817, 2930.3113768264443, 2943.6877010444227, 484025.0, 493015.0, 493936.9999999964, 494866.0, 495726.0, 48003.27995080077, 48522.75738621355, 48527.0, 73900.0, 75212.0, 47604.0, 47719.522804771506, 47961.5203847957, 47994.5200547997, 48017.0, 14191.574252772434, 17083.060431676127, 17246.568835778955, 17254.654906902044, 17265.741013884803, 13259.867401326057, 13273.070885037954, 13274.336283185801, 13305.66735831612, 13318.400671969785, 13531.849792767725, 15209.6197595061, 15626.984246023972, 15655.921720391552, 15770.132642704531, 5535.750891209906, 6370.904436433457, 6506.739730410825, 6528.347165283433, 6529.444997175198, 985.7042887133831, 1040.6877936618985, 1049.3913530152645, 1109.611635927419, 1200.609801814414, 30690.53964190539, 30700.0, 31348.529772053436, 31358.47755361111, 31661.683383166335, 1088.5700148441322, 1170.1867202294325, 1176.4647085576041, 1201.3512703140382, 1275.7639836630253, 12935.870641293466, 13901.652458688412, 15807.446739364066, 15816.05103693782, 15851.445199417965, 511170.0, 519223.0, 520210.0, 520653.0, 521008.0, 61335.38664613386, 62788.68605656942, 62790.0, 62816.685916570124, 62966.425839354386, 1410.1609542322508, 1417.6603110060894, 1419.283261952728, 1482.1033274868548, 1524.2454984782382, 26315.473690526465, 30609.54085688761, 31360.05919822409, 32366.838165809022, 32774.68901243924, 59549.0, 59929.0, 60684.0, 60910.390896090474, 60946.39053609407, 483736.0, 487302.0, 488518.0, 489091.2181756416, 489280.0, 40760.59239407568, 47234.055318892744, 47840.282395764785, 48015.519844802504, 48819.5118048815, 45430.0, 46218.613441596804, 46305.84235394142, 47467.28799068086, 47919.52080479151, 35526.93419197428, 37046.07384815401, 38732.80633596814, 39152.0, 39421.80289098536, 37802.62197378101, 38287.80856095702, 38618.84143475588, 39130.80434597809, 39497.60502394939, 34184.0, 38723.2255354897, 42107.0, 42110.57889421067, 42249.577504224566, 31660.208494787814, 34048.97853064412, 34293.82711112024, 34692.785752498545, 34968.30063398667, 22622.0, 25850.0, 25898.093566725074, 26062.0, 26290.342741431617], "unit": "score", "name": "ext.html", "value": 20199.518929321584}, {"lowerIsBetter": false, "replicates": [384.4387194695744, 385.32568005989526, 388.21192978254135, 393.5061497820235, 393.661451152009, 14717.558473245806, 15339.23303834808, 17247.051412172324, 17782.733259001125, 20444.386668399955, 21165.0, 21168.57662846742, 22021.66967495489, 22047.11811527541, 22112.668309975365, 5783.913241301384, 5929.495992840613, 6038.818835434922, 6050.2437195350585, 6051.788187413442, 4115.403266526352, 5782.421757824205, 5880.26496687914, 5929.555283353744, 6034.577579569432, 6015.729292181863, 6016.27804663441, 6018.8796224075495, 6021.397860213965, 6024.704688491974, 5993.101034844764, 6174.444300012998, 6361.491080713532, 6552.705128269239, 6559.27847936729, 5748.993926062923, 5757.769689212427, 5760.452756988079, 5765.971170144123, 5773.220615216934, 18853.717194242097, 19881.900590496956, 25780.097696580717, 26634.93460261587, 26643.333916652045, 1938.2440848069123, 2156.105216335219, 2267.671187677794, 2272.488690044727, 2385.355953892439, 9847.359921605144, 9946.154576860976, 10317.38095714252, 10417.791644167075, 10460.581576736922, 1808.3761102419644, 1825.3596387163727, 1865.9346922857635, 1896.8672192946499, 1910.694288913781, 84806.57596711977, 99891.0, 105024.4748776259, 108027.0, 108249.0, 11457.942710286561, 11577.76844463106, 11604.94197529007, 11614.30314181135, 11687.88312116885, 12463.563775267821, 12880.742385152433, 12900.548480803127, 14481.637959051108, 14494.782578261334, 8541.316694664536, 8812.559372031374, 8925.062868398854, 8993.685221017233, 8995.0, 9156.587953542106, 9179.541022948826, 9210.401323913924, 9243.0, 9301.255899528021, 4445.844395446144, 4527.777500074962, 4537.0, 4537.2059889519205, 4562.885927851764, 1888.4712280561464, 1946.3090602836073, 1947.2405761752927, 1975.190172029461, 1981.959471277562, 912.8493798523302, 1020.9081182693593, 1057.862477877871, 1067.631667074858, 1072.790805792863, 20035.499112522302, 20452.693209601868, 20515.836427521124, 20734.170633174504, 20735.27426540094, 1032.726327523207, 1054.841773733946, 1072.5763323487336, 1096.17786660005, 1111.7276267314398, 10722.571097156182, 11272.830907536394, 11274.7181320466, 11302.604408845651, 11347.602833900939, 650075.0, 659495.0, 659813.0, 672080.0, 673754.0, 117548.41225793817, 119801.80198197906, 121810.39094804646, 122547.0, 126396.73603264033, 970.1608108985677, 1062.1608928946046, 1078.6494389323502, 1097.8023955688052, 1109.5949978258038, 18595.535111622317, 18728.25086996505, 19154.0, 19170.712439313702, 19410.8058919409, 54501.72749136229, 54825.0, 56521.760847956546, 56909.0, 58316.0, 79471.60264198642, 79902.20097798947, 79917.0, 80229.0, 81857.59071204606, 7970.362371010421, 7978.441509094308, 8233.012038555173, 8307.584620769057, 8310.459820111673, 9908.603655853685, 13106.541271055466, 13271.137376070525, 13464.259465729087, 13495.25776082325, 11435.199536032398, 11699.415029248334, 11734.061275098142, 11843.644690659294, 11970.102242332034, 11568.537258509565, 11742.471588778697, 11814.527418903148, 11951.22317049389, 12094.213876098025, 12011.459484323052, 12119.272843629411, 12138.453769580214, 12259.816102758645, 12265.0, 8776.990646075528, 11695.415229238673, 11940.582079627171, 11981.880181198425, 12369.93815030919, 11710.4730287139, 12054.75890482168, 12070.577529786766, 12089.972352350149, 12337.444814983168], "unit": "score", "name": "jquery.html", "value": 9821.619577654768}, {"lowerIsBetter": false, "replicates": [1486.7175236705018, 1658.8838781285308, 1684.8399402056807, 2068.9068991895365, 2127.5319429725464, 8434.66261349546, 9095.499747513884, 9264.0, 9264.166225039753, 9270.49012304323, 8960.551972401387, 9258.166764991149, 9263.722088337343, 9269.814603707922, 9276.118768716979, 2584.4185058361813, 2589.262060312811, 2610.6997695265004, 2616.725243849397, 2621.698504671968, 2534.5437821192177, 2635.6441880346197, 2639.6436481075098, 2641.6565846439935, 2652.8938842446278, 2605.9218223453327, 2625.514279858223, 2645.5634820254636, 2646.4310173312733, 2651.3504191473116, 2593.909213177539, 2616.489784492015, 2637.1033848491606, 2640.6567146271054, 2643.8810253538636, 2611.8824652890667, 2627.2906315294763, 2642.0, 2646.7485588869026, 2652.9602055969176, 9299.953500232456, 9338.673146439842, 9349.298802589765, 9349.626014959393, 9359.0, 4643.605293550052, 5826.563007774434, 5896.115582662592, 5905.468507834273, 5908.615939963932, 3713.795741234231, 3796.2787070456525, 3870.767753934773, 3878.1661942682176, 3881.204353107606, 1076.7361996310954, 1084.7613525024483, 1086.1907878630393, 1105.6959336182533, 1126.6563698072084, 12622.621321360373, 12637.936810315981, 12642.55751048718, 12653.87346126536, 12654.81017784734, 4845.345878306454, 5100.311457953203, 5187.19598462239, 5207.062728708869, 5220.608454365938, 10678.73303167427, 10716.410597417062, 10722.088622467021, 10722.571097156026, 10759.246852720235, 5823.912641310384, 5889.234399528034, 5890.558208134407, 5895.911561326584, 5897.056470964711, 4574.611158051536, 4729.07782982322, 5100.311457953203, 5288.127458969227, 5300.31095957523, 4096.392684589618, 4153.3769934510065, 4192.7065105442325, 4203.62167404935, 4226.57734226581, 1217.3243849663345, 1353.15427857589, 1378.5244090788663, 1378.5244090788663, 1390.5341710526884, 1407.099456347938, 1432.9426822926966, 1452.353702602353, 1461.8976671633097, 1480.067557438828, 8640.222379985831, 8683.6526538939, 8694.130586941255, 8706.216440520257, 8711.08533603975, 528.183955788308, 535.9785608575613, 543.2259030880979, 543.3778323819283, 545.7653209120037, 6435.613863168225, 6463.418292353711, 6477.125588045647, 6494.675266236669, 6495.4803615710625, 11038.944805276084, 11523.942380288045, 11536.788637193142, 11544.653660390202, 11568.132390070778, 11189.160812938899, 11210.047145992681, 11293.887061129448, 11365.943170284261, 11395.430228488542, 8889.777755556033, 8980.057094005166, 8986.101389861093, 8997.820043599091, 9010.3242256831, 8244.958775206085, 8432.198941100585, 8460.450070745383, 8475.152484751723, 8482.787930301793, 10102.242331824995, 10186.236032297755, 10310.278280520291, 10344.431056291976, 10357.533910973874, 10264.948675256575, 10308.690739277834, 10647.94676026615, 10665.253432259668, 10840.837387439036, 7235.457340699574, 7448.143463501767, 7972.322352600094, 8078.87881681787, 8542.060373358801, 8804.955975220082, 8815.9861615915, 8869.157430044135, 8876.644934202559, 8891.377603567948, 7624.771256862303, 7699.923000770144, 7786.88319675194, 7907.011623547057, 7924.722634707758, 7276.745313913988, 7560.735374261874, 7595.772126836204, 7740.92259077402, 7785.377169826514, 8152.062512811102, 8322.625481853453, 8327.916720832714, 8332.541710205996, 8344.332453403835, 7358.963205184154, 7482.588457634883, 7500.36246919018, 7511.8497630046, 7513.812154696177, 7580.204078571891, 7583.355414789805, 7653.043369578802, 7654.885176722465, 7658.425618078778], "unit": "score", "name": "mootools.html", "value": 5151.975248564256}, {"lowerIsBetter": false, "replicates": [335.92945481448896, 337.51566502069534, 344.10704222542495, 345.8426415980728, 350.47953788623903, 6685.2980437054075, 6706.0, 6740.22487413947, 6747.156605424322, 6758.966205168979, 5640.717964101799, 6289.465395441393, 6604.2074951005825, 6610.702518386672, 6650.201975762903, 4732.7160370377715, 4850.927236091461, 4872.7563621818945, 4886.926696099561, 4974.457918045399, 4870.415550133971, 4894.3147959285725, 4910.508949105097, 4974.701517908937, 5013.248012798073, 4920.557149856512, 4942.6293028022865, 4944.406671199443, 4954.0, 4990.65065445419, 4929.088118698017, 4934.25986102084, 4943.406791185045, 4944.505549445063, 4955.331030310898, 3165.876113979527, 3968.960310396888, 4064.248114098901, 4141.91716165675, 4164.0, 6214.906776398358, 6244.313125556185, 6257.5932564383165, 6281.528885333572, 6292.465140463066, 5693.7437815298, 5718.771249150029, 5723.885522289573, 5735.8528294341295, 5737.88524229513, 6933.583984960918, 6937.445004399636, 6940.410065144419, 6943.9652801735665, 6953.89569156463, 4703.412073490814, 4705.035467729107, 4714.151452738506, 4715.858524244244, 4722.220833562458, 5731.484166425, 7398.260173982559, 7422.369098626623, 7453.739119130804, 7459.328660420588, 4604.700694454849, 4676.789544470507, 4679.789409476582, 4682.297655351656, 4694.953050469451, 4788.856334309976, 4793.688410253322, 4794.808207671724, 4799.256115302133, 4802.327674125625, 5641.01026455979, 5653.547716182696, 5662.66024038559, 5665.206871038058, 5673.971630141823, 6141.8944589974235, 6674.866502669919, 6748.190217173872, 7048.964755176191, 7067.787966361017, 1619.6922584708868, 1656.097426902341, 1656.1470842515873, 1656.8177500474937, 1661.4797460323668, 1027.209049032241, 1047.1616021080852, 1060.6287799270349, 1063.409807556798, 1065.0574241795912, 6120.234970628671, 6722.596644201266, 6728.495362847806, 6745.662716864137, 6756.155480564929, 7004.964975175091, 7230.240824713434, 7235.89146162808, 7381.630918454056, 7402.592857392895, 6755.560888542327, 6770.763023294161, 6774.762883299061, 6778.847595908707, 6798.694058767367, 3848.8652897148463, 3877.592852750477, 3881.4177873319227, 3887.7667339959694, 3897.2595206910596, 6193.659348735863, 7351.264873512606, 7642.273983971514, 7643.656035478417, 7644.503107298008, 7544.170141284454, 7554.546727196386, 7559.962200188964, 7576.090869095744, 7589.1272503661685, 6152.0, 6460.806175814733, 7331.816704582428, 7600.1639819619795, 7665.425093118039, 7324.487285889936, 7325.230850760593, 7327.8534429312185, 7328.120625524971, 7345.118585769742, 6927.930720692729, 7175.677094530863, 7198.49610527258, 7199.1001124859395, 7213.927860721536, 7675.731349402968, 7714.801281634707, 7716.7684969451, 7718.0, 7751.41864360164, 4681.789319480699, 4710.269908164103, 4726.338312636165, 4726.36194113804, 4728.692634978715, 6046.788362407295, 7305.780826575211, 7321.194668586558, 7338.192798792022, 7338.743143989935, 6786.321367863175, 7034.718611255493, 7046.647667616701, 7049.647517624201, 7050.541714788523, 7035.366816986496, 7056.15326160864, 7083.256258092826, 7100.112485939258, 7144.0, 6934.306569343227, 6938.167419909643, 6946.756863509753, 6950.409215216561, 6955.1653801544135, 7052.471064670273, 7078.398336141486, 7082.575045497287, 7084.397826184832, 7091.326323999212, 6653.367930046637, 6927.064846245894, 6931.757388491378, 6947.68735406918, 6977.686004129928], "unit": "score", "name": "prototype.html", "value": 5162.05954339432}, {"lowerIsBetter": false, "replicates": [724.214227563094, 736.4587028534023, 806.9112397636262, 809.562836068523, 819.1808191808192, 15933.521994340173, 16165.515034548953, 16166.83833161668, 16169.19154042296, 16190.919045404771, 14861.405543778235, 14877.92561037196, 14907.627309317273, 14958.62603434912, 14962.177080260608, 804.6499772598909, 819.2340161948567, 978.8776402949632, 980.181548407081, 1006.6275478073123, 794.4399198564997, 868.7350358140765, 1005.4620777883833, 1008.596561375452, 1009.581023875091, 1050.5325130317012, 1052.3317693264794, 1054.9050585447308, 1054.9103326217241, 1058.3544038136731, 847.9576021198947, 1028.655400440853, 1053.6048981631889, 1054.4727636181908, 1056.7146870344964, 783.2950344689825, 783.4124406694979, 784.1061190243128, 784.9489783164133, 786.0214033528237, 15742.449014284559, 15866.603334916605, 15871.0, 15877.841221587867, 15948.601284967852, 13299.933500332532, 13308.667283317898, 13351.265680387574, 13544.0, 13683.0, 10207.285490015702, 10434.06093451593, 10560.419176945265, 10842.403667798348, 10893.237473376867, 3586.1572530455323, 3608.1520842601967, 3665.065408320888, 3665.9450108248398, 3766.886993390203, 81840.59079704623, 82594.9999999994, 85253.14746852515, 87795.12204877933, 88355.0, 9834.606615735434, 9927.851082233772, 9928.957459466796, 9976.351537150062, 10182.847257290998, 22243.332700019026, 22533.549329013327, 23601.527969440514, 23742.762572374402, 23809.642855357182, 7845.450818442654, 7888.64501097452, 7923.445358824827, 7947.245011723992, 7970.760877173694, 4297.978510107492, 4342.652587792969, 4381.737095774264, 4436.157130145262, 4640.118377508263, 3729.9627003730157, 3731.7466220404117, 3761.435784632327, 3791.33651610967, 3801.296760099335, 577.4052725692543, 669.394198250584, 683.6205905722372, 698.4307789151926, 698.9580625162506, 565.3470241870564, 597.9820605381846, 598.4583951523878, 602.5330368964088, 605.9939400605938, 8064.677412903536, 8324.417290789586, 8432.03031651368, 8442.113578074337, 8642.740717778477, 519.5090639345782, 583.3612194646855, 617.3240301869446, 625.2902955145851, 626.5582764151262, 3942.9605703943166, 3958.050067983663, 3994.7603143811466, 4043.6765058795227, 4048.719692944778, 96151.0, 98749.50625246827, 99204.0, 100180.99819001717, 100236.49881750545, 81568.0, 82885.3422931538, 83774.0, 84261.89345266417, 85220.0, 55493.99999999919, 71483.64258178676, 73525.89711154337, 73772.63113684398, 74415.0, 7817.257360550739, 7947.602619869099, 8076.71731489395, 8100.756977290691, 8248.958755206186, 50867.20230387216, 51190.23214651709, 51873.48126518686, 51917.740411299215, 52484.47515524796, 64243.0, 64407.677961611764, 66242.33757662361, 72604.0, 75028.24971750213, 10161.745956351151, 10348.379097254188, 10397.220208484243, 10482.475876206006, 10545.472726363805, 11031.83452248233, 11250.381229032482, 11252.212345135762, 11306.152038596974, 11432.542698291974, 10610.098141657736, 10991.450427478434, 11052.115830733683, 11059.72350691239, 11212.49543770516, 10353.06822385989, 10531.631392901212, 10594.046535811814, 10755.0, 11521.596744113916, 10086.646967356108, 10119.848202277119, 10135.138513226459, 10286.2799604027, 11030.613928512463, 9164.541772911462, 9235.538223088954, 9363.531823408939, 9557.330986830855, 9631.229501639993, 7548.811279718051, 9146.58840352199, 9180.0, 9194.770130746518, 9311.534423278674], "unit": "score", "name": "yui.html", "value": 7101.6263578078815}], "name": "dromaeo_css", "value": 7761.560196873845}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 110.0, 112.0, 113.0, 120.0, 111.0, 115.0, 162.0], "unit": "score", "name": "ai-astar", "value": 117.5}, {"lowerIsBetter": true, "replicates": [153.0, 138.0, 186.0, 150.0, 118.0, 137.0, 117.0, 148.0, 147.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [182.0, 183.0, 184.0, 188.0, 186.0, 187.0, 182.0, 181.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [84.0, 74.0, 73.0, 117.0, 50.0, 48.0, 59.0, 73.0, 145.0, 82.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [91.0, 88.0, 129.0, 80.0, 77.0, 78.0, 120.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 87.0, 90.0, 88.0, 89.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 128.0, 85.0, 84.0, 84.0, 88.0, 96.0, 133.0, 133.0], "unit": "score", "name": "imaging-desaturate", "value": 101.1}, {"lowerIsBetter": true, "replicates": [52.0, 57.0, 58.0, 57.0, 59.0, 57.0, 58.0, 57.0, 52.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 67.0, 71.0, 70.0, 67.0, 64.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [79.0, 95.0, 67.0, 81.0, 68.0, 90.0, 68.0, 77.0, 97.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [117.0, 133.0, 125.0, 130.0, 111.0, 118.0, 117.0, 116.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [136.0, 123.0, 133.0, 134.0, 134.0, 126.0, 134.0, 136.0, 131.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.0}, {"lowerIsBetter": true, "replicates": [62.0, 60.0, 59.0, 65.0, 63.0, 68.0, 66.0, 81.0, 96.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1426.5000000000005}]} 02:09:22 INFO - Return code: 0 02:09:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:09:22 INFO - # TBPL SUCCESS # 02:09:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:23 INFO - 2016-04-29 02:09:23.003 screenresolution[1675:9869] starting screenresolution argv=screenresolution get 02:09:23 INFO - 2016-04-29 02:09:23.006 screenresolution[1675:9869] Display 0: 1600x1200x32@60 02:09:23 INFO - 2016-04-29 02:09:23.012 screenresolution[1676:9872] starting screenresolution argv=screenresolution list 02:09:23 INFO - Available Modes on Display 0 02:09:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:23 INFO - Intel Iris: 02:09:23 INFO - Chipset Model: Intel Iris 02:09:23 INFO - Type: GPU 02:09:23 INFO - Bus: Built-In 02:09:23 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:23 INFO - Vendor: Intel (0x8086) 02:09:23 INFO - Device ID: 0x0a2e 02:09:23 INFO - Revision ID: 0x0009 02:09:23 INFO - Displays: 02:09:23 INFO - Display: 02:09:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:23 INFO - Display Serial Number: 1600x1200 60 02:09:23 INFO - Main Display: Yes 02:09:23 INFO - Mirror: Off 02:09:23 INFO - Online: Yes 02:09:23 INFO - Rotation: Supported 02:09:23 INFO - Return code: 0 02:09:23 INFO - Running post-action listener: _resource_record_post_action 02:09:23 INFO - Running post-run listener: _resource_record_post_run 02:09:24 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 37758464; Write bytes: 507064832; Read time: 387; Write time: 1662 02:09:24 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 202748416; Write bytes: 196149248; Read time: 18911; Write time: 353 02:09:24 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 35976704; Write bytes: 298375680; Read time: 370; Write time: 1263 02:09:24 INFO - Running post-run listener: _upload_blobber_files 02:09:24 INFO - Blob upload gear active. 02:09:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:09:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:09:24 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:09:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:25 INFO - (blobuploader) - INFO - Done attempting. 02:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:26 INFO - (blobuploader) - INFO - Done attempting. 02:09:26 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:26 INFO - Return code: 0 02:09:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:09:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/973bd4f8a9dcfc31ed35135e70d6ffc0c01d9fe525551f20eb03dc030a85d724494b9eef0bf7c8da3a677103e30aefa999454cb6514d475515abff4b5402ce7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efc9df5edec287e1597fbda702aba9346456d6a19d808e8745d8fdeea2225a5f6312c1c38e5882c537025145593e5292a3c9ef9dfbee0cdf71fc30d5e664e17d"} 02:09:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:09:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:09:26 INFO - Contents: 02:09:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/973bd4f8a9dcfc31ed35135e70d6ffc0c01d9fe525551f20eb03dc030a85d724494b9eef0bf7c8da3a677103e30aefa999454cb6514d475515abff4b5402ce7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efc9df5edec287e1597fbda702aba9346456d6a19d808e8745d8fdeea2225a5f6312c1c38e5882c537025145593e5292a3c9ef9dfbee0cdf71fc30d5e664e17d"} 02:09:26 INFO - Running post-run listener: copy_logs_to_upload_dir 02:09:26 INFO - Copying logs to upload dir... 02:09:26 INFO - mkdir: /builds/slave/test/build/upload/logs 02:09:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.688597 ========= master_lag: 4.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-29 02:09:31.213332) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 02:09:31.217929) ========= 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.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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/Mozilla-Beta/sha512/973bd4f8a9dcfc31ed35135e70d6ffc0c01d9fe525551f20eb03dc030a85d724494b9eef0bf7c8da3a677103e30aefa999454cb6514d475515abff4b5402ce7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efc9df5edec287e1597fbda702aba9346456d6a19d808e8745d8fdeea2225a5f6312c1c38e5882c537025145593e5292a3c9ef9dfbee0cdf71fc30d5e664e17d"} build_url:https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/RiADP9n3T022t1DRdBjXyw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/973bd4f8a9dcfc31ed35135e70d6ffc0c01d9fe525551f20eb03dc030a85d724494b9eef0bf7c8da3a677103e30aefa999454cb6514d475515abff4b5402ce7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/efc9df5edec287e1597fbda702aba9346456d6a19d808e8745d8fdeea2225a5f6312c1c38e5882c537025145593e5292a3c9ef9dfbee0cdf71fc30d5e664e17d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 02:09:31.259870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-29 02:09:31.260204) ========= 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.PCEaVfC2HE/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.K0wihzZJDj/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.004522 ========= master_lag: 4.65 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-29 02:09:35.914542) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-29 02:09:35.914856) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2016-04-29 02:09:41.541081) ========= ========= Total master_lag: 11.09 =========