builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0170 starttime: 1461594394.2 results: success (0) buildid: 20160425053553 builduid: 1d95cc054ffb4593add8611da7987a93 revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:34.199665) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:34.200160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:34.200443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:34.846823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:34.847171) ========= 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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 07:26:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-04-25 07:26:35 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:35.030381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:35.030692) ========= 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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.026960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:35.085068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 07:26:35.085402) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 07:26:35,160 truncating revision to first 12 chars 2016-04-25 07:26:35,160 Setting DEBUG logging. 2016-04-25 07:26:35,160 attempt 1/10 2016-04-25 07:26:35,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f07f975526f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 07:26:36,117 unpacking tar archive at: fx-team-0f07f975526f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.202474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 07:26:36.308628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:36.309002) ========= script_repo_revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:36.309445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:36.309750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:26:36.325385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-25 07:26:36.325768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:26:36 INFO - MultiFileLogger online at 20160425 07:26:36 in /builds/slave/test 07:26:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:26:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:26:36 INFO - {'append_to_log': False, 07:26:36 INFO - 'base_work_dir': '/builds/slave/test', 07:26:36 INFO - 'blob_upload_branch': 'Fx-Team', 07:26:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:26:36 INFO - 'branch': 'Fx-Team', 07:26:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:26:36 INFO - 'config_files': ('talos/mac_config.py',), 07:26:36 INFO - 'default_actions': ('clobber', 07:26:36 INFO - 'read-buildbot-config', 07:26:36 INFO - 'download-and-extract', 07:26:36 INFO - 'populate-webroot', 07:26:36 INFO - 'create-virtualenv', 07:26:36 INFO - 'install', 07:26:36 INFO - 'run-tests'), 07:26:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:26:36 INFO - 'download_minidump_stackwalk': True, 07:26:36 INFO - 'download_symbols': 'ondemand', 07:26:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:26:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:26:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:26:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:26:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:26:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:26:36 INFO - 'installer_path': 'installer.exe', 07:26:36 INFO - 'log_level': 'info', 07:26:36 INFO - 'log_name': 'talos', 07:26:36 INFO - 'log_to_console': True, 07:26:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:26:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:26:36 INFO - 'opt_config_files': (), 07:26:36 INFO - 'pip_index': False, 07:26:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:26:36 INFO - 'cmd': ('bash', 07:26:36 INFO - '-c', 07:26:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:26:36 INFO - 'enabled': True, 07:26:36 INFO - 'halt_on_failure': False, 07:26:36 INFO - 'name': 'check_screen_resolution'},), 07:26:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:26:36 INFO - 'cmd': ('bash', 07:26:36 INFO - '-c', 07:26:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:26:36 INFO - 'enabled': True, 07:26:36 INFO - 'halt_on_failure': False, 07:26:36 INFO - 'name': 'check_screen_resolution'},), 07:26:36 INFO - 'run_cmd_checks_enabled': True, 07:26:36 INFO - 'sps_profile': False, 07:26:36 INFO - 'sps_profile_interval': 0, 07:26:36 INFO - 'suite': 'dromaeojs', 07:26:36 INFO - 'system_bits': '32', 07:26:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:26:36 INFO - 'title': 't-yosemite-r7-0170', 07:26:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:26:36 INFO - 'use_talos_json': True, 07:26:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:26:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:26:36 INFO - 'work_dir': 'build'} 07:26:36 INFO - ##### 07:26:36 INFO - ##### Running clobber step. 07:26:36 INFO - ##### 07:26:36 INFO - Running pre-action listener: _resource_record_pre_action 07:26:36 INFO - Running main action method: clobber 07:26:36 INFO - rmtree: /builds/slave/test/build 07:26:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:26:38 INFO - Running post-action listener: _resource_record_post_action 07:26:38 INFO - ##### 07:26:38 INFO - ##### Running read-buildbot-config step. 07:26:38 INFO - ##### 07:26:38 INFO - Running pre-action listener: _resource_record_pre_action 07:26:38 INFO - Running main action method: read_buildbot_config 07:26:38 INFO - Using buildbot properties: 07:26:38 INFO - { 07:26:38 INFO - "project": "", 07:26:38 INFO - "product": "firefox", 07:26:38 INFO - "script_repo_revision": "production", 07:26:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:26:38 INFO - "repository": "", 07:26:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:26:38 INFO - "buildid": "20160425053553", 07:26:38 INFO - "pgo_build": "False", 07:26:38 INFO - "basedir": "/builds/slave/test", 07:26:38 INFO - "buildnumber": 668, 07:26:38 INFO - "slavename": "t-yosemite-r7-0170", 07:26:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:26:38 INFO - "platform": "yosemite_r7", 07:26:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:26:38 INFO - "branch": "fx-team", 07:26:38 INFO - "repo_path": "integration/fx-team", 07:26:38 INFO - "revision": "0f07f975526f3abda2f997bbb2feb0a25f771227", 07:26:38 INFO - "stage_platform": "macosx64", 07:26:38 INFO - "builduid": "1d95cc054ffb4593add8611da7987a93", 07:26:38 INFO - "slavebuilddir": "test" 07:26:38 INFO - } 07:26:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:26:38 INFO - Running post-action listener: _resource_record_post_action 07:26:38 INFO - ##### 07:26:38 INFO - ##### Running download-and-extract step. 07:26:38 INFO - ##### 07:26:38 INFO - Running pre-action listener: _resource_record_pre_action 07:26:38 INFO - Running main action method: download_and_extract 07:26:38 INFO - mkdir: /builds/slave/test/build/tests 07:26: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')]} 07:26:38 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:26:39 INFO - Downloaded 1199 bytes. 07:26:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:26:39 INFO - Using the following test package requirements: 07:26:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:26:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:26:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:26:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'jsshell-mac.zip'], 07:26:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:26:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:26:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:26:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:26:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:26:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:26:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:26:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:39 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:26:41 INFO - Downloaded 18111316 bytes. 07:26:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:26:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:26:44 INFO - Return code: 0 07:26:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:44 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:26:45 INFO - Downloaded 18111316 bytes. 07:26:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:26:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:26:48 INFO - Return code: 0 07:26:48 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')]} 07:26:48 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:26:49 INFO - Downloaded 10840145 bytes. 07:26:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:26:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:26:50 INFO - Return code: 0 07:26:50 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')]} 07:26:50 INFO - https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:26:53 INFO - Downloaded 110147975 bytes. 07:26:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:26:53 INFO - mkdir: /builds/slave/test/properties 07:26:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:26:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:26:53 INFO - Contents: 07:26:53 INFO - build_url:https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:26:54 INFO - Running post-action listener: _resource_record_post_action 07:26:54 INFO - Running post-action listener: set_extra_try_arguments 07:26:54 INFO - ##### 07:26:54 INFO - ##### Running populate-webroot step. 07:26:54 INFO - ##### 07:26:54 INFO - Running pre-action listener: _resource_record_pre_action 07:26:54 INFO - Running main action method: populate_webroot 07:26:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:26:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:26:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:26:54 INFO - '--tppagecycles', 07:26:54 INFO - '7'], 07:26:54 INFO - 'tests': ['tsvgm']}}, 07:26:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:26:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:26:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:26:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:26:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['damp', 'tps']}, 07:26:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'tests': ['damp', 'tps']}, 07:26:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['dromaeo_dom']}, 07:26:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:26:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'other-e10s': {'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['a11yr', 07:26:54 INFO - 'ts_paint', 07:26:54 INFO - 'tpaint', 07:26:54 INFO - 'sessionrestore', 07:26:54 INFO - 'sessionrestore_no_auto_restore', 07:26:54 INFO - 'tabpaint']}, 07:26:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['tsvgx', 07:26:54 INFO - 'tsvgr_opacity', 07:26:54 INFO - 'tart', 07:26:54 INFO - 'tscrollx', 07:26:54 INFO - 'cart']}, 07:26:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:26:54 INFO - 'tsvgr_opacity', 07:26:54 INFO - 'tart', 07:26:54 INFO - 'tscrollx', 07:26:54 INFO - 'cart']}, 07:26:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'talos_options': ['--disable-e10s'], 07:26:54 INFO - 'tests': ['tp5o']}, 07:26:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'tests': ['tp5o']}, 07:26:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'talos_options': ['--disable-e10s', 07:26:54 INFO - '--xperf_path', 07:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:54 INFO - 'tests': ['tp5n']}, 07:26:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:54 INFO - 'talos_options': ['--xperf_path', 07:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:54 INFO - 'tests': ['tp5n']}}, 07:26:54 INFO - 'talos.zip': {'path': '', 07:26:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:26:54 INFO - Running post-action listener: _resource_record_post_action 07:26:54 INFO - ##### 07:26:54 INFO - ##### Running create-virtualenv step. 07:26:54 INFO - ##### 07:26:54 INFO - Running pre-action listener: _resource_record_pre_action 07:26:54 INFO - Running main action method: create_virtualenv 07:26:54 INFO - Creating virtualenv /builds/slave/test/build/venv 07:26: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 07:26:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:26:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:26:54 INFO - Using real prefix '/tools/python27' 07:26:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:26:55 INFO - Installing distribute.............................................................................................................................................................................................done. 07:26:58 INFO - Installing pip.................done. 07:26:58 INFO - Return code: 0 07:26:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:26: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')]} 07:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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')]} 07:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:26: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 07:26: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 07:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:26:58 INFO - 'HOME': '/Users/cltbld', 07:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:26:58 INFO - 'LOGNAME': 'cltbld', 07:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:58 INFO - 'MOZ_NO_REMOTE': '1', 07:26:58 INFO - 'NO_EM_RESTART': '1', 07:26:58 INFO - 'PAGER': '/bin/cat', 07:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:58 INFO - 'PWD': '/builds/slave/test', 07:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:26:58 INFO - 'SHELL': '/bin/bash', 07:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:26:58 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:26:58 INFO - 'USER': 'cltbld', 07:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:58 INFO - 'XPC_FLAGS': '0x0', 07:26:58 INFO - 'XPC_SERVICE_NAME': '0', 07:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26: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 07:26:58 INFO - Cleaning up... 07:26:58 INFO - Return code: 0 07:26:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:26: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')]} 07:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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')]} 07:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:26: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 07:26: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 07:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:26:58 INFO - 'HOME': '/Users/cltbld', 07:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:26:58 INFO - 'LOGNAME': 'cltbld', 07:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:58 INFO - 'MOZ_NO_REMOTE': '1', 07:26:58 INFO - 'NO_EM_RESTART': '1', 07:26:58 INFO - 'PAGER': '/bin/cat', 07:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:58 INFO - 'PWD': '/builds/slave/test', 07:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:26:58 INFO - 'SHELL': '/bin/bash', 07:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:26:58 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:26:58 INFO - 'USER': 'cltbld', 07:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:58 INFO - 'XPC_FLAGS': '0x0', 07:26:58 INFO - 'XPC_SERVICE_NAME': '0', 07:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:59 INFO - Downloading/unpacking psutil>=0.7.1 07:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:02 INFO - Installing collected packages: psutil 07:27:02 INFO - Running setup.py install for psutil 07:27:02 INFO - building 'psutil._psutil_osx' extension 07:27: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:27: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 07:27: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 07:27: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 07:27:03 INFO - building 'psutil._psutil_posix' extension 07:27:03 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 07:27:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:27:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:27:03 INFO - ^ 07:27:03 INFO - 1 warning generated. 07:27:03 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 07:27:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:03 INFO - Successfully installed psutil 07:27:03 INFO - Cleaning up... 07:27:03 INFO - Return code: 0 07:27:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:03 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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27:03 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 07:27:03 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 07:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:03 INFO - 'HOME': '/Users/cltbld', 07:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:03 INFO - 'LOGNAME': 'cltbld', 07:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:03 INFO - 'MOZ_NO_REMOTE': '1', 07:27:03 INFO - 'NO_EM_RESTART': '1', 07:27:03 INFO - 'PAGER': '/bin/cat', 07:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:03 INFO - 'PWD': '/builds/slave/test', 07:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:03 INFO - 'SHELL': '/bin/bash', 07:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:03 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:03 INFO - 'USER': 'cltbld', 07:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:03 INFO - 'XPC_FLAGS': '0x0', 07:27:03 INFO - 'XPC_SERVICE_NAME': '0', 07:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:27:03 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 07:27:03 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 07:27:03 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 07:27:03 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 07:27:03 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 07:27:03 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 07:27:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:27:06 INFO - Installing collected packages: mozsystemmonitor 07:27:06 INFO - Running setup.py install for mozsystemmonitor 07:27:06 INFO - Successfully installed mozsystemmonitor 07:27:06 INFO - Cleaning up... 07:27:06 INFO - Return code: 0 07:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27: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 07:27: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 07:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:06 INFO - 'HOME': '/Users/cltbld', 07:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:06 INFO - 'LOGNAME': 'cltbld', 07:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:06 INFO - 'MOZ_NO_REMOTE': '1', 07:27:06 INFO - 'NO_EM_RESTART': '1', 07:27:06 INFO - 'PAGER': '/bin/cat', 07:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:06 INFO - 'PWD': '/builds/slave/test', 07:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:06 INFO - 'SHELL': '/bin/bash', 07:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:06 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:06 INFO - 'USER': 'cltbld', 07:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:06 INFO - 'XPC_FLAGS': '0x0', 07:27:06 INFO - 'XPC_SERVICE_NAME': '0', 07:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:10 INFO - Downloading docopt-0.6.1.tar.gz 07:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:10 INFO - Running setup.py install for blobuploader 07:27:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:10 INFO - Running setup.py install for requests 07:27:10 INFO - Running setup.py install for docopt 07:27:11 INFO - Successfully installed blobuploader requests docopt 07:27:11 INFO - Cleaning up... 07:27:11 INFO - Return code: 0 07:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27: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 07:27: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 07:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:11 INFO - 'HOME': '/Users/cltbld', 07:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:11 INFO - 'LOGNAME': 'cltbld', 07:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:11 INFO - 'MOZ_NO_REMOTE': '1', 07:27:11 INFO - 'NO_EM_RESTART': '1', 07:27:11 INFO - 'PAGER': '/bin/cat', 07:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:11 INFO - 'PWD': '/builds/slave/test', 07:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:11 INFO - 'SHELL': '/bin/bash', 07:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:11 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:11 INFO - 'USER': 'cltbld', 07:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:11 INFO - 'XPC_FLAGS': '0x0', 07:27:11 INFO - 'XPC_SERVICE_NAME': '0', 07:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-3_WY2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-N7m1Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-wvWAgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-rllY8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-Qv9SJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:11 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-2v4WKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-6cO4r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-JPtgaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-zRQ0_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-FXLjff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-b0x9HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-jHAvy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-oj7fBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-QXtTmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-cFHVf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:12 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-dLp58r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:13 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-osY4Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:13 INFO - Running setup.py install for manifestparser 07:27:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:13 INFO - Running setup.py install for mozcrash 07:27:13 INFO - Running setup.py install for mozdebug 07:27:13 INFO - Running setup.py install for mozdevice 07:27:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:13 INFO - Running setup.py install for mozfile 07:27:13 INFO - Running setup.py install for mozhttpd 07:27:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Running setup.py install for mozinfo 07:27:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Running setup.py install for mozInstall 07:27:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Running setup.py install for mozleak 07:27:14 INFO - Running setup.py install for mozlog 07:27:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Running setup.py install for moznetwork 07:27:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:14 INFO - Running setup.py install for mozprocess 07:27:14 INFO - Running setup.py install for mozprofile 07:27:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:15 INFO - Running setup.py install for mozrunner 07:27:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:15 INFO - Running setup.py install for mozscreenshot 07:27:15 INFO - Running setup.py install for moztest 07:27:15 INFO - Running setup.py install for mozversion 07:27:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:15 INFO - Cleaning up... 07:27:15 INFO - Return code: 0 07:27:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27: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 07:27: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 07:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:15 INFO - 'HOME': '/Users/cltbld', 07:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:15 INFO - 'LOGNAME': 'cltbld', 07:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:15 INFO - 'MOZ_NO_REMOTE': '1', 07:27:15 INFO - 'NO_EM_RESTART': '1', 07:27:15 INFO - 'PAGER': '/bin/cat', 07:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:15 INFO - 'PWD': '/builds/slave/test', 07:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:15 INFO - 'SHELL': '/bin/bash', 07:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:15 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:15 INFO - 'USER': 'cltbld', 07:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:15 INFO - 'XPC_FLAGS': '0x0', 07:27:15 INFO - 'XPC_SERVICE_NAME': '0', 07:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-k1_jJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-mSGG5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-a8GDFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-8fq9Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-hjUpkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-GEzKqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-5_MGVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27: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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-3SkAr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:16 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)) 07:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:16 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-8nfG6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-2FrtcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-W1CLcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-BQnvuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-kPYA6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-bYBzNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-WqzIjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-IASNPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27: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)) 07:27:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:17 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-uWgPp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:20 INFO - Downloading blessings-1.6.tar.gz 07:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:20 INFO - Installing collected packages: blessings 07:27:20 INFO - Running setup.py install for blessings 07:27:20 INFO - Successfully installed blessings 07:27:20 INFO - Cleaning up... 07:27:20 INFO - Return code: 0 07:27:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:20 INFO - Reading from file tmpfile_stdout 07:27:20 INFO - Current package versions: 07:27:20 INFO - blessings == 1.6 07:27:20 INFO - blobuploader == 1.2.4 07:27:20 INFO - docopt == 0.6.1 07:27:20 INFO - manifestparser == 1.1 07:27:20 INFO - mozInstall == 1.12 07:27:20 INFO - mozcrash == 0.17 07:27:20 INFO - mozdebug == 0.1 07:27:20 INFO - mozdevice == 0.48 07:27:20 INFO - mozfile == 1.2 07:27:20 INFO - mozhttpd == 0.7 07:27:20 INFO - mozinfo == 0.9 07:27:20 INFO - mozleak == 0.1 07:27:20 INFO - mozlog == 3.1 07:27:20 INFO - moznetwork == 0.27 07:27:20 INFO - mozprocess == 0.22 07:27:20 INFO - mozprofile == 0.28 07:27:20 INFO - mozrunner == 6.11 07:27:20 INFO - mozscreenshot == 0.1 07:27:20 INFO - mozsystemmonitor == 0.0 07:27:20 INFO - moztest == 0.7 07:27:20 INFO - mozversion == 1.4 07:27:20 INFO - psutil == 3.1.1 07:27:20 INFO - requests == 1.2.3 07:27:20 INFO - wsgiref == 0.1.2 07:27:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:20 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')]} 07:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27: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 07:27: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 07:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:21 INFO - 'HOME': '/Users/cltbld', 07:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:21 INFO - 'LOGNAME': 'cltbld', 07:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:21 INFO - 'MOZ_NO_REMOTE': '1', 07:27:21 INFO - 'NO_EM_RESTART': '1', 07:27:21 INFO - 'PAGER': '/bin/cat', 07:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:21 INFO - 'PWD': '/builds/slave/test', 07:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:21 INFO - 'SHELL': '/bin/bash', 07:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:21 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:21 INFO - 'USER': 'cltbld', 07:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:21 INFO - 'XPC_FLAGS': '0x0', 07:27:21 INFO - 'XPC_SERVICE_NAME': '0', 07:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27: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)) 07:27:21 INFO - Cleaning up... 07:27:21 INFO - Return code: 0 07:27:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27: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 07:27: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 07:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:21 INFO - 'HOME': '/Users/cltbld', 07:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:21 INFO - 'LOGNAME': 'cltbld', 07:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:21 INFO - 'MOZ_NO_REMOTE': '1', 07:27:21 INFO - 'NO_EM_RESTART': '1', 07:27:21 INFO - 'PAGER': '/bin/cat', 07:27:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:21 INFO - 'PWD': '/builds/slave/test', 07:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:21 INFO - 'SHELL': '/bin/bash', 07:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:21 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:21 INFO - 'USER': 'cltbld', 07:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:21 INFO - 'XPC_FLAGS': '0x0', 07:27:21 INFO - 'XPC_SERVICE_NAME': '0', 07:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:22 INFO - Downloading/unpacking jsonschema 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:24 INFO - Downloading/unpacking functools32 (from jsonschema) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:25 INFO - warning: no files found matching '*.txt' 07:27:25 INFO - no previously-included directories found matching 'build' 07:27:25 INFO - no previously-included directories found matching 'dist' 07:27:25 INFO - no previously-included directories found matching '.git*' 07:27:25 INFO - Installing collected packages: jsonschema, functools32 07:27:25 INFO - Running setup.py install for functools32 07:27:25 INFO - warning: no files found matching '*.txt' 07:27:25 INFO - no previously-included directories found matching 'build' 07:27:25 INFO - no previously-included directories found matching 'dist' 07:27:25 INFO - no previously-included directories found matching '.git*' 07:27:25 INFO - Successfully installed jsonschema functools32 07:27:25 INFO - Cleaning up... 07:27:25 INFO - Return code: 0 07:27:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d02aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d03a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3e8571160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, '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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 07:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:25 INFO - 'HOME': '/Users/cltbld', 07:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:25 INFO - 'LOGNAME': 'cltbld', 07:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:25 INFO - 'MOZ_NO_REMOTE': '1', 07:27:25 INFO - 'NO_EM_RESTART': '1', 07:27:25 INFO - 'PAGER': '/bin/cat', 07:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:25 INFO - 'PWD': '/builds/slave/test', 07:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:25 INFO - 'SHELL': '/bin/bash', 07:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:27:25 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:25 INFO - 'USER': 'cltbld', 07:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:25 INFO - 'XPC_FLAGS': '0x0', 07:27:25 INFO - 'XPC_SERVICE_NAME': '0', 07:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:25 INFO - Downloading/unpacking flake8 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:27:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:27:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 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 07:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:29 INFO - no previously-included directories found matching 'docs/_build' 07:27:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:27:29 INFO - Running setup.py install for pep8 07:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:29 INFO - no previously-included directories found matching 'docs/_build' 07:27:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:27:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:27:29 INFO - Cleaning up... 07:27:29 INFO - Return code: 0 07:27:29 INFO - Running post-action listener: _resource_record_post_action 07:27:29 INFO - Running post-action listener: _start_resource_monitoring 07:27:29 INFO - Starting resource monitoring. 07:27:29 INFO - ##### 07:27:29 INFO - ##### Running install step. 07:27:29 INFO - ##### 07:27:29 INFO - Running pre-action listener: _resource_record_pre_action 07:27:29 INFO - Running main action method: install 07:27:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:30 INFO - Reading from file tmpfile_stdout 07:27:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:27:30 INFO - Reading from file tmpfile_stdout 07:27:30 INFO - Output received: 07:27:30 INFO - Usage: mozinstall [options] installer 07:27:30 INFO - Options: 07:27:30 INFO - -h, --help show this help message and exit 07:27:30 INFO - -d DEST, --destination=DEST 07:27:30 INFO - Directory to install application into. [default: 07:27:30 INFO - "/builds/slave/test"] 07:27:30 INFO - --app=APP Application being installed. [default: firefox] 07:27:30 INFO - mkdir: /builds/slave/test/build/application 07:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:28:03 INFO - Reading from file tmpfile_stdout 07:28:03 INFO - Output received: 07:28:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:28:03 INFO - Running post-action listener: _resource_record_post_action 07:28:03 INFO - ##### 07:28:03 INFO - ##### Running run-tests step. 07:28:03 INFO - ##### 07:28:03 INFO - Running pre-action listener: _resource_record_pre_action 07:28:03 INFO - Running main action method: run_tests 07:28:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:28:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:28:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:28:03 INFO - 2016-04-25 07:28:03.626 screenresolution[1644:7549] starting screenresolution argv=screenresolution get 07:28:03 INFO - 2016-04-25 07:28:03.628 screenresolution[1644:7549] Display 0: 1600x1200x32@60 07:28:03 INFO - 2016-04-25 07:28:03.633 screenresolution[1645:7551] starting screenresolution argv=screenresolution list 07:28:03 INFO - Available Modes on Display 0 07:28:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:28:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:28:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:28:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:28:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:28:03 INFO - Intel Iris: 07:28:03 INFO - Chipset Model: Intel Iris 07:28:03 INFO - Type: GPU 07:28:03 INFO - Bus: Built-In 07:28:03 INFO - VRAM (Dynamic, Max): 1536 MB 07:28:03 INFO - Vendor: Intel (0x8086) 07:28:03 INFO - Device ID: 0x0a2e 07:28:03 INFO - Revision ID: 0x0009 07:28:03 INFO - Displays: 07:28:03 INFO - Display: 07:28:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:28:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:28:03 INFO - Display Serial Number: 1600x1200 60 07:28:03 INFO - Main Display: Yes 07:28:03 INFO - Mirror: Off 07:28:03 INFO - Online: Yes 07:28:03 INFO - Rotation: Supported 07:28:03 INFO - Return code: 0 07:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:03 INFO - Python 2.7.3 07:28:03 INFO - Return code: 0 07:28:03 INFO - grabbing minidump binary from tooltool 07:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:03 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 0x10cec9e00>, '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 0x10ccf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:03 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 07:28:03 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 07:28:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:03 INFO - Return code: 0 07:28:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:28:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:28:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:28:05 INFO - Return code: 0 07:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 07:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --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 07:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FsRLwSQ1Uq/Render', 07:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:05 INFO - 'HOME': '/Users/cltbld', 07:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:05 INFO - 'LOGNAME': 'cltbld', 07:28:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:05 INFO - 'MOZ_NO_REMOTE': '1', 07:28:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:05 INFO - 'NO_EM_RESTART': '1', 07:28:05 INFO - 'PAGER': '/bin/cat', 07:28:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:05 INFO - 'PWD': '/builds/slave/test', 07:28:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:05 INFO - 'SHELL': '/bin/bash', 07:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4n4n0bBgYi/Listeners', 07:28:05 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 07:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:05 INFO - 'USER': 'cltbld', 07:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:05 INFO - 'XPC_FLAGS': '0x0', 07:28:05 INFO - 'XPC_SERVICE_NAME': '0', 07:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 07:28:05 INFO - mozversion application_buildid: 20160425053553 07:28:05 INFO - mozversion application_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 07:28:05 INFO - mozversion application_display_name: Nightly 07:28:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:05 INFO - mozversion application_name: Firefox 07:28:05 INFO - mozversion application_remotingname: firefox 07:28:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:28:05 INFO - mozversion application_vendor: Mozilla 07:28:05 INFO - mozversion application_version: 48.0a1 07:28:05 INFO - mozversion platform_buildid: 20160425053553 07:28:05 INFO - mozversion platform_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 07:28:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:28:05 INFO - mozversion platform_version: 48.0a1 07:28:05 INFO - using testdate: 1461594485 07:28:05 INFO - actual date: 1461594485 07:28:05 INFO - starting webserver on 'localhost:49275' 07:28:05 INFO - SUITE-START | Running 2 tests 07:28:05 INFO - TEST-START | dromaeo_css 07:28:05 INFO - operating with platform_type : mac_ 07:28:05 INFO - Initialising browser for dromaeo_css test... 07:28:05 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpCj4aQH/profile http://localhost:49275/getInfo.html) 07:28:07 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 07:28:07 INFO - PROCESS | 1663 | colorDepth:24 07:28:07 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 07:28:07 INFO - PROCESS | 1663 | __metrics 07:28:07 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:28:07 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:28:08 INFO - TEST-INFO | 1663: exit 0 07:28:08 INFO - Browser initialized. 07:28:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:08 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpCj4aQH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:20 INFO - PROCESS | 1665 | RSS: Main: 239624192 07:28:20 INFO - PROCESS | 1665 | 07:29:11 INFO - PROCESS | 1665 | 1461594551888 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] 07:31:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 07:31:23 INFO - PROCESS | 1665 | RSS: Main: 342495232 07:31:23 INFO - PROCESS | 1665 | 07:34:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 07:34:27 INFO - PROCESS | 1665 | RSS: Main: 376938496 07:34:27 INFO - PROCESS | 1665 | 07:37:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 07:37:30 INFO - PROCESS | 1665 | RSS: Main: 378613760 07:37:30 INFO - PROCESS | 1665 | 07:40:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 07:40:32 INFO - PROCESS | 1665 | RSS: Main: 375607296 07:40:32 INFO - PROCESS | 1665 | 07:43:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 07:43:36 INFO - PROCESS | 1665 | RSS: Main: 348078080 07:43:36 INFO - PROCESS | 1665 | 07:46:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 07:46:40 INFO - PROCESS | 1665 | RSS: Main: 380715008 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | __start_tp_report 07:46:40 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:46:40 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:46:40 INFO - PROCESS | 1665 | |i|pagename|runs| 07:46:40 INFO - PROCESS | 1665 | |0;dojo.html;3194.8242846643434;3444.965550344496;3460.134966258435;3481.460373642083;3518.41946078897;5651.8587035324135;5680.375158732536;5710.486056254937;5718.828435146942;5724.141378793183;5715.971420142904;5743.741531631076;5836.474717275444;5866.941330586693;5878.000739874221;5103.209002604603;5146.74266286686;5166.896662066756;5175.741212939357;5239.816606418776;5264.789408423659;5286.947130528703;5293.814716484924;5315.813946511873;5329.973350133263;5067.594592432615;5112.821051263225;5158.277841102249;5179.922301165486;5239.423663397042;5143.742812859342;5173.663711858717;5176.948230517684;5186.481351864821;5197.974010129963;4681.180793361183;4868.805247790084;5142.794288228466;5161.7161056141895;5210.583153347723;5517.200005999148;5622.1004639257935;5625;5637.323521177444;5638.097904335327;6116.960116780158;6216.627002379872;6240.719167637467;6251.968740156316;6252.3122456529745;6240;6301.873962520724;6303.180586523768;6323.14637523933;6341.365863413668;4695.436547614308;5770.7403166857175;5773.134029895466;5776.740046697909;5789.392113828029;6255.56211065221;6314.273858506331;6357.586756860789;6385.329540398191;6396;5221.686698798008;6110.663913484712;6117.694115294217;6139.201903752483;6147.44672979434;6226.066090086523;6237.345078766664;6238.594491358047;6278.497720182374;6279.434850863444;6045.758169673251;6102.489251635809;6105;6118.162361256266;6162.22972128484;6215.192025036717;6222.066689996446;6233.1273621693;6236.158118653923;6243.344448832807;4884.291777692215;4887.9735255596015;4888.560029597282;4896;4932;4318.438602981592;4367.650587952956;4425.579569940851;4468.910621787546;4504.887377815516;5619.044762390404;5642.858928526737;5649.915251271234;5664.858378540487;5678.119891416837;6261.937380626136;6266.467350275278;6283.3088360280335;6309.400606942333;6320.968395157995;4822.662413631012;5574.526165275997;5639.774409023593;5640.182173584889;5737.08206686928;5375.838724838261;5382.434844341366;5386.434424385461;5387.595930305243;5394;6315.242170939517;6316.021016742412;6342.746290148435;6348.968255158695;6354.872902542016;6106.3089915548935;6198.907016394848;6333.461655759312;6340.207474065742;6350.333215012357;6275.717592708248;6339.746410143543;6363.204599425072;6374.521910856612;6377.489800816016;5941.524678025661;6145.84635384119;6147.323794382703;6159.784407545714;6181.84545386369;6102.337773232528;6165.660888651168;6171.9074213887725;6281.748730050929;6283.434490895841;5997.730102145327;6010.338862725184;6024.457798797954;6054.3340232575265;6069.9089513656445;6011.819645410645;6019.909701354396;6026.7589296429405;6026.909596356146;6036.456718895321;5711.971440142773;5850.180974663465;5876.647401155944;5882.088276317178;5966.671833049224;5941.049432090845;5977.252843394575;6025.337212906665;6035.18524999137;6119.877602448015;5923.763049478145;5924.6149000314845;5926.140709597171;5927.229460170151;5944.4352786485215 07:46:40 INFO - PROCESS | 1665 | |1;ext.html;501.45842490110664;504.28643469490675;594.7650677982194;602.8975074237379;632.2886752403546;28006.85996570017;38375.80812095939;39378.212435751266;39398.80300598493;39497.42010319584;43564.564354356444;44141.11717765643;44308.3353749694;44335;44551;8407.24334809867;9475.857862132074;9708.17480514157;9729.513524323791;9740.318177727562;8484.872726909101;11139.888601114008;11396.487158077865;11397.430128493583;11399.487023083939;9500.762480937963;11476.139289553317;11481.196316257865;11487.483063262172;11488.310701357945;8257.752267431986;11120.332780033143;11341.206115571913;11364.659060228123;11439.771204575904;11173.106151507942;11340.886591134065;11342.659720208407;11355.943220283845;11378.943105284503;38380.23239535194;38890.22219555621;38913.41629875554;38944.41583376252;39048.02379940496;3198.3603279344225;3230.095573239497;3239.514072889062;3247.3667634811222;3405.3700065487965;28793;29287.853560732274;29575.70424295751;29596;29650.110496685134;2679.517686816372;2737.5619900815773;2799.3561480859516;2817.0844475545528;2831.8159319644365;297923;352808;392746;394851;395610.0219498913;60866.08700869491;61674.074888876705;61684.38315616876;61791.45521362002;61848.690756545926;64569;65183;65255.34744652588;65271.69456610841;65426;15752.76370854438;16372.918135409247;16401.753973690404;16676.74984875228;16953.321867125425;11435.59975400857;11729.941350293195;12439.37803109841;12653.87346126527;13056.804147937788;17175.57061073483;17200.31198752061;17225.22486488111;17245.65508689819;17252.654946901243;5374.6506477078865;6426;6654.500912431587;6658.500612454085;6722.899156512656;956.9808603827885;984.2077127911956;986.8125056239435;1048.7325731938306;1052.074174726236;24276;28244.576331354634;28891.85554072216;29144;29480.410391792044;1108.2408550143177;1132.9546818127346;1137.2494153858413;1137.4881303413497;1141.0814294493014;15082.472113475975;15205.543833685007;15214.934954553075;15360.155191464577;15465.304061317267;583462;587986;588615;588898;589314;49918.750406248466;57939.13091303634;59804.40195598076;59916;60078.49803754941;1273.802560603108;1316.7432350691522;1347.636138242669;1477.918714470693;1540.9675517403143;29117.563236551046;29568;29764.55353169661;30286.54570181493;30480.390392192476;49750;49866;50090.74954625204;50184.74907625438;50289.49710502848;429453;433087;433655.66344337416;434273;434660;28159.776033594306;32282.83858580786;32309.838450807594;32324.191895202806;32382.67617323891;41774.72565807188;42235.577644223165;42330.94172645709;43013;43240.135197296506;35596.466053009746;35678.286434271686;36519;36525.45211821878;36708.81645591755;34577.65422345845;34834.303313934084;35741.642583573834;36897.63102369049;36929.02650040882;35127.47308790421;35674.643253567134;36869.44695829618;37115.700950466606;37230.44154337741;30242.697573023986;31297.374052518368;31318.843405782824;31369.05892823219;31463.21341966469;23285.53428931446;23410.853487408287;24037.51924961456;24092.75907240905;24124.396890077187 07:46:40 INFO - PROCESS | 1665 | |2;jquery.html;393.78735482839267;395.94654721612574;398.1459768795932;398.3228511530399;411.2535747618073;14841.703165936675;20363.49091272719;21148.788512114876;21181.788182118173;21189.470263243427;20346.389608311776;20377.388678339637;20529.076191571377;20894.164233430645;21209.151633934664;5770.249867517216;5985.910211346833;6040.96979515104;6049.032154855224;6053.152558641794;5095.464976177504;5577.358603760558;5928.55535834812;5990.101484777275;6663.866722665543;6421.518386121036;6694.163229596301;6700.899486507707;6702.631355275458;6716.563423377489;6567.877867158139;6570.737170513174;6575.3095924927675;6576.441002514816;6599.3070727573395;4246.426732391149;4877.146499362598;4956.207006878918;4961.925571116436;4969.378827646544;25813.870930645415;26007;26568.468630627278;26973.92104315825;27276.45447091067;2170.4180064308694;2299.8735069571167;2464.236086813076;2469.2221950085664;2573.29234460523;14293.409947926044;14694;14767;15178.241087945558;15326.463573774976;1707.9146042697816;1727.4558514068028;1735.0543953545223;1834.8073452287585;1859.2562974810048;114953;118450.99999999914;118542;120026.39986800097;121654;9113.36206465541;10889.83665245022;11384.886151138382;11487.25332853362;11590.536378544764;12823.551175708806;13534.18794872291;13623.18260904349;14540.636484087983;14544.927275363556;8696.78258043554;8811.603477843513;8920.375573709907;8929.285657147413;9038.909610903938;8920.107989201028;8924.910750892537;8927.553622318857;9043.68347107848;9076.455412675261;5742.598018138774;5914.290285165807;6790;6829.112215411965;6860.897086543706;1882.284731801934;1913.885166889991;1917.8657493975288;1918.56832212751;1946.7929883472339;909.5497728624241;958.7219706285099;977.2231076294363;1009.9091081802526;1033.6537260017978;20914.37256882296;21057.89471052635;21301.46746331323;21322.827244501703;21815.236466723905;969.4813274897896;993.6969224386631;999.5606326889256;1008.3798463944621;1017.6438246613626;11237.943810280896;11669.649910502698;11692.47383867711;11774;11983.340916249515;572348;580689;586590;599344;600474;119537.40231298962;120484.19273710901;122179.38910305391;123384.38307808404;125201.12198317032;1043.2853495355555;1057.894210578936;1109.5728144664201;1126.8760436351995;1127.9041281491002;18893.527661808566;19067.855928644327;19232.423027309203;19279.710804337665;19293.517662058563;45251.83237173366;49846.75076624594;50463;50467.49532504775;50875.491245087076;71345.64327178331;71550;71994.28005720086;72867.27132728604;73339;8007.079185893464;8119.066307374727;8150.959245203736;8394.706185283485;8396.580170991549;13117.409716562586;13161;13226.4048117833;13355.26546039977;13443.932780336036;11250.099992000456;11484.827727583926;11578.76842463163;11595.478203480694;11618.360990145624;11097.500612472297;11175.273607215506;11236.157288203582;11451.713707157387;11560.132990025613;10973.945130274298;11594.14493681007;11619.593314233962;11724.88275117272;11890;8151.5109093454585;8202.83594328122;8245.79385515343;8278.544680042414;8401.915980840113;11392.715182120513;11420.885791142315;11628;11695.532178712756;11792.05663546897 07:46:40 INFO - PROCESS | 1665 | |3;mootools.html;1428.6071330384143;1436.6839295355019;1612.298650087212;1839.9724004139941;2001.8498612604049;7862.292393684567;8667.78330541736;8884.422512536697;8885.200331970129;8888.155625215593;8532.488050716962;8745.781355466117;8753.3872628916;8759.824803503927;8766.868496972551;2427.8786060696984;2460.1758410932357;2461.396957745355;2463.3964678653756;2466.124525793344;2036.3178335257633;2392.629142482918;2451.0930955546473;2458.409981604411;2460.6309053642008;2428.162284012013;2449.534588428202;2462.212092130519;2463.261021693485;2467.2721547143638;2387.4747555537756;2393.724721657006;2408.121035821921;2412.7949124324455;2427.647991041289;2382.5711371953043;2418.3470462974897;2422.382292515415;2423.4547226873988;2424.15154695855;8604.268637165786;8746.60640271183;8776.780580485474;8824.426412283181;8851.734447966572;4572.611328037121;4679.391679081732;5315.973420132913;5528.502434780889;5549.334079910396;3487.2851065531504;3587.802670853102;3630.2557975614936;3644.8359823807727;3653.6163702811355;1021.7752094539189;1027.8817935937388;1029.8249297619423;1032.7624646331385;1033.6175615022414;11630.185886987914;11740.354280514568;11949.22330048544;11962.40187990597;11969.222000570022;4584.243599805995;4659.184642687516;4744.146053710297;4770.499097594772;4776.928346074812;9344.439333640003;9356.578953947088;9360.672376466791;9386.249100071978;9393.577289021874;5328.520433161034;5397.298351214317;5409;5427.3758517770175;5429.049916264638;3951.9012024699036;4472.396226509444;4826.975865120652;5003.599712023102;5062.038212739568;3771.528558930134;3799.639034291738;3852.788096654655;3884.2037382336553;3906.4726261954843;1215.1068964311223;1225.1240363140219;1226.6381417481864;1230.8584512780965;1241.1994263699862;686.5914780705472;722.4401089155946;955.4362925873629;956.2254573795109;969.680005598151;5778.942210577925;5803.912941305884;5951.226340575698;5953.613015154001;6145.639843850909;479.30022167635644;492.92359684249;493.29705170132416;507.1328029070331;641.4195153386192;3815.961840381616;3968.4840970673627;4021.1923683662094;4057.6145266199665;4064.6138616831354;10599.523021464052;10896.400697961688;11010.284331518425;11032.834507482394;11080.113590912708;10722.946385268024;10973.451327433597;10995.670129896116;10995.780084398268;11005.229633925548;8227.465214761021;8247.752567422987;8257.752267431986;8302.750917472486;8403.537805420761;5661;5849.8537536560225;5863.413658634103;5966.910496342645;6086.239220097488;9677.322587418814;10094.697159085239;10269.948650256702;10288.537015834156;10294.485275736033;10253.692389228336;10263.384196948207;10294.3823370598;10308.072273495422;10363.06732394058;6852.794416167523;6941.028256044259;7014.088168538057;7016.298370162943;7049.894251586128;8037.557934313669;8260.463069900678;8268.83462330762;8276.627551760306;8314;5889.705514724333;7275.090613673291;7282.817929551804;7627.923720762721;7724.497907635986;7266.854662906607;7366.742164024234;7459.589722565311;7480.4015678746655;7511.474196806171;6936.445084393337;6979.5114341997605;7029.332213439715;7029.683664235224;7029.929700703132;4796.82477792929;4917.704937703749;5002.674826136289;5076.974615126901;5196.194589838581;4958.925616115834;5037.773300201573;5080.669756465818;5134.820281290137;5314.335708036496 07:46:40 INFO - PROCESS | 1665 | |4;prototype.html;306.86958042831793;315.296887939894;325.52960971396334;325.53347170994664;326.16013764556243;4604.6776725629215;4749.572538471537;4962;5188.325517682705;5241.344831896013;4284.421603083582;5162.064225915282;5204.297419848319;5218.608604354679;5221.660592061523;3406.540117084193;3726.3851464508325;3750.512433383656;3971.523417189941;3990.481237439129;3117.4544454720335;3788.2423515296914;3831.808409579524;3948.9605103949025;3980.2835489611857;3811.028187812104;3941.7437866538585;3990.221906728189;3990.423782605869;3993.4608827808165;3290.0129961011603;3937.940930886053;3964.920701585952;3979.60713750188;3984.6015398460213;3442.6557344265625;3494.877679281238;3497.7820405227253;3513.4554144107706;3513.9824300878586;4390.912181756379;4617.559917861181;4851.151048566487;4946.629002824767;4988.378776897523;3879.3792993121247;4451.421315229032;4464.196444639963;4496.348029535699;4503.594676479132;4759.928601070987;5225.764840582145;5406.810761623364;5412.4587541245955;5415.9458405415835;3274.3942370661503;3612.566492020948;3738.980950286842;3744.700423966076;3771.509703738524;5399.37907140676;5408.810691625814;5698.580851489115;5772.278465191851;5775.989201889611;3352.2625022495013;3645.90622813155;3805.811658296491;3814.370628846265;3835.712321575893;3585.0678823506078;3604.4953706481115;3656.232191239816;3890.8832735017995;3894.9610503894596;3727.539823716334;4420.690551661417;4462.866114016585;4492.707973981681;4498.347739577743;4337.761423121696;5163.845084647466;5511.889762204733;5515.310586176728;5523.25436066134;1344.4823742859069;1372.4235820955223;1373.4712135827579;1407.8873690104972;1419.9077059991068;891.148952750122;894.5080205886867;909.1862782809349;950.3157726436955;952.5237381309346;4932.964077543685;4979.775910084055;5127.435982041972;5548.334199895958;5557.610967232255;5546.4453554644215;6075.756969721162;6118.265808102967;6190.628562286277;6217.253929528486;3993.7020468347323;4976.615901187155;5286.471352864683;5300.231466437345;5642.899634571219;2898.130560831742;3224.0166749141736;3234.4178047951123;3274.8690052397637;3281.704646581819;5670.206171136044;5967.806438712275;6245.125682404467;6492.156019717407;6538.398092467376;5100.336956195671;6336.972168905906;6410.583312084699;6420.1974753155855;6427.485801135898;6430.871382572416;6445.066480055964;6467.350825539457;6497.18785151856;6505.21937367519;5866.706664666664;6204.255489341308;6210.882041232621;6214.937850621617;6225.813225603058;5095.719735414587;5166.974165129151;5379.569634429315;6069.757209711562;6173.382661733791;6192;6426.293107758236;6449.290578036506;6486.740530378732;6500.284968653539;4025.9396109058976;4032.2943484890616;4065.959340406558;4079.551249362627;4093.6111069448357;5058.54473097423;6089.3720772212555;6134.631922084689;6171.161265817774;6184.783532576338;4759.6430267729365;5361.812336568201;5505.6696598204235;5536;5919.763209471573;5454.863628409322;5516.310461192351;5532.889342213214;5582.180998595683;5583.497485226187;4592.954070459253;5200.375954885438;5433.972830135824;5449.209864569694;5462.617616766788;5423.3491980962535;5465.453454654503;5520.171974203901;5524.558035357081;5559.499645031967;4108.897277568085;4571.200039993055;4625.537446255347;5432.185172224198;5459.727013649381 07:46:40 INFO - PROCESS | 1665 | |5;yui.html;738.6085374751381;746.1046743907312;752.1500704204249;758.4577027425394;767.2174382130229;14009.859901400983;14728.18994955277;15220.543383698507;15229.619259518518;15231.923840380783;13795.44818207273;13984.230867302294;14001.789973150411;14011.08927919687;14018.859811401882;719.5323040023987;744.4119145874753;826.8718348655968;893.8078313162669;932.3846261467432;911.2482202183226;923.2152670230284;924.0990034716165;925.1303774452027;927.3137877970321;729.9233580474054;977.1352353167463;979.0503211884496;981.268954628799;982.0081717465375;747.8840779679158;982.832918403873;983.6852207293668;986.3145114145672;987.5309228116658;725.4015437264226;729.6133049483782;729.7117638532803;730.8720973829612;731.6890321613294;14489.347979340955;14559.417623295056;14566.344514496766;14568.490102846456;14586.4894728684;10477.26659133861;12510.3744812759;12656;12903.419346129353;12968.80546791799;9809.656662016867;9810.46042467664;9973.601055957753;10259.640912568098;10471.267011309212;3444.207832198583;3483.7213022958103;3524.559430071241;3538.469229615578;3572.7499075064757;68561;69594.60810783807;70258.2974170257;70363.64818175927;71164.28835711628;9168.193367711232;9172.541372931326;9243.630254789867;9341.78993677483;9471.147596716191;19580.70628940567;20296.797032029786;20317;20335.186592536134;20357.796422035888;6151.323354431009;7043.696916070543;7306.305900939402;7419.2158978953785;7499.250074992567;3729.701623870084;4088.5911408858874;4096.91806163875;4098.938515922264;4123.340265557496;3554.0759402555004;3620.981895090508;3632.654897784706;3634.473001414833;3634.763740356921;569.857535616096;601.2334273800851;649.2339039932924;652.1652285075112;657.5824351536809;515.209153948687;542.5090293284505;564.3340857787849;590.1295589006181;599.9550033747487;8052.759111688489;8084.8383032339025;8210.137935516805;8279.95860020696;8346.8330633387;509.0582422518385;551.5752870289855;567.3617180671745;609.856354912483;629.0187307799847;3860.613938606173;3865.4974853268895;3897.2400381925254;3973.463582416337;3993.4209539616595;99255.50372248238;101028;104574;105182;107597.46201268943;82474.17525824664;83530;85730;85987.71018434729;87855.56072219598;60160.79678406495;61340;65949;78070.82893756485;78727.21272787199;7977.546607270171;8143.5928203590765;8248.13394593559;8290.668373265244;8395.622197001028;36721.44917826181;41948.79025604852;43050.13899722051;44556.33165502455;45489.317660235785;66410.00384994326;69368.30631693618;70484.59030819457;70510.64744676244;71595;11582.88417115818;11624.88375116238;11697;11719.707007324885;12232.877671223174;11925.463354149259;12145.757084858431;12186.51253949832;12200.51197952072;12522.248665080124;8725.269517829782;10364.585416583252;10960.835587466036;11466.197366184288;11541.365224912375;9269.44383337002;11408.372539510407;11648.475818588353;11781.004873867525;11865.822012669989;9389.624415023323;10956;11075.889241107487;11174.66476005721;11449.59926402572;9099;9210.677626283048;9366.718998429786;9449.527523623929;9563.426194428357;9892.901070989486;9924.702258932244;9935.801283974424;9964.651237206663;10038.548265327932 07:46:40 INFO - PROCESS | 1665 | __end_tp_report 07:46:40 INFO - PROCESS | 1665 | __start_cc_report 07:46:40 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1125 07:46:40 INFO - PROCESS | 1665 | __end_cc_report 07:46:40 INFO - PROCESS | 1665 | __startTimestamp1461595600055__endTimestamp 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:46:40 INFO - PROCESS | 1665 | Number of tests: 6 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5713.43 Median:5926.14 stddev:650.30 (11.0%) stddev-sans-first:621.55 07:46:40 INFO - PROCESS | 1665 | Values: 3194.8 3445.0 3460.1 3481.5 3518.4 5651.9 5680.4 5710.5 5718.8 5724.1 5716.0 5743.7 5836.5 5866.9 5878.0 5103.2 5146.7 5166.9 5175.7 5239.8 5264.8 5286.9 5293.8 5315.8 5330.0 5067.6 5112.8 5158.3 5179.9 5239.4 5143.7 5173.7 5176.9 5186.5 5198.0 4681.2 4868.8 5142.8 5161.7 5210.6 5517.2 5622.1 5625.0 5637.3 5638.1 6117.0 6216.6 6240.7 6252.0 6252.3 6240.0 6301.9 6303.2 6323.1 6341.4 4695.4 5770.7 5773.1 5776.7 5789.4 6255.6 6314.3 6357.6 6385.3 6396.0 5221.7 6110.7 6117.7 6139.2 6147.4 6226.1 6237.3 6238.6 6278.5 6279.4 6045.8 6102.5 6105.0 6118.2 6162.2 6215.2 6222.1 6233.1 6236.2 6243.3 4884.3 4888.0 4888.6 4896.0 4932.0 4318.4 4367.7 4425.6 4468.9 4504.9 5619.0 5642.9 5649.9 5664.9 5678.1 6261.9 6266.5 6283.3 6309.4 6321.0 4822.7 5574.5 5639.8 5640.2 5737.1 5375.8 5382.4 5386.4 5387.6 5394.0 6315.2 6316.0 6342.7 6349.0 6354.9 6106.3 6198.9 6333.5 6340.2 6350.3 6275.7 6339.7 6363.2 6374.5 6377.5 5941.5 6145.8 6147.3 6159.8 6181.8 6102.3 6165.7 6171.9 6281.7 6283.4 5997.7 6010.3 6024.5 6054.3 6069.9 6011.8 6019.9 6026.8 6026.9 6036.5 5712.0 5850.2 5876.6 5882.1 5966.7 5941.0 5977.3 6025.3 6035.2 6119.9 5923.8 5924.6 5926.1 5927.2 5944.4 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:61034.40 Median:18991.51 stddev:125718.66 (662.0%) stddev-sans-first:125989.18 07:46:40 INFO - PROCESS | 1665 | Values: 501.5 504.3 594.8 602.9 632.3 28006.9 38375.8 39378.2 39398.8 39497.4 43564.6 44141.1 44308.3 44335.0 44551.0 8407.2 9475.9 9708.2 9729.5 9740.3 8484.9 11139.9 11396.5 11397.4 11399.5 9500.8 11476.1 11481.2 11487.5 11488.3 8257.8 11120.3 11341.2 11364.7 11439.8 11173.1 11340.9 11342.7 11355.9 11378.9 38380.2 38890.2 38913.4 38944.4 39048.0 3198.4 3230.1 3239.5 3247.4 3405.4 28793.0 29287.9 29575.7 29596.0 29650.1 2679.5 2737.6 2799.4 2817.1 2831.8 297923.0 352808.0 392746.0 394851.0 395610.0 60866.1 61674.1 61684.4 61791.5 61848.7 64569.0 65183.0 65255.3 65271.7 65426.0 15752.8 16372.9 16401.8 16676.7 16953.3 11435.6 11729.9 12439.4 12653.9 13056.8 17175.6 17200.3 17225.2 17245.7 17252.7 5374.7 6426.0 6654.5 6658.5 6722.9 957.0 984.2 986.8 1048.7 1052.1 24276.0 28244.6 28891.9 29144.0 29480.4 1108.2 1133.0 1137.2 1137.5 1141.1 15082.5 15205.5 15214.9 15360.2 15465.3 583462.0 587986.0 588615.0 588898.0 589314.0 49918.8 57939.1 59804.4 59916.0 60078.5 1273.8 1316.7 1347.6 1477.9 1541.0 29117.6 29568.0 29764.6 30286.5 30480.4 49750.0 49866.0 50090.7 50184.7 50289.5 429453.0 433087.0 433655.7 434273.0 434660.0 28159.8 32282.8 32309.8 32324.2 32382.7 41774.7 42235.6 42330.9 43013.0 43240.1 35596.5 35678.3 36519.0 36525.5 36708.8 34577.7 34834.3 35741.6 36897.6 36929.0 35127.5 35674.6 36869.4 37115.7 37230.4 30242.7 31297.4 31318.8 31369.1 31463.2 23285.5 23410.9 24037.5 24092.8 24124.4 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34676.78 Median:21312.15 stddev:97936.81 (459.5%) stddev-sans-first:98177.71 07:46:40 INFO - PROCESS | 1665 | Values: 393.8 395.9 398.1 398.3 411.3 14841.7 20363.5 21148.8 21181.8 21189.5 20346.4 20377.4 20529.1 20894.2 21209.2 5770.2 5985.9 6041.0 6049.0 6053.2 5095.5 5577.4 5928.6 5990.1 6663.9 6421.5 6694.2 6700.9 6702.6 6716.6 6567.9 6570.7 6575.3 6576.4 6599.3 4246.4 4877.1 4956.2 4961.9 4969.4 25813.9 26007.0 26568.5 26973.9 27276.5 2170.4 2299.9 2464.2 2469.2 2573.3 14293.4 14694.0 14767.0 15178.2 15326.5 1707.9 1727.5 1735.1 1834.8 1859.3 114953.0 118451.0 118542.0 120026.4 121654.0 9113.4 10889.8 11384.9 11487.3 11590.5 12823.6 13534.2 13623.2 14540.6 14544.9 8696.8 8811.6 8920.4 8929.3 9038.9 8920.1 8924.9 8927.6 9043.7 9076.5 5742.6 5914.3 6790.0 6829.1 6860.9 1882.3 1913.9 1917.9 1918.6 1946.8 909.5 958.7 977.2 1009.9 1033.7 20914.4 21057.9 21301.5 21322.8 21815.2 969.5 993.7 999.6 1008.4 1017.6 11237.9 11669.6 11692.5 11774.0 11983.3 572348.0 580689.0 586590.0 599344.0 600474.0 119537.4 120484.2 122179.4 123384.4 125201.1 1043.3 1057.9 1109.6 1126.9 1127.9 18893.5 19067.9 19232.4 19279.7 19293.5 45251.8 49846.8 50463.0 50467.5 50875.5 71345.6 71550.0 71994.3 72867.3 73339.0 8007.1 8119.1 8151.0 8394.7 8396.6 13117.4 13161.0 13226.4 13355.3 13443.9 11250.1 11484.8 11578.8 11595.5 11618.4 11097.5 11175.3 11236.2 11451.7 11560.1 10973.9 11594.1 11619.6 11724.9 11890.0 8151.5 8202.8 8245.8 8278.5 8401.9 11392.7 11420.9 11628.0 11695.5 11792.1 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5703.30 Median:4872.34 stddev:3227.88 (66.2%) stddev-sans-first:3220.95 07:46:40 INFO - PROCESS | 1665 | Values: 1428.6 1436.7 1612.3 1840.0 2001.8 7862.3 8667.8 8884.4 8885.2 8888.2 8532.5 8745.8 8753.4 8759.8 8766.9 2427.9 2460.2 2461.4 2463.4 2466.1 2036.3 2392.6 2451.1 2458.4 2460.6 2428.2 2449.5 2462.2 2463.3 2467.3 2387.5 2393.7 2408.1 2412.8 2427.6 2382.6 2418.3 2422.4 2423.5 2424.2 8604.3 8746.6 8776.8 8824.4 8851.7 4572.6 4679.4 5316.0 5528.5 5549.3 3487.3 3587.8 3630.3 3644.8 3653.6 1021.8 1027.9 1029.8 1032.8 1033.6 11630.2 11740.4 11949.2 11962.4 11969.2 4584.2 4659.2 4744.1 4770.5 4776.9 9344.4 9356.6 9360.7 9386.2 9393.6 5328.5 5397.3 5409.0 5427.4 5429.0 3951.9 4472.4 4827.0 5003.6 5062.0 3771.5 3799.6 3852.8 3884.2 3906.5 1215.1 1225.1 1226.6 1230.9 1241.2 686.6 722.4 955.4 956.2 969.7 5778.9 5803.9 5951.2 5953.6 6145.6 479.3 492.9 493.3 507.1 641.4 3816.0 3968.5 4021.2 4057.6 4064.6 10599.5 10896.4 11010.3 11032.8 11080.1 10722.9 10973.5 10995.7 10995.8 11005.2 8227.5 8247.8 8257.8 8302.8 8403.5 5661.0 5849.9 5863.4 5966.9 6086.2 9677.3 10094.7 10269.9 10288.5 10294.5 10253.7 10263.4 10294.4 10308.1 10363.1 6852.8 6941.0 7014.1 7016.3 7049.9 8037.6 8260.5 8268.8 8276.6 8314.0 5889.7 7275.1 7282.8 7627.9 7724.5 7266.9 7366.7 7459.6 7480.4 7511.5 6936.4 6979.5 7029.3 7029.7 7029.9 4796.8 4917.7 5002.7 5077.0 5196.2 4958.9 5037.8 5080.7 5134.8 5314.3 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4578.34 Median:5077.13 stddev:1475.95 (29.1%) stddev-sans-first:1444.85 07:46:40 INFO - PROCESS | 1665 | Values: 306.9 315.3 325.5 325.5 326.2 4604.7 4749.6 4962.0 5188.3 5241.3 4284.4 5162.1 5204.3 5218.6 5221.7 3406.5 3726.4 3750.5 3971.5 3990.5 3117.5 3788.2 3831.8 3949.0 3980.3 3811.0 3941.7 3990.2 3990.4 3993.5 3290.0 3937.9 3964.9 3979.6 3984.6 3442.7 3494.9 3497.8 3513.5 3514.0 4390.9 4617.6 4851.2 4946.6 4988.4 3879.4 4451.4 4464.2 4496.3 4503.6 4759.9 5225.8 5406.8 5412.5 5415.9 3274.4 3612.6 3739.0 3744.7 3771.5 5399.4 5408.8 5698.6 5772.3 5776.0 3352.3 3645.9 3805.8 3814.4 3835.7 3585.1 3604.5 3656.2 3890.9 3895.0 3727.5 4420.7 4462.9 4492.7 4498.3 4337.8 5163.8 5511.9 5515.3 5523.3 1344.5 1372.4 1373.5 1407.9 1419.9 891.1 894.5 909.2 950.3 952.5 4933.0 4979.8 5127.4 5548.3 5557.6 5546.4 6075.8 6118.3 6190.6 6217.3 3993.7 4976.6 5286.5 5300.2 5642.9 2898.1 3224.0 3234.4 3274.9 3281.7 5670.2 5967.8 6245.1 6492.2 6538.4 5100.3 6337.0 6410.6 6420.2 6427.5 6430.9 6445.1 6467.4 6497.2 6505.2 5866.7 6204.3 6210.9 6214.9 6225.8 5095.7 5167.0 5379.6 6069.8 6173.4 6192.0 6426.3 6449.3 6486.7 6500.3 4025.9 4032.3 4066.0 4079.6 4093.6 5058.5 6089.4 6134.6 6171.2 6184.8 4759.6 5361.8 5505.7 5536.0 5919.8 5454.9 5516.3 5532.9 5582.2 5583.5 4593.0 5200.4 5434.0 5449.2 5462.6 5423.3 5465.5 5520.2 5524.6 5559.5 4108.9 4571.2 4625.5 5432.2 5459.7 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18222.94 Median:30974.93 stddev:26340.67 (85.0%) stddev-sans-first:26381.85 07:46:40 INFO - PROCESS | 1665 | Values: 738.6 746.1 752.2 758.5 767.2 14009.9 14728.2 15220.5 15229.6 15231.9 13795.4 13984.2 14001.8 14011.1 14018.9 719.5 744.4 826.9 893.8 932.4 911.2 923.2 924.1 925.1 927.3 729.9 977.1 979.1 981.3 982.0 747.9 982.8 983.7 986.3 987.5 725.4 729.6 729.7 730.9 731.7 14489.3 14559.4 14566.3 14568.5 14586.5 10477.3 12510.4 12656.0 12903.4 12968.8 9809.7 9810.5 9973.6 10259.6 10471.3 3444.2 3483.7 3524.6 3538.5 3572.7 68561.0 69594.6 70258.3 70363.6 71164.3 9168.2 9172.5 9243.6 9341.8 9471.1 19580.7 20296.8 20317.0 20335.2 20357.8 6151.3 7043.7 7306.3 7419.2 7499.3 3729.7 4088.6 4096.9 4098.9 4123.3 3554.1 3621.0 3632.7 3634.5 3634.8 569.9 601.2 649.2 652.2 657.6 515.2 542.5 564.3 590.1 600.0 8052.8 8084.8 8210.1 8280.0 8346.8 509.1 551.6 567.4 609.9 629.0 3860.6 3865.5 3897.2 3973.5 3993.4 99255.5 101028.0 104574.0 105182.0 107597.5 82474.2 83530.0 85730.0 85987.7 87855.6 60160.8 61340.0 65949.0 78070.8 78727.2 7977.5 8143.6 8248.1 8290.7 8395.6 36721.4 41948.8 43050.1 44556.3 45489.3 66410.0 69368.3 70484.6 70510.6 71595.0 11582.9 11624.9 11697.0 11719.7 12232.9 11925.5 12145.8 12186.5 12200.5 12522.2 8725.3 10364.6 10960.8 11466.2 11541.4 9269.4 11408.4 11648.5 11781.0 11865.8 9389.6 10956.0 11075.9 11174.7 11449.6 9099.0 9210.7 9366.7 9449.5 9563.4 9892.9 9924.7 9935.8 9964.7 10038.5 07:46:40 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:46:40 INFO - PROCESS | 1665 | 07:46:40 INFO - TEST-INFO | 1665: exit 0 07:46:40 INFO - TEST-OK | dromaeo_css | took 1115335ms 07:46:40 INFO - TEST-START | kraken 07:46:40 INFO - operating with platform_type : mac_ 07:46:40 INFO - Initialising browser for kraken test... 07:46:40 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpblSy7p/profile http://localhost:49275/getInfo.html) 07:46:42 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 07:46:42 INFO - PROCESS | 1676 | colorDepth:24 07:46:42 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 07:46:42 INFO - PROCESS | 1676 | __metrics 07:46:42 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:46:42 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:46:43 INFO - TEST-INFO | 1676: exit 0 07:46:43 INFO - Browser initialized. 07:46:43 INFO - Running cycle 1/1 for kraken test... 07:46:43 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpblSy7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:55 INFO - PROCESS | 1678 | RSS: Main: 239669248 07:46:55 INFO - PROCESS | 1678 | 07:46:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 07:46:59 INFO - PROCESS | 1678 | RSS: Main: 286793728 07:46:59 INFO - PROCESS | 1678 | 07:47:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 07:47:02 INFO - PROCESS | 1678 | RSS: Main: 300126208 07:47:02 INFO - PROCESS | 1678 | 07:47:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 07:47:06 INFO - PROCESS | 1678 | RSS: Main: 384376832 07:47:06 INFO - PROCESS | 1678 | 07:47:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 07:47:09 INFO - PROCESS | 1678 | RSS: Main: 288739328 07:47:09 INFO - PROCESS | 1678 | 07:47:11 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:12 INFO - PROCESS | 1678 | RSS: Main: 292089856 07:47:12 INFO - PROCESS | 1678 | 07:47:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:15 INFO - PROCESS | 1678 | RSS: Main: 331542528 07:47:15 INFO - PROCESS | 1678 | 07:47:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:19 INFO - PROCESS | 1678 | RSS: Main: 331173888 07:47:19 INFO - PROCESS | 1678 | 07:47:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 07:47:22 INFO - PROCESS | 1678 | RSS: Main: 329101312 07:47:22 INFO - PROCESS | 1678 | 07:47:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:24 INFO - PROCESS | 1678 | RSS: Main: 321667072 07:47:24 INFO - PROCESS | 1678 | 07:47:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:27 INFO - PROCESS | 1678 | RSS: Main: 328196096 07:47:27 INFO - PROCESS | 1678 | 07:47:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:29 INFO - PROCESS | 1678 | RSS: Main: 330010624 07:47:29 INFO - PROCESS | 1678 | 07:47:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:33 INFO - PROCESS | 1678 | RSS: Main: 335634432 07:47:33 INFO - PROCESS | 1678 | 07:47:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:36 INFO - PROCESS | 1678 | RSS: Main: 332763136 07:47:36 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 07:47:38 INFO - PROCESS | 1678 | RSS: Main: 397090816 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | __start_tp_report 07:47:38 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 07:47:38 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 07:47:38 INFO - PROCESS | 1678 | |i|pagename|runs| 07:47:38 INFO - PROCESS | 1678 | |0;ai-astar;113;112;108;111;113;111;112;113;106;112 07:47:38 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;121;162;203;146;142;115;149;159;118 07:47:38 INFO - PROCESS | 1678 | |2;audio-dft;184;188;184;186;185;181;187;185;177;183 07:47:38 INFO - PROCESS | 1678 | |3;audio-fft;76;71;76;151;55;55;64;69;150;71 07:47:38 INFO - PROCESS | 1678 | |4;audio-oscillator;91;92;139;78;80;85;125;79;75;122 07:47:38 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;84;87;90;86;84;87;83;87;83 07:47:38 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;92;93;92;92;91;93;93;92;92 07:47:38 INFO - PROCESS | 1678 | |7;imaging-desaturate;88;82;84;83;84;84;85;84;86;94 07:47:38 INFO - PROCESS | 1678 | |8;json-parse-financial;60;60;61;59;59;61;59;77;60;58 07:47:38 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;62;74;78;69;68;65;67;67;67 07:47:38 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;83;83;83;78;82;82;83;79;83 07:47:38 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;136;140;149;124;142;147;149;156;175;133 07:47:38 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;172;169;180;172;171;168;170;168;167;169 07:47:38 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;69;67;68;71;82;96;97;80;68;71 07:47:38 INFO - PROCESS | 1678 | __end_tp_report 07:47:38 INFO - PROCESS | 1678 | __start_cc_report 07:47:38 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,2025 07:47:38 INFO - PROCESS | 1678 | __end_cc_report 07:47:38 INFO - PROCESS | 1678 | __startTimestamp1461595658924__endTimestamp 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | ------- Summary: start ------- 07:47:38 INFO - PROCESS | 1678 | Number of tests: 14 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.33 (2.1%) stddev-sans-first:2.37 07:47:38 INFO - PROCESS | 1678 | Values: 113.0 112.0 108.0 111.0 113.0 111.0 112.0 113.0 106.0 112.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:151.50 stddev:26.09 (17.2%) stddev-sans-first:27.54 07:47:38 INFO - PROCESS | 1678 | Values: 154.0 121.0 162.0 203.0 146.0 142.0 115.0 149.0 159.0 118.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:3.16 (1.7%) stddev-sans-first:3.35 07:47:38 INFO - PROCESS | 1678 | Values: 184.0 188.0 184.0 186.0 185.0 181.0 187.0 185.0 177.0 183.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:83.80 Median:70.00 stddev:35.93 (51.3%) stddev-sans-first:38.00 07:47:38 INFO - PROCESS | 1678 | Values: 76.0 71.0 76.0 151.0 55.0 55.0 64.0 69.0 150.0 71.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:79.50 stddev:23.18 (29.2%) stddev-sans-first:24.49 07:47:38 INFO - PROCESS | 1678 | Values: 91.0 92.0 139.0 78.0 80.0 85.0 125.0 79.0 75.0 122.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:2.33 (2.7%) stddev-sans-first:2.35 07:47:38 INFO - PROCESS | 1678 | Values: 88.0 84.0 87.0 90.0 86.0 84.0 87.0 83.0 87.0 83.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:47:38 INFO - PROCESS | 1678 | Values: 92.0 92.0 93.0 92.0 92.0 91.0 93.0 93.0 92.0 92.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:84.50 stddev:3.44 (4.1%) stddev-sans-first:3.52 07:47:38 INFO - PROCESS | 1678 | Values: 88.0 82.0 84.0 83.0 84.0 84.0 85.0 84.0 86.0 94.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:60.00 stddev:5.56 (9.3%) stddev-sans-first:5.88 07:47:38 INFO - PROCESS | 1678 | Values: 60.0 60.0 61.0 59.0 59.0 61.0 59.0 77.0 60.0 58.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:4.83 (7.2%) stddev-sans-first:4.77 07:47:38 INFO - PROCESS | 1678 | Values: 63.0 62.0 74.0 78.0 69.0 68.0 65.0 67.0 67.0 67.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:83.00 stddev:1.85 (2.2%) stddev-sans-first:1.92 07:47:38 INFO - PROCESS | 1678 | Values: 83.0 83.0 83.0 83.0 78.0 82.0 82.0 83.0 79.0 83.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:148.00 stddev:13.97 (9.4%) stddev-sans-first:14.43 07:47:38 INFO - PROCESS | 1678 | Values: 136.0 140.0 149.0 124.0 142.0 147.0 149.0 156.0 175.0 133.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.50 stddev:3.72 (2.2%) stddev-sans-first:3.91 07:47:38 INFO - PROCESS | 1678 | Values: 172.0 169.0 180.0 172.0 171.0 168.0 170.0 168.0 167.0 169.0 07:47:38 INFO - PROCESS | 1678 | 07:47:38 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:75.50 stddev:11.51 (15.2%) stddev-sans-first:11.85 07:47:38 INFO - PROCESS | 1678 | Values: 69.0 67.0 68.0 71.0 82.0 96.0 97.0 80.0 68.0 71.0 07:47:38 INFO - PROCESS | 1678 | -------- Summary: end -------- 07:47:38 INFO - PROCESS | 1678 | 07:47:39 INFO - TEST-INFO | 1678: exit 0 07:47:39 INFO - TEST-OK | kraken | took 59125ms 07:47:39 INFO - SUITE-END | took 1174s 07:47:40 INFO - Completed test suite (00:19:34) 07:47:40 INFO - javascript benchmark 07:47:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3194.8242846643434, 3444.965550344496, 3460.134966258435, 3481.460373642083, 3518.41946078897, 5651.8587035324135, 5680.375158732536, 5710.486056254937, 5718.828435146942, 5724.141378793183, 5715.971420142904, 5743.741531631076, 5836.474717275444, 5866.941330586693, 5878.000739874221, 5103.209002604603, 5146.74266286686, 5166.896662066756, 5175.741212939357, 5239.816606418776, 5264.789408423659, 5286.947130528703, 5293.814716484924, 5315.813946511873, 5329.973350133263, 5067.594592432615, 5112.821051263225, 5158.277841102249, 5179.922301165486, 5239.423663397042, 5143.742812859342, 5173.663711858717, 5176.948230517684, 5186.481351864821, 5197.974010129963, 4681.180793361183, 4868.805247790084, 5142.794288228466, 5161.7161056141895, 5210.583153347723, 5517.200005999148, 5622.1004639257935, 5625.0, 5637.323521177444, 5638.097904335327, 6116.960116780158, 6216.627002379872, 6240.719167637467, 6251.968740156316, 6252.3122456529745, 6240.0, 6301.873962520724, 6303.180586523768, 6323.14637523933, 6341.365863413668, 4695.436547614308, 5770.7403166857175, 5773.134029895466, 5776.740046697909, 5789.392113828029, 6255.56211065221, 6314.273858506331, 6357.586756860789, 6385.329540398191, 6396.0, 5221.686698798008, 6110.663913484712, 6117.694115294217, 6139.201903752483, 6147.44672979434, 6226.066090086523, 6237.345078766664, 6238.594491358047, 6278.497720182374, 6279.434850863444, 6045.758169673251, 6102.489251635809, 6105.0, 6118.162361256266, 6162.22972128484, 6215.192025036717, 6222.066689996446, 6233.1273621693, 6236.158118653923, 6243.344448832807, 4884.291777692215, 4887.9735255596015, 4888.560029597282, 4896.0, 4932.0, 4318.438602981592, 4367.650587952956, 4425.579569940851, 4468.910621787546, 4504.887377815516, 5619.044762390404, 5642.858928526737, 5649.915251271234, 5664.858378540487, 5678.119891416837, 6261.937380626136, 6266.467350275278, 6283.3088360280335, 6309.400606942333, 6320.968395157995, 4822.662413631012, 5574.526165275997, 5639.774409023593, 5640.182173584889, 5737.08206686928, 5375.838724838261, 5382.434844341366, 5386.434424385461, 5387.595930305243, 5394.0, 6315.242170939517, 6316.021016742412, 6342.746290148435, 6348.968255158695, 6354.872902542016, 6106.3089915548935, 6198.907016394848, 6333.461655759312, 6340.207474065742, 6350.333215012357, 6275.717592708248, 6339.746410143543, 6363.204599425072, 6374.521910856612, 6377.489800816016, 5941.524678025661, 6145.84635384119, 6147.323794382703, 6159.784407545714, 6181.84545386369, 6102.337773232528, 6165.660888651168, 6171.9074213887725, 6281.748730050929, 6283.434490895841, 5997.730102145327, 6010.338862725184, 6024.457798797954, 6054.3340232575265, 6069.9089513656445, 6011.819645410645, 6019.909701354396, 6026.7589296429405, 6026.909596356146, 6036.456718895321, 5711.971440142773, 5850.180974663465, 5876.647401155944, 5882.088276317178, 5966.671833049224, 5941.049432090845, 5977.252843394575, 6025.337212906665, 6035.18524999137, 6119.877602448015, 5923.763049478145, 5924.6149000314845, 5926.140709597171, 5927.229460170151, 5944.4352786485215], "value": 5672.136594074118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.45842490110664, 504.28643469490675, 594.7650677982194, 602.8975074237379, 632.2886752403546, 28006.85996570017, 38375.80812095939, 39378.212435751266, 39398.80300598493, 39497.42010319584, 43564.564354356444, 44141.11717765643, 44308.3353749694, 44335.0, 44551.0, 8407.24334809867, 9475.857862132074, 9708.17480514157, 9729.513524323791, 9740.318177727562, 8484.872726909101, 11139.888601114008, 11396.487158077865, 11397.430128493583, 11399.487023083939, 9500.762480937963, 11476.139289553317, 11481.196316257865, 11487.483063262172, 11488.310701357945, 8257.752267431986, 11120.332780033143, 11341.206115571913, 11364.659060228123, 11439.771204575904, 11173.106151507942, 11340.886591134065, 11342.659720208407, 11355.943220283845, 11378.943105284503, 38380.23239535194, 38890.22219555621, 38913.41629875554, 38944.41583376252, 39048.02379940496, 3198.3603279344225, 3230.095573239497, 3239.514072889062, 3247.3667634811222, 3405.3700065487965, 28793.0, 29287.853560732274, 29575.70424295751, 29596.0, 29650.110496685134, 2679.517686816372, 2737.5619900815773, 2799.3561480859516, 2817.0844475545528, 2831.8159319644365, 297923.0, 352808.0, 392746.0, 394851.0, 395610.0219498913, 60866.08700869491, 61674.074888876705, 61684.38315616876, 61791.45521362002, 61848.690756545926, 64569.0, 65183.0, 65255.34744652588, 65271.69456610841, 65426.0, 15752.76370854438, 16372.918135409247, 16401.753973690404, 16676.74984875228, 16953.321867125425, 11435.59975400857, 11729.941350293195, 12439.37803109841, 12653.87346126527, 13056.804147937788, 17175.57061073483, 17200.31198752061, 17225.22486488111, 17245.65508689819, 17252.654946901243, 5374.6506477078865, 6426.0, 6654.500912431587, 6658.500612454085, 6722.899156512656, 956.9808603827885, 984.2077127911956, 986.8125056239435, 1048.7325731938306, 1052.074174726236, 24276.0, 28244.576331354634, 28891.85554072216, 29144.0, 29480.410391792044, 1108.2408550143177, 1132.9546818127346, 1137.2494153858413, 1137.4881303413497, 1141.0814294493014, 15082.472113475975, 15205.543833685007, 15214.934954553075, 15360.155191464577, 15465.304061317267, 583462.0, 587986.0, 588615.0, 588898.0, 589314.0, 49918.750406248466, 57939.13091303634, 59804.40195598076, 59916.0, 60078.49803754941, 1273.802560603108, 1316.7432350691522, 1347.636138242669, 1477.918714470693, 1540.9675517403143, 29117.563236551046, 29568.0, 29764.55353169661, 30286.54570181493, 30480.390392192476, 49750.0, 49866.0, 50090.74954625204, 50184.74907625438, 50289.49710502848, 429453.0, 433087.0, 433655.66344337416, 434273.0, 434660.0, 28159.776033594306, 32282.83858580786, 32309.838450807594, 32324.191895202806, 32382.67617323891, 41774.72565807188, 42235.577644223165, 42330.94172645709, 43013.0, 43240.135197296506, 35596.466053009746, 35678.286434271686, 36519.0, 36525.45211821878, 36708.81645591755, 34577.65422345845, 34834.303313934084, 35741.642583573834, 36897.63102369049, 36929.02650040882, 35127.47308790421, 35674.643253567134, 36869.44695829618, 37115.700950466606, 37230.44154337741, 30242.697573023986, 31297.374052518368, 31318.843405782824, 31369.05892823219, 31463.21341966469, 23285.53428931446, 23410.853487408287, 24037.51924961456, 24092.75907240905, 24124.396890077187], "value": 19534.015118719348, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.78735482839267, 395.94654721612574, 398.1459768795932, 398.3228511530399, 411.2535747618073, 14841.703165936675, 20363.49091272719, 21148.788512114876, 21181.788182118173, 21189.470263243427, 20346.389608311776, 20377.388678339637, 20529.076191571377, 20894.164233430645, 21209.151633934664, 5770.249867517216, 5985.910211346833, 6040.96979515104, 6049.032154855224, 6053.152558641794, 5095.464976177504, 5577.358603760558, 5928.55535834812, 5990.101484777275, 6663.866722665543, 6421.518386121036, 6694.163229596301, 6700.899486507707, 6702.631355275458, 6716.563423377489, 6567.877867158139, 6570.737170513174, 6575.3095924927675, 6576.441002514816, 6599.3070727573395, 4246.426732391149, 4877.146499362598, 4956.207006878918, 4961.925571116436, 4969.378827646544, 25813.870930645415, 26007.0, 26568.468630627278, 26973.92104315825, 27276.45447091067, 2170.4180064308694, 2299.8735069571167, 2464.236086813076, 2469.2221950085664, 2573.29234460523, 14293.409947926044, 14694.0, 14767.0, 15178.241087945558, 15326.463573774976, 1707.9146042697816, 1727.4558514068028, 1735.0543953545223, 1834.8073452287585, 1859.2562974810048, 114953.0, 118450.99999999914, 118542.0, 120026.39986800097, 121654.0, 9113.36206465541, 10889.83665245022, 11384.886151138382, 11487.25332853362, 11590.536378544764, 12823.551175708806, 13534.18794872291, 13623.18260904349, 14540.636484087983, 14544.927275363556, 8696.78258043554, 8811.603477843513, 8920.375573709907, 8929.285657147413, 9038.909610903938, 8920.107989201028, 8924.910750892537, 8927.553622318857, 9043.68347107848, 9076.455412675261, 5742.598018138774, 5914.290285165807, 6790.0, 6829.112215411965, 6860.897086543706, 1882.284731801934, 1913.885166889991, 1917.8657493975288, 1918.56832212751, 1946.7929883472339, 909.5497728624241, 958.7219706285099, 977.2231076294363, 1009.9091081802526, 1033.6537260017978, 20914.37256882296, 21057.89471052635, 21301.46746331323, 21322.827244501703, 21815.236466723905, 969.4813274897896, 993.6969224386631, 999.5606326889256, 1008.3798463944621, 1017.6438246613626, 11237.943810280896, 11669.649910502698, 11692.47383867711, 11774.0, 11983.340916249515, 572348.0, 580689.0, 586590.0, 599344.0, 600474.0, 119537.40231298962, 120484.19273710901, 122179.38910305391, 123384.38307808404, 125201.12198317032, 1043.2853495355555, 1057.894210578936, 1109.5728144664201, 1126.8760436351995, 1127.9041281491002, 18893.527661808566, 19067.855928644327, 19232.423027309203, 19279.710804337665, 19293.517662058563, 45251.83237173366, 49846.75076624594, 50463.0, 50467.49532504775, 50875.491245087076, 71345.64327178331, 71550.0, 71994.28005720086, 72867.27132728604, 73339.0, 8007.079185893464, 8119.066307374727, 8150.959245203736, 8394.706185283485, 8396.580170991549, 13117.409716562586, 13161.0, 13226.4048117833, 13355.26546039977, 13443.932780336036, 11250.099992000456, 11484.827727583926, 11578.76842463163, 11595.478203480694, 11618.360990145624, 11097.500612472297, 11175.273607215506, 11236.157288203582, 11451.713707157387, 11560.132990025613, 10973.945130274298, 11594.14493681007, 11619.593314233962, 11724.88275117272, 11890.0, 8151.5109093454585, 8202.83594328122, 8245.79385515343, 8278.544680042414, 8401.915980840113, 11392.715182120513, 11420.885791142315, 11628.0, 11695.532178712756, 11792.05663546897], "value": 9909.06225669824, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.6071330384143, 1436.6839295355019, 1612.298650087212, 1839.9724004139941, 2001.8498612604049, 7862.292393684567, 8667.78330541736, 8884.422512536697, 8885.200331970129, 8888.155625215593, 8532.488050716962, 8745.781355466117, 8753.3872628916, 8759.824803503927, 8766.868496972551, 2427.8786060696984, 2460.1758410932357, 2461.396957745355, 2463.3964678653756, 2466.124525793344, 2036.3178335257633, 2392.629142482918, 2451.0930955546473, 2458.409981604411, 2460.6309053642008, 2428.162284012013, 2449.534588428202, 2462.212092130519, 2463.261021693485, 2467.2721547143638, 2387.4747555537756, 2393.724721657006, 2408.121035821921, 2412.7949124324455, 2427.647991041289, 2382.5711371953043, 2418.3470462974897, 2422.382292515415, 2423.4547226873988, 2424.15154695855, 8604.268637165786, 8746.60640271183, 8776.780580485474, 8824.426412283181, 8851.734447966572, 4572.611328037121, 4679.391679081732, 5315.973420132913, 5528.502434780889, 5549.334079910396, 3487.2851065531504, 3587.802670853102, 3630.2557975614936, 3644.8359823807727, 3653.6163702811355, 1021.7752094539189, 1027.8817935937388, 1029.8249297619423, 1032.7624646331385, 1033.6175615022414, 11630.185886987914, 11740.354280514568, 11949.22330048544, 11962.40187990597, 11969.222000570022, 4584.243599805995, 4659.184642687516, 4744.146053710297, 4770.499097594772, 4776.928346074812, 9344.439333640003, 9356.578953947088, 9360.672376466791, 9386.249100071978, 9393.577289021874, 5328.520433161034, 5397.298351214317, 5409.0, 5427.3758517770175, 5429.049916264638, 3951.9012024699036, 4472.396226509444, 4826.975865120652, 5003.599712023102, 5062.038212739568, 3771.528558930134, 3799.639034291738, 3852.788096654655, 3884.2037382336553, 3906.4726261954843, 1215.1068964311223, 1225.1240363140219, 1226.6381417481864, 1230.8584512780965, 1241.1994263699862, 686.5914780705472, 722.4401089155946, 955.4362925873629, 956.2254573795109, 969.680005598151, 5778.942210577925, 5803.912941305884, 5951.226340575698, 5953.613015154001, 6145.639843850909, 479.30022167635644, 492.92359684249, 493.29705170132416, 507.1328029070331, 641.4195153386192, 3815.961840381616, 3968.4840970673627, 4021.1923683662094, 4057.6145266199665, 4064.6138616831354, 10599.523021464052, 10896.400697961688, 11010.284331518425, 11032.834507482394, 11080.113590912708, 10722.946385268024, 10973.451327433597, 10995.670129896116, 10995.780084398268, 11005.229633925548, 8227.465214761021, 8247.752567422987, 8257.752267431986, 8302.750917472486, 8403.537805420761, 5661.0, 5849.8537536560225, 5863.413658634103, 5966.910496342645, 6086.239220097488, 9677.322587418814, 10094.697159085239, 10269.948650256702, 10288.537015834156, 10294.485275736033, 10253.692389228336, 10263.384196948207, 10294.3823370598, 10308.072273495422, 10363.06732394058, 6852.794416167523, 6941.028256044259, 7014.088168538057, 7016.298370162943, 7049.894251586128, 8037.557934313669, 8260.463069900678, 8268.83462330762, 8276.627551760306, 8314.0, 5889.705514724333, 7275.090613673291, 7282.817929551804, 7627.923720762721, 7724.497907635986, 7266.854662906607, 7366.742164024234, 7459.589722565311, 7480.4015678746655, 7511.474196806171, 6936.445084393337, 6979.5114341997605, 7029.332213439715, 7029.683664235224, 7029.929700703132, 4796.82477792929, 4917.704937703749, 5002.674826136289, 5076.974615126901, 5196.194589838581, 4958.925616115834, 5037.773300201573, 5080.669756465818, 5134.820281290137, 5314.335708036496], "value": 4517.259575316804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.86958042831793, 315.296887939894, 325.52960971396334, 325.53347170994664, 326.16013764556243, 4604.6776725629215, 4749.572538471537, 4962.0, 5188.325517682705, 5241.344831896013, 4284.421603083582, 5162.064225915282, 5204.297419848319, 5218.608604354679, 5221.660592061523, 3406.540117084193, 3726.3851464508325, 3750.512433383656, 3971.523417189941, 3990.481237439129, 3117.4544454720335, 3788.2423515296914, 3831.808409579524, 3948.9605103949025, 3980.2835489611857, 3811.028187812104, 3941.7437866538585, 3990.221906728189, 3990.423782605869, 3993.4608827808165, 3290.0129961011603, 3937.940930886053, 3964.920701585952, 3979.60713750188, 3984.6015398460213, 3442.6557344265625, 3494.877679281238, 3497.7820405227253, 3513.4554144107706, 3513.9824300878586, 4390.912181756379, 4617.559917861181, 4851.151048566487, 4946.629002824767, 4988.378776897523, 3879.3792993121247, 4451.421315229032, 4464.196444639963, 4496.348029535699, 4503.594676479132, 4759.928601070987, 5225.764840582145, 5406.810761623364, 5412.4587541245955, 5415.9458405415835, 3274.3942370661503, 3612.566492020948, 3738.980950286842, 3744.700423966076, 3771.509703738524, 5399.37907140676, 5408.810691625814, 5698.580851489115, 5772.278465191851, 5775.989201889611, 3352.2625022495013, 3645.90622813155, 3805.811658296491, 3814.370628846265, 3835.712321575893, 3585.0678823506078, 3604.4953706481115, 3656.232191239816, 3890.8832735017995, 3894.9610503894596, 3727.539823716334, 4420.690551661417, 4462.866114016585, 4492.707973981681, 4498.347739577743, 4337.761423121696, 5163.845084647466, 5511.889762204733, 5515.310586176728, 5523.25436066134, 1344.4823742859069, 1372.4235820955223, 1373.4712135827579, 1407.8873690104972, 1419.9077059991068, 891.148952750122, 894.5080205886867, 909.1862782809349, 950.3157726436955, 952.5237381309346, 4932.964077543685, 4979.775910084055, 5127.435982041972, 5548.334199895958, 5557.610967232255, 5546.4453554644215, 6075.756969721162, 6118.265808102967, 6190.628562286277, 6217.253929528486, 3993.7020468347323, 4976.615901187155, 5286.471352864683, 5300.231466437345, 5642.899634571219, 2898.130560831742, 3224.0166749141736, 3234.4178047951123, 3274.8690052397637, 3281.704646581819, 5670.206171136044, 5967.806438712275, 6245.125682404467, 6492.156019717407, 6538.398092467376, 5100.336956195671, 6336.972168905906, 6410.583312084699, 6420.1974753155855, 6427.485801135898, 6430.871382572416, 6445.066480055964, 6467.350825539457, 6497.18785151856, 6505.21937367519, 5866.706664666664, 6204.255489341308, 6210.882041232621, 6214.937850621617, 6225.813225603058, 5095.719735414587, 5166.974165129151, 5379.569634429315, 6069.757209711562, 6173.382661733791, 6192.0, 6426.293107758236, 6449.290578036506, 6486.740530378732, 6500.284968653539, 4025.9396109058976, 4032.2943484890616, 4065.959340406558, 4079.551249362627, 4093.6111069448357, 5058.54473097423, 6089.3720772212555, 6134.631922084689, 6171.161265817774, 6184.783532576338, 4759.6430267729365, 5361.812336568201, 5505.6696598204235, 5536.0, 5919.763209471573, 5454.863628409322, 5516.310461192351, 5532.889342213214, 5582.180998595683, 5583.497485226187, 4592.954070459253, 5200.375954885438, 5433.972830135824, 5449.209864569694, 5462.617616766788, 5423.3491980962535, 5465.453454654503, 5520.171974203901, 5524.558035357081, 5559.499645031967, 4108.897277568085, 4571.200039993055, 4625.537446255347, 5432.185172224198, 5459.727013649381], "value": 4123.740375178549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.6085374751381, 746.1046743907312, 752.1500704204249, 758.4577027425394, 767.2174382130229, 14009.859901400983, 14728.18994955277, 15220.543383698507, 15229.619259518518, 15231.923840380783, 13795.44818207273, 13984.230867302294, 14001.789973150411, 14011.08927919687, 14018.859811401882, 719.5323040023987, 744.4119145874753, 826.8718348655968, 893.8078313162669, 932.3846261467432, 911.2482202183226, 923.2152670230284, 924.0990034716165, 925.1303774452027, 927.3137877970321, 729.9233580474054, 977.1352353167463, 979.0503211884496, 981.268954628799, 982.0081717465375, 747.8840779679158, 982.832918403873, 983.6852207293668, 986.3145114145672, 987.5309228116658, 725.4015437264226, 729.6133049483782, 729.7117638532803, 730.8720973829612, 731.6890321613294, 14489.347979340955, 14559.417623295056, 14566.344514496766, 14568.490102846456, 14586.4894728684, 10477.26659133861, 12510.3744812759, 12656.0, 12903.419346129353, 12968.80546791799, 9809.656662016867, 9810.46042467664, 9973.601055957753, 10259.640912568098, 10471.267011309212, 3444.207832198583, 3483.7213022958103, 3524.559430071241, 3538.469229615578, 3572.7499075064757, 68561.0, 69594.60810783807, 70258.2974170257, 70363.64818175927, 71164.28835711628, 9168.193367711232, 9172.541372931326, 9243.630254789867, 9341.78993677483, 9471.147596716191, 19580.70628940567, 20296.797032029786, 20317.0, 20335.186592536134, 20357.796422035888, 6151.323354431009, 7043.696916070543, 7306.305900939402, 7419.2158978953785, 7499.250074992567, 3729.701623870084, 4088.5911408858874, 4096.91806163875, 4098.938515922264, 4123.340265557496, 3554.0759402555004, 3620.981895090508, 3632.654897784706, 3634.473001414833, 3634.763740356921, 569.857535616096, 601.2334273800851, 649.2339039932924, 652.1652285075112, 657.5824351536809, 515.209153948687, 542.5090293284505, 564.3340857787849, 590.1295589006181, 599.9550033747487, 8052.759111688489, 8084.8383032339025, 8210.137935516805, 8279.95860020696, 8346.8330633387, 509.0582422518385, 551.5752870289855, 567.3617180671745, 609.856354912483, 629.0187307799847, 3860.613938606173, 3865.4974853268895, 3897.2400381925254, 3973.463582416337, 3993.4209539616595, 99255.50372248238, 101028.0, 104574.0, 105182.0, 107597.46201268943, 82474.17525824664, 83530.0, 85730.0, 85987.71018434729, 87855.56072219598, 60160.79678406495, 61340.0, 65949.0, 78070.82893756485, 78727.21272787199, 7977.546607270171, 8143.5928203590765, 8248.13394593559, 8290.668373265244, 8395.622197001028, 36721.44917826181, 41948.79025604852, 43050.13899722051, 44556.33165502455, 45489.317660235785, 66410.00384994326, 69368.30631693618, 70484.59030819457, 70510.64744676244, 71595.0, 11582.88417115818, 11624.88375116238, 11697.0, 11719.707007324885, 12232.877671223174, 11925.463354149259, 12145.757084858431, 12186.51253949832, 12200.51197952072, 12522.248665080124, 8725.269517829782, 10364.585416583252, 10960.835587466036, 11466.197366184288, 11541.365224912375, 9269.44383337002, 11408.372539510407, 11648.475818588353, 11781.004873867525, 11865.822012669989, 9389.624415023323, 10956.0, 11075.889241107487, 11174.66476005721, 11449.59926402572, 9099.0, 9210.677626283048, 9366.718998429786, 9449.527523623929, 9563.426194428357, 9892.901070989486, 9924.702258932244, 9935.801283974424, 9964.651237206663, 10038.548265327932], "value": 6824.88721460442, "unit": "score"}], "name": "dromaeo_css", "value": 7202.441712766111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 108.0, 111.0, 113.0, 111.0, 112.0, 113.0, 106.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 162.0, 203.0, 146.0, 142.0, 115.0, 149.0, 159.0, 118.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 184.0, 186.0, 185.0, 181.0, 187.0, 185.0, 177.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 76.0, 151.0, 55.0, 55.0, 64.0, 69.0, 150.0, 71.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 139.0, 78.0, 80.0, 85.0, 125.0, 79.0, 75.0, 122.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 90.0, 86.0, 84.0, 87.0, 83.0, 87.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 91.0, 93.0, 93.0, 92.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0, 86.0, 94.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 59.0, 61.0, 59.0, 77.0, 60.0, 58.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 74.0, 78.0, 69.0, 68.0, 65.0, 67.0, 67.0, 67.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 78.0, 82.0, 82.0, 83.0, 79.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 149.0, 124.0, 142.0, 147.0, 149.0, 156.0, 175.0, 133.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 180.0, 172.0, 171.0, 168.0, 170.0, 168.0, 167.0, 169.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 71.0, 82.0, 96.0, 97.0, 80.0, 68.0, 71.0], "value": 76.9, "unit": "score"}], "name": "kraken", "value": 1489.8, "alertThreshold": 2.0}]} 07:47:40 INFO - Return code: 0 07:47:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:47:40 ERROR - # TBPL SUCCESS # 07:47:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:40 INFO - 2016-04-25 07:47:40.221 screenresolution[1682:9679] starting screenresolution argv=screenresolution get 07:47:40 INFO - 2016-04-25 07:47:40.224 screenresolution[1682:9679] Display 0: 1600x1200x32@60 07:47:40 INFO - 2016-04-25 07:47:40.230 screenresolution[1683:9682] starting screenresolution argv=screenresolution list 07:47:40 INFO - Available Modes on Display 0 07:47:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:40 INFO - Intel Iris: 07:47:40 INFO - Chipset Model: Intel Iris 07:47:40 INFO - Type: GPU 07:47:40 INFO - Bus: Built-In 07:47:40 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:40 INFO - Vendor: Intel (0x8086) 07:47:40 INFO - Device ID: 0x0a2e 07:47:40 INFO - Revision ID: 0x0009 07:47:40 INFO - Displays: 07:47:40 INFO - Display: 07:47:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:40 INFO - Display Serial Number: 1600x1200 60 07:47:40 INFO - Main Display: Yes 07:47:40 INFO - Mirror: Off 07:47:40 INFO - Online: Yes 07:47:40 INFO - Rotation: Supported 07:47:40 INFO - Return code: 0 07:47:40 INFO - Running post-action listener: _resource_record_post_action 07:47:40 INFO - Running post-run listener: _resource_record_post_run 07:47:41 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37586432; Write bytes: 694639616; Read time: 394; Write time: 1755 07:47:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384719360; Write bytes: 379090432; Read time: 28460; Write time: 676 07:47:41 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35788288; Write bytes: 295708160; Read time: 376; Write time: 1036 07:47:41 INFO - Running post-run listener: _upload_blobber_files 07:47:41 INFO - Blob upload gear active. 07:47:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:47:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:47:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:42 INFO - (blobuploader) - INFO - Done attempting. 07:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:43 INFO - (blobuploader) - INFO - Done attempting. 07:47:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:43 INFO - Return code: 0 07:47:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b22a6b6752c7013c101c6ec3cfd6a6d9e39b3d0399f0518b8892646982a3621912ed753ebe8da5bed7e961e3772a76d6553cfc96d9725771f7dbc1bb9d579e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f458df7fbffdb34cfd04828d9092d11563f0211bf76bec9432278e189cc00a9af9aaa27b99a07d5c416962e4aa6314be83950819091475206c6e09bd0d4309a0"} 07:47:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:43 INFO - Contents: 07:47:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b22a6b6752c7013c101c6ec3cfd6a6d9e39b3d0399f0518b8892646982a3621912ed753ebe8da5bed7e961e3772a76d6553cfc96d9725771f7dbc1bb9d579e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f458df7fbffdb34cfd04828d9092d11563f0211bf76bec9432278e189cc00a9af9aaa27b99a07d5c416962e4aa6314be83950819091475206c6e09bd0d4309a0"} 07:47:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:43 INFO - Copying logs to upload dir... 07:47:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.384330 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-25 07:47:43.742308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:47:43.746287) ========= 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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b22a6b6752c7013c101c6ec3cfd6a6d9e39b3d0399f0518b8892646982a3621912ed753ebe8da5bed7e961e3772a76d6553cfc96d9725771f7dbc1bb9d579e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f458df7fbffdb34cfd04828d9092d11563f0211bf76bec9432278e189cc00a9af9aaa27b99a07d5c416962e4aa6314be83950819091475206c6e09bd0d4309a0"} build_url:https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012717 build_url: 'https://queue.taskcluster.net/v1/task/DRUoTmnRTR6OOtETwMcfYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b22a6b6752c7013c101c6ec3cfd6a6d9e39b3d0399f0518b8892646982a3621912ed753ebe8da5bed7e961e3772a76d6553cfc96d9725771f7dbc1bb9d579e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f458df7fbffdb34cfd04828d9092d11563f0211bf76bec9432278e189cc00a9af9aaa27b99a07d5c416962e4aa6314be83950819091475206c6e09bd0d4309a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:47:43.776119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:47:43.776401) ========= 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.FsRLwSQ1Uq/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.4n4n0bBgYi/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005662 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:47:43.826096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:47:43.826423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:47:43.827614) ========= ========= Total master_lag: 0.16 =========