builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0043 starttime: 1460713825.75 results: success (0) buildid: 20160415004038 builduid: 67d6d06e83554bda87b9211ef3b633d1 revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.752087) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.752517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.752792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.772964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.773227) ========= 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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-15 02:50:25-- 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% 12.4M=0.001s 2016-04-15 02:50:25 (12.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.871493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.871817) ========= 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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.026444 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:25.919376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-15 02:50:25.919685) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4633816cde73beee6ed194e571c3a2ba14b15069 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4633816cde73beee6ed194e571c3a2ba14b15069 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-15 02:50:26,005 truncating revision to first 12 chars 2016-04-15 02:50:26,005 Setting DEBUG logging. 2016-04-15 02:50:26,005 attempt 1/10 2016-04-15 02:50:26,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4633816cde73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:50:27,909 unpacking tar archive at: mozilla-aurora-4633816cde73/testing/mozharness/ program finished with exit code 0 elapsedTime=2.157077 ========= master_lag: 4.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-15 02:50:32.751526) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:32.751855) ========= script_repo_revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:32.752259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:32.752522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:50:33.518248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-15 02:50:33.518697) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:50:33 INFO - MultiFileLogger online at 20160415 02:50:33 in /builds/slave/test 02:50:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:33 INFO - {'append_to_log': False, 02:50:33 INFO - 'base_work_dir': '/builds/slave/test', 02:50:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:33 INFO - 'branch': 'Mozilla-Aurora', 02:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:33 INFO - 'config_files': ('talos/mac_config.py',), 02:50:33 INFO - 'default_actions': ('clobber', 02:50:33 INFO - 'read-buildbot-config', 02:50:33 INFO - 'download-and-extract', 02:50:33 INFO - 'populate-webroot', 02:50:33 INFO - 'create-virtualenv', 02:50:33 INFO - 'install', 02:50:33 INFO - 'run-tests'), 02:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:33 INFO - 'download_minidump_stackwalk': True, 02:50:33 INFO - 'download_symbols': 'ondemand', 02:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:33 INFO - 'installer_path': 'installer.exe', 02:50:33 INFO - 'log_level': 'info', 02:50:33 INFO - 'log_name': 'talos', 02:50:33 INFO - 'log_to_console': True, 02:50:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:33 INFO - 'opt_config_files': (), 02:50:33 INFO - 'pip_index': False, 02:50:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:33 INFO - 'cmd': ('bash', 02:50:33 INFO - '-c', 02:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:33 INFO - 'enabled': True, 02:50:33 INFO - 'halt_on_failure': False, 02:50:33 INFO - 'name': 'check_screen_resolution'},), 02:50:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:33 INFO - 'cmd': ('bash', 02:50:33 INFO - '-c', 02:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:33 INFO - 'enabled': True, 02:50:33 INFO - 'halt_on_failure': False, 02:50:33 INFO - 'name': 'check_screen_resolution'},), 02:50:33 INFO - 'run_cmd_checks_enabled': True, 02:50:33 INFO - 'sps_profile': False, 02:50:33 INFO - 'sps_profile_interval': 0, 02:50:33 INFO - 'suite': 'dromaeojs', 02:50:33 INFO - 'system_bits': '32', 02:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:33 INFO - 'title': 't-yosemite-r7-0043', 02:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:33 INFO - 'use_talos_json': True, 02:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:33 INFO - 'work_dir': 'build'} 02:50:33 INFO - ##### 02:50:33 INFO - ##### Running clobber step. 02:50:33 INFO - ##### 02:50:33 INFO - Running pre-action listener: _resource_record_pre_action 02:50:33 INFO - Running main action method: clobber 02:50:33 INFO - rmtree: /builds/slave/test/build 02:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:35 INFO - Running post-action listener: _resource_record_post_action 02:50:35 INFO - ##### 02:50:35 INFO - ##### Running read-buildbot-config step. 02:50:35 INFO - ##### 02:50:35 INFO - Running pre-action listener: _resource_record_pre_action 02:50:35 INFO - Running main action method: read_buildbot_config 02:50:35 INFO - Using buildbot properties: 02:50:35 INFO - { 02:50:35 INFO - "project": "", 02:50:35 INFO - "product": "firefox", 02:50:35 INFO - "script_repo_revision": "production", 02:50:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:50:35 INFO - "repository": "", 02:50:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:50:35 INFO - "buildid": "20160415004038", 02:50:35 INFO - "stage_platform": "macosx64", 02:50:35 INFO - "basedir": "/builds/slave/test", 02:50:35 INFO - "nightly_build": "True", 02:50:35 INFO - "buildnumber": 278, 02:50:35 INFO - "slavename": "t-yosemite-r7-0043", 02:50:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:50:35 INFO - "platform": "yosemite_r7", 02:50:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:50:35 INFO - "branch": "mozilla-aurora", 02:50:35 INFO - "repo_path": "releases/mozilla-aurora", 02:50:35 INFO - "revision": "4633816cde73beee6ed194e571c3a2ba14b15069", 02:50:35 INFO - "pgo_build": "False", 02:50:35 INFO - "builduid": "67d6d06e83554bda87b9211ef3b633d1", 02:50:35 INFO - "slavebuilddir": "test" 02:50:35 INFO - } 02:50:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:50:35 INFO - Running post-action listener: _resource_record_post_action 02:50:35 INFO - ##### 02:50:35 INFO - ##### Running download-and-extract step. 02:50:35 INFO - ##### 02:50:35 INFO - Running pre-action listener: _resource_record_pre_action 02:50:35 INFO - Running main action method: download_and_extract 02:50:35 INFO - mkdir: /builds/slave/test/build/tests 02:50:35 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')]} 02:50:35 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:50:40 INFO - Downloaded 1277 bytes. 02:50:40 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:50:40 INFO - Using the following test package requirements: 02:50:40 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:40 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:50:40 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:50:40 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'jsshell-mac.zip'], 02:50:40 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:50:40 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:40 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:50:40 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:50:40 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:50:40 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:50:40 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:50:40 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:50:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:50:40 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')]} 02:50:40 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:50:41 INFO - Downloaded 17911146 bytes. 02:50:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:50:44 INFO - Return code: 0 02:50:44 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:50: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')]} 02:50:44 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:50:49 INFO - Downloaded 17911146 bytes. 02:50:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:50:52 INFO - Return code: 0 02:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:52 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:50:53 INFO - Downloaded 10845168 bytes. 02:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:50:53 INFO - Return code: 0 02:50:53 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')]} 02:50:53 INFO - https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:50:56 INFO - Downloaded 115310490 bytes. 02:50:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:56 INFO - mkdir: /builds/slave/test/properties 02:50:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:50:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:50:56 INFO - Contents: 02:50:56 INFO - build_url:https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:50:58 INFO - Running post-action listener: _resource_record_post_action 02:50:58 INFO - Running post-action listener: set_extra_try_arguments 02:50:58 INFO - ##### 02:50:58 INFO - ##### Running populate-webroot step. 02:50:58 INFO - ##### 02:50:58 INFO - Running pre-action listener: _resource_record_pre_action 02:50:58 INFO - Running main action method: populate_webroot 02:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:50:58 INFO - '--tppagecycles', 02:50:58 INFO - '7'], 02:50:58 INFO - 'tests': ['tsvgm']}}, 02:50:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:50:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:50:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:50:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'tests': ['damp', 'tps']}, 02:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['damp', 'tps']}, 02:50:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:50:58 INFO - 'other': {'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'other_l64': {'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'other_nol64': {'tests': ['a11yr', 02:50:58 INFO - 'ts_paint', 02:50:58 INFO - 'tpaint', 02:50:58 INFO - 'sessionrestore', 02:50:58 INFO - 'sessionrestore_no_auto_restore', 02:50:58 INFO - 'tabpaint']}, 02:50:58 INFO - 'svgr': {'tests': ['tsvgx', 02:50:58 INFO - 'tsvgr_opacity', 02:50:58 INFO - 'tart', 02:50:58 INFO - 'tscrollx', 02:50:58 INFO - 'cart']}, 02:50:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['tsvgx', 02:50:58 INFO - 'tsvgr_opacity', 02:50:58 INFO - 'tart', 02:50:58 INFO - 'tscrollx', 02:50:58 INFO - 'cart']}, 02:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'tests': ['tp5o']}, 02:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'talos_options': ['--e10s'], 02:50:58 INFO - 'tests': ['tp5o']}, 02:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'talos_options': ['--xperf_path', 02:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:58 INFO - 'tests': ['tp5n']}, 02:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:58 INFO - 'talos_options': ['--e10s', 02:50:58 INFO - '--xperf_path', 02:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:58 INFO - 'tests': ['tp5n']}}, 02:50:58 INFO - 'talos.zip': {'path': '', 02:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:50:58 INFO - Running post-action listener: _resource_record_post_action 02:50:58 INFO - ##### 02:50:58 INFO - ##### Running create-virtualenv step. 02:50:58 INFO - ##### 02:50:58 INFO - Running pre-action listener: _resource_record_pre_action 02:50:58 INFO - Running main action method: create_virtualenv 02:50:58 INFO - Creating virtualenv /builds/slave/test/build/venv 02:50:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:50:58 INFO - Using real prefix '/tools/python27' 02:50:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:50:59 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:02 INFO - Installing pip.................done. 02:51:02 INFO - Return code: 0 02:51:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:02 INFO - 'HOME': '/Users/cltbld', 02:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:02 INFO - 'LOGNAME': 'cltbld', 02:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:02 INFO - 'MOZ_NO_REMOTE': '1', 02:51:02 INFO - 'NO_EM_RESTART': '1', 02:51:02 INFO - 'PAGER': '/bin/cat', 02:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:02 INFO - 'PWD': '/builds/slave/test', 02:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:02 INFO - 'SHELL': '/bin/bash', 02:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:02 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:02 INFO - 'USER': 'cltbld', 02:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:02 INFO - 'XPC_FLAGS': '0x0', 02:51:02 INFO - 'XPC_SERVICE_NAME': '0', 02:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:51:02 INFO - Cleaning up... 02:51:02 INFO - Return code: 0 02:51:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:02 INFO - 'HOME': '/Users/cltbld', 02:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:02 INFO - 'LOGNAME': 'cltbld', 02:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:02 INFO - 'MOZ_NO_REMOTE': '1', 02:51:02 INFO - 'NO_EM_RESTART': '1', 02:51:02 INFO - 'PAGER': '/bin/cat', 02:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:02 INFO - 'PWD': '/builds/slave/test', 02:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:02 INFO - 'SHELL': '/bin/bash', 02:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:02 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:02 INFO - 'USER': 'cltbld', 02:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:02 INFO - 'XPC_FLAGS': '0x0', 02:51:02 INFO - 'XPC_SERVICE_NAME': '0', 02:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:02 INFO - Downloading/unpacking psutil>=0.7.1 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:05 INFO - Installing collected packages: psutil 02:51:05 INFO - Running setup.py install for psutil 02:51:05 INFO - building 'psutil._psutil_osx' extension 02:51:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:51:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:51:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:51:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:51:06 INFO - building 'psutil._psutil_posix' extension 02:51:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:51:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:51:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:51:06 INFO - ^ 02:51:06 INFO - 1 warning generated. 02:51:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:06 INFO - Successfully installed psutil 02:51:06 INFO - Cleaning up... 02:51:06 INFO - Return code: 0 02:51:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51: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')]} 02:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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')]} 02:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51: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', '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 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:51: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 mozsystemmonitor==0.0.0 02:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:06 INFO - 'HOME': '/Users/cltbld', 02:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:06 INFO - 'LOGNAME': 'cltbld', 02:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:06 INFO - 'MOZ_NO_REMOTE': '1', 02:51:06 INFO - 'NO_EM_RESTART': '1', 02:51:06 INFO - 'PAGER': '/bin/cat', 02:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:06 INFO - 'PWD': '/builds/slave/test', 02:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:06 INFO - 'SHELL': '/bin/bash', 02:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:06 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:06 INFO - 'USER': 'cltbld', 02:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:06 INFO - 'XPC_FLAGS': '0x0', 02:51:06 INFO - 'XPC_SERVICE_NAME': '0', 02:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51: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 02:51:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:51:09 INFO - Installing collected packages: mozsystemmonitor 02:51:09 INFO - Running setup.py install for mozsystemmonitor 02:51:09 INFO - Successfully installed mozsystemmonitor 02:51:09 INFO - Cleaning up... 02:51:09 INFO - Return code: 0 02:51:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:09 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')]} 02:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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')]} 02:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:09 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 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:09 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 02:51:09 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 02:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:09 INFO - 'HOME': '/Users/cltbld', 02:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:09 INFO - 'LOGNAME': 'cltbld', 02:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:09 INFO - 'MOZ_NO_REMOTE': '1', 02:51:09 INFO - 'NO_EM_RESTART': '1', 02:51:09 INFO - 'PAGER': '/bin/cat', 02:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:09 INFO - 'PWD': '/builds/slave/test', 02:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:09 INFO - 'SHELL': '/bin/bash', 02:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:09 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:09 INFO - 'USER': 'cltbld', 02:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:09 INFO - 'XPC_FLAGS': '0x0', 02:51:09 INFO - 'XPC_SERVICE_NAME': '0', 02:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:12 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 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 02:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:13 INFO - Downloading docopt-0.6.1.tar.gz 02:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:13 INFO - Running setup.py install for blobuploader 02:51:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:13 INFO - Running setup.py install for requests 02:51:14 INFO - Running setup.py install for docopt 02:51:14 INFO - Successfully installed blobuploader requests docopt 02:51:14 INFO - Cleaning up... 02:51:14 INFO - Return code: 0 02:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:14 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')]} 02:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:14 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')]} 02:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:14 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 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:14 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 02:51:14 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 02:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:14 INFO - 'HOME': '/Users/cltbld', 02:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:14 INFO - 'LOGNAME': 'cltbld', 02:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:14 INFO - 'MOZ_NO_REMOTE': '1', 02:51:14 INFO - 'NO_EM_RESTART': '1', 02:51:14 INFO - 'PAGER': '/bin/cat', 02:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:14 INFO - 'PWD': '/builds/slave/test', 02:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:14 INFO - 'SHELL': '/bin/bash', 02:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:14 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:14 INFO - 'USER': 'cltbld', 02:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:14 INFO - 'XPC_FLAGS': '0x0', 02:51:14 INFO - 'XPC_SERVICE_NAME': '0', 02:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:14 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-IjtRoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:14 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-TjalLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-kS1vLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-1jKF2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-EnKvTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-0msIuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-FeXErk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-wtz7uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-UCCAA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-AITRsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-DBt4u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:15 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-d1mKOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:16 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-QC84rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:16 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-YBXy9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:16 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Q84fQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:16 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-G0_f8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:16 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Xzw_He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:16 INFO - Running setup.py install for manifestparser 02:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:16 INFO - Running setup.py install for mozcrash 02:51:16 INFO - Running setup.py install for mozdebug 02:51:16 INFO - Running setup.py install for mozdevice 02:51:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Running setup.py install for mozfile 02:51:17 INFO - Running setup.py install for mozhttpd 02:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Running setup.py install for mozinfo 02:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Running setup.py install for mozInstall 02:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:17 INFO - Running setup.py install for mozleak 02:51:17 INFO - Running setup.py install for mozlog 02:51:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for moznetwork 02:51:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozprocess 02:51:18 INFO - Running setup.py install for mozprofile 02:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozrunner 02:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:18 INFO - Running setup.py install for mozscreenshot 02:51:18 INFO - Running setup.py install for moztest 02:51:18 INFO - Running setup.py install for mozversion 02:51:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:19 INFO - Cleaning up... 02:51:19 INFO - Return code: 0 02:51:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:19 INFO - 'HOME': '/Users/cltbld', 02:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:19 INFO - 'LOGNAME': 'cltbld', 02:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:19 INFO - 'MOZ_NO_REMOTE': '1', 02:51:19 INFO - 'NO_EM_RESTART': '1', 02:51:19 INFO - 'PAGER': '/bin/cat', 02:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:19 INFO - 'PWD': '/builds/slave/test', 02:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:19 INFO - 'SHELL': '/bin/bash', 02:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:19 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:19 INFO - 'USER': 'cltbld', 02:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:19 INFO - 'XPC_FLAGS': '0x0', 02:51:19 INFO - 'XPC_SERVICE_NAME': '0', 02:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-kl_z2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-_nNNEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-fwgCkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-BIDCfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-dWLnUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-xJuDAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:19 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)) 02:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-M_jan1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rdF5ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-aKrE5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-IMZo13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Db9sQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-MjRGfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-EnwPiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-2BnNOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rl_nA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:20 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)) 02:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-u5oFxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:21 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-noWeVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:23 INFO - Downloading blessings-1.6.tar.gz 02:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:23 INFO - Installing collected packages: blessings 02:51:23 INFO - Running setup.py install for blessings 02:51:23 INFO - Successfully installed blessings 02:51:23 INFO - Cleaning up... 02:51:23 INFO - Return code: 0 02:51:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:24 INFO - Reading from file tmpfile_stdout 02:51:24 INFO - Current package versions: 02:51:24 INFO - blessings == 1.6 02:51:24 INFO - blobuploader == 1.2.4 02:51:24 INFO - docopt == 0.6.1 02:51:24 INFO - manifestparser == 1.1 02:51:24 INFO - mozInstall == 1.12 02:51:24 INFO - mozcrash == 0.17 02:51:24 INFO - mozdebug == 0.1 02:51:24 INFO - mozdevice == 0.48 02:51:24 INFO - mozfile == 1.2 02:51:24 INFO - mozhttpd == 0.7 02:51:24 INFO - mozinfo == 0.9 02:51:24 INFO - mozleak == 0.1 02:51:24 INFO - mozlog == 3.1 02:51:24 INFO - moznetwork == 0.27 02:51:24 INFO - mozprocess == 0.22 02:51:24 INFO - mozprofile == 0.28 02:51:24 INFO - mozrunner == 6.11 02:51:24 INFO - mozscreenshot == 0.1 02:51:24 INFO - mozsystemmonitor == 0.0 02:51:24 INFO - moztest == 0.7 02:51:24 INFO - mozversion == 1.4 02:51:24 INFO - psutil == 3.1.1 02:51:24 INFO - requests == 1.2.3 02:51:24 INFO - wsgiref == 0.1.2 02:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:24 INFO - 'HOME': '/Users/cltbld', 02:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:24 INFO - 'LOGNAME': 'cltbld', 02:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:24 INFO - 'MOZ_NO_REMOTE': '1', 02:51:24 INFO - 'NO_EM_RESTART': '1', 02:51:24 INFO - 'PAGER': '/bin/cat', 02:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:24 INFO - 'PWD': '/builds/slave/test', 02:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:24 INFO - 'SHELL': '/bin/bash', 02:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:24 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:24 INFO - 'USER': 'cltbld', 02:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:24 INFO - 'XPC_FLAGS': '0x0', 02:51:24 INFO - 'XPC_SERVICE_NAME': '0', 02:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 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)) 02:51:24 INFO - Cleaning up... 02:51:24 INFO - Return code: 0 02:51:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:24 INFO - 'HOME': '/Users/cltbld', 02:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:24 INFO - 'LOGNAME': 'cltbld', 02:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:24 INFO - 'MOZ_NO_REMOTE': '1', 02:51:24 INFO - 'NO_EM_RESTART': '1', 02:51:24 INFO - 'PAGER': '/bin/cat', 02:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:24 INFO - 'PWD': '/builds/slave/test', 02:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:24 INFO - 'SHELL': '/bin/bash', 02:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:24 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:24 INFO - 'USER': 'cltbld', 02:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:24 INFO - 'XPC_FLAGS': '0x0', 02:51:24 INFO - 'XPC_SERVICE_NAME': '0', 02:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:25 INFO - Downloading/unpacking jsonschema 02:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:27 INFO - Downloading/unpacking functools32 (from jsonschema) 02:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:28 INFO - warning: no files found matching '*.txt' 02:51:28 INFO - no previously-included directories found matching 'build' 02:51:28 INFO - no previously-included directories found matching 'dist' 02:51:28 INFO - no previously-included directories found matching '.git*' 02:51:28 INFO - Installing collected packages: jsonschema, functools32 02:51:28 INFO - Running setup.py install for functools32 02:51:28 INFO - warning: no files found matching '*.txt' 02:51:28 INFO - no previously-included directories found matching 'build' 02:51:28 INFO - no previously-included directories found matching 'dist' 02:51:28 INFO - no previously-included directories found matching '.git*' 02:51:28 INFO - Successfully installed jsonschema functools32 02:51:28 INFO - Cleaning up... 02:51:28 INFO - Return code: 0 02:51:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104685a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbac2569c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, '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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 02:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:28 INFO - 'HOME': '/Users/cltbld', 02:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:28 INFO - 'LOGNAME': 'cltbld', 02:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:28 INFO - 'MOZ_NO_REMOTE': '1', 02:51:28 INFO - 'NO_EM_RESTART': '1', 02:51:28 INFO - 'PAGER': '/bin/cat', 02:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:28 INFO - 'PWD': '/builds/slave/test', 02:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:28 INFO - 'SHELL': '/bin/bash', 02:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:51:28 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:28 INFO - 'USER': 'cltbld', 02:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:28 INFO - 'XPC_FLAGS': '0x0', 02:51:28 INFO - 'XPC_SERVICE_NAME': '0', 02:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:28 INFO - Downloading/unpacking flake8 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:32 INFO - no previously-included directories found matching 'docs/_build' 02:51:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:32 INFO - Running setup.py install for pep8 02:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:32 INFO - no previously-included directories found matching 'docs/_build' 02:51:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:32 INFO - Cleaning up... 02:51:32 INFO - Return code: 0 02:51:32 INFO - Running post-action listener: _resource_record_post_action 02:51:32 INFO - Running post-action listener: _start_resource_monitoring 02:51:32 INFO - Starting resource monitoring. 02:51:32 INFO - ##### 02:51:32 INFO - ##### Running install step. 02:51:32 INFO - ##### 02:51:32 INFO - Running pre-action listener: _resource_record_pre_action 02:51:32 INFO - Running main action method: install 02:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:33 INFO - Reading from file tmpfile_stdout 02:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:33 INFO - Reading from file tmpfile_stdout 02:51:33 INFO - Output received: 02:51:33 INFO - Usage: mozinstall [options] installer 02:51:33 INFO - Options: 02:51:33 INFO - -h, --help show this help message and exit 02:51:33 INFO - -d DEST, --destination=DEST 02:51:33 INFO - Directory to install application into. [default: 02:51:33 INFO - "/builds/slave/test"] 02:51:33 INFO - --app=APP Application being installed. [default: firefox] 02:51:33 INFO - mkdir: /builds/slave/test/build/application 02:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:52:04 INFO - Reading from file tmpfile_stdout 02:52:04 INFO - Output received: 02:52:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:52:04 INFO - Running post-action listener: _resource_record_post_action 02:52:04 INFO - ##### 02:52:04 INFO - ##### Running run-tests step. 02:52:04 INFO - ##### 02:52:04 INFO - Running pre-action listener: _resource_record_pre_action 02:52:04 INFO - Running main action method: run_tests 02:52:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:52:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:52:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:52:04 INFO - 2016-04-15 02:52:04.722 screenresolution[1641:7686] starting screenresolution argv=screenresolution get 02:52:04 INFO - 2016-04-15 02:52:04.725 screenresolution[1641:7686] Display 0: 1600x1200x32@60 02:52:04 INFO - 2016-04-15 02:52:04.730 screenresolution[1642:7689] starting screenresolution argv=screenresolution list 02:52:04 INFO - Available Modes on Display 0 02:52:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:52:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:52:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:52:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:52:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:52:04 INFO - Intel Iris: 02:52:04 INFO - Chipset Model: Intel Iris 02:52:04 INFO - Type: GPU 02:52:04 INFO - Bus: Built-In 02:52:04 INFO - VRAM (Dynamic, Max): 1536 MB 02:52:04 INFO - Vendor: Intel (0x8086) 02:52:04 INFO - Device ID: 0x0a2e 02:52:04 INFO - Revision ID: 0x0009 02:52:04 INFO - Displays: 02:52:04 INFO - Display: 02:52:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:52:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:52:04 INFO - Display Serial Number: 1600x1200 60 02:52:04 INFO - Main Display: Yes 02:52:04 INFO - Mirror: Off 02:52:04 INFO - Online: Yes 02:52:04 INFO - Rotation: Supported 02:52:04 INFO - Return code: 0 02:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:04 INFO - Python 2.7.3 02:52:04 INFO - Return code: 0 02:52:04 INFO - grabbing minidump binary from tooltool 02:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:04 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 0x104529d30>, '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 0x10438ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104520b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:04 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 02:52:04 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 02:52:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:05 INFO - Return code: 0 02:52:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:52:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:52:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:06 INFO - Return code: 0 02:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 02:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0043 --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 02:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xE6K5z2Xy3/Render', 02:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:06 INFO - 'HOME': '/Users/cltbld', 02:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:06 INFO - 'LOGNAME': 'cltbld', 02:52:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:06 INFO - 'MOZ_NO_REMOTE': '1', 02:52:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:06 INFO - 'NO_EM_RESTART': '1', 02:52:06 INFO - 'PAGER': '/bin/cat', 02:52:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:06 INFO - 'PWD': '/builds/slave/test', 02:52:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:06 INFO - 'SHELL': '/bin/bash', 02:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jRJGi76Arf/Listeners', 02:52:06 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 02:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:06 INFO - 'USER': 'cltbld', 02:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:06 INFO - 'XPC_FLAGS': '0x0', 02:52:06 INFO - 'XPC_SERVICE_NAME': '0', 02:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 02:52:06 INFO - mozversion application_buildid: 20160415004038 02:52:06 INFO - mozversion application_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 02:52:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:06 INFO - mozversion application_name: Firefox 02:52:06 INFO - mozversion application_remotingname: firefox-dev 02:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:06 INFO - mozversion application_vendor: Mozilla 02:52:06 INFO - mozversion application_version: 47.0a2 02:52:06 INFO - mozversion platform_buildid: 20160415004038 02:52:06 INFO - mozversion platform_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 02:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:06 INFO - mozversion platform_version: 47.0a2 02:52:06 INFO - using testdate: 1460713926 02:52:06 INFO - actual date: 1460713926 02:52:06 INFO - starting webserver on 'localhost:49277' 02:52:06 INFO - SUITE-START | Running 2 tests 02:52:06 INFO - TEST-START | dromaeo_css 02:52:06 INFO - operating with platform_type : mac_ 02:52:06 INFO - Initialising browser for dromaeo_css test... 02:52:06 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpQGzvXR/profile http://localhost:49277/getInfo.html) 02:52:09 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:52:09 INFO - PROCESS | 1660 | colorDepth:24 02:52:09 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:52:09 INFO - PROCESS | 1660 | __metrics 02:52:09 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:52:09 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:09 INFO - TEST-INFO | 1660: exit 0 02:52:09 INFO - Browser initialized. 02:52:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:09 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpQGzvXR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:21 INFO - PROCESS | 1666 | RSS: Main: 207568896 02:52:21 INFO - PROCESS | 1666 | 02:53:13 INFO - PROCESS | 1666 | 1460713993113 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] 02:55:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 02:55:24 INFO - PROCESS | 1666 | RSS: Main: 328306688 02:55:24 INFO - PROCESS | 1666 | 02:58:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 02:58:27 INFO - PROCESS | 1666 | RSS: Main: 342818816 02:58:27 INFO - PROCESS | 1666 | 03:01:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 03:01:30 INFO - PROCESS | 1666 | RSS: Main: 339791872 03:01:30 INFO - PROCESS | 1666 | 03:04:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 03:04:32 INFO - PROCESS | 1666 | RSS: Main: 302530560 03:04:32 INFO - PROCESS | 1666 | 03:07:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 03:07:36 INFO - PROCESS | 1666 | RSS: Main: 303501312 03:07:36 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 03:10:39 INFO - PROCESS | 1666 | RSS: Main: 352858112 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | __start_tp_report 03:10:39 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 03:10:39 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 03:10:39 INFO - PROCESS | 1666 | |i|pagename|runs| 03:10:39 INFO - PROCESS | 1666 | |0;dojo.html;3478.947815782764;3537.204129070961;3551.680348768612;3583.6058033616305;3635.690966267867;5903.582757884602;5907.143464197688;5941.821745347635;5951.285845698522;5962.075878238875;5892.116182572616;5958.642481451116;5959.70201489926;5962.552808539355;5974.31295401029;5163.896722065557;5278.234655974891;5279.5512381447625;5348.893022139555;5374;5260.710660913648;5264.999650066475;5268.6575372600655;5271.209318602221;5275.155975043994;5263.947360526384;5298.311219541454;5319;5356.946430535703;5358.785648574052;5175.844724658266;5182.963407318513;5186.559142472895;5188.7146206958605;5212.087884620214;5143.459936706667;5153.613478989091;5314;5327.493888080626;5343.465653434625;4815.446223684286;5846.064629659277;5848.122781582754;5853.795117170878;5883.558733095035;6118.418750218722;6242.500599951993;6254.906176407358;6260.248770147566;6269.843253918689;6240.095186197976;6259.217597800275;6265.279492858334;6320.273168585625;6357.523185761086;6028.6985650717725;6038.818835434944;6052.394760524;6056.727447264883;6061.636301821904;6245.125682404467;6342.175517182736;6422.871542569216;6434.967825160844;6436;6192.256929168439;6197.876042479125;6213.596116252519;6220.595661282002;6222.875542489125;6202.968985155136;6210.782622608187;6211.3478084801345;6215.409536094064;6220.471259942956;6150.200473938359;6156.8917594832465;6171.537134714914;6231.594946328565;6237.875242495215;6174.676238879325;6211.596246243979;6226.221722284715;6229.408206220402;6231.719572619243;4972.875678108004;4976.104301225741;4978.90042199154;4995.975020124949;5011.022850544109;4447.733136011785;4494.258447356215;4509.391232183679;4545.204589196877;4578.381918440968;5923.940760592339;5930.11048342752;5945.881082378328;5962.956482615525;5984.31180414258;6268.09112678659;6278.089676996901;6286.842828929313;6288.874222515524;6289.0252010938375;5509.724513774296;5595.629070877661;5753;5875.177475153482;5948.524118070544;5489.231507588861;5497.917531237034;5515.641483303572;5519.448055194448;5526.58550608706;6479.773207937699;6497.545171837926;6520.217573891164;6520.608763474207;6534.738610455529;6209.906851397142;6278.843028924313;6298.275698294755;6334.1765570475545;6349.904751428639;6438.420542151229;6441.838954026187;6443.065755465525;6452.709628066842;6463.256725476443;6159.630422174684;6175.5677102602385;6212.316645169119;6212.316645169119;6226.159468471698;6240.219972503437;6290.49676025926;6291.087792270004;6291.1192433058495;6329.936700632935;6030.819075427744;6200.720967556381;6201.224846894138;6211.844703882259;6214.9689251553455;6042.425969532887;6131.988406491147;6185.072239164161;6212.378762123933;6233.438990490878;6099.146119543356;6130.9179418630665;6138.785142519991;6140.565599444613;6143.327652471189;6197.25632924052;6214.471769899609;6229.563930525001;6229.937700623117;6247.437730604267;5920.940790592039;6022.819315420545;6042.123892035718;6094.603850749687;6122.510199183966 03:10:39 INFO - PROCESS | 1666 | |1;ext.html;483.30645523673553;592.8458600763801;602.1118849696697;676.732690587218;678.6437120511732;41511.37732934008;42157.15685686284;42189.945251368656;42262.78868605661;42332;45107.548924510746;45566.08867822641;45753.542464575345;45945.31082033772;45967.310490342585;9723.076307750753;9920.603175872957;9925.305228633999;9946.701598952042;10029.448380339078;9758.365706229073;9903.405795652285;9929.553170107363;9934.205263578897;9954.054364835329;9998;10058.295919285652;10076.69769906904;10081.09270165685;10098.343607665514;9962.352447090916;10048.196144308438;10049.497525123714;10053;10056.648017319432;9885.654002109892;10005.449700266483;10010.349327293776;10015.849762253572;10015.899841001643;43981.34027989583;44278.89302767425;44324.335134973;44336.55663443357;44343.556564434264;3304.9173770655684;3325.384803811303;3394.032700680319;3538.5399898013093;3872.477215575889;29685.70314296851;30289.545656815164;30575.847120764254;30893.918712845167;31083;2835.716428357148;2841.8152820066834;2873.310405502685;2918.518444456662;2931.736143747073;509773;513459;514496;514497;516298;50264.49735502598;50840;68831.65584172147;69965.65017174983;70050.2994970054;49530.76173095629;49688.503114968385;49764.75117624461;49812.0037599246;49840.501594984315;17397.391091311743;17565.560860978578;17585.296588136585;17599.472015839547;17613.911930440267;13544.458221671022;13548.796768048487;13579.932100339434;13580.524681636292;13584.660383490294;15765.054096754231;16054.678906421806;16061.598460038358;16070.43753468623;16079.18614242503;5759.452851979056;6687.465002799764;6744.291849355845;6768.289329620319;6783.660816959133;922.4695799915075;991.4546999150439;1004.8795592913848;1066.4454483668449;1104.0394856474918;29924.551131733042;30534.694653053186;30608.387832243232;31265.531017034762;31321;1096.7313008313015;1207.088648070701;1221.8472690913636;1226.4603574427224;1229.3238718704677;15389.46136885226;15943.44197953066;16078.517644470685;16288.02271863692;16963.236654350585;645518;647219.5278047253;653467;654057;655832;68756;69484;69568.6521567389;69686;69765.65117174381;1335.5726167626267;1524.7255494010963;1574.157825563318;1580.2651766928434;1582.5647946814488;30424.239394015327;30435.2391190222;31082;32173.195670108435;32491.18772030718;54899;55510;55702;55755.16367254576;56033.75864965519;429640;433172;434498;434651.2674366206;515162;34638.78764243239;35163.945081647595;36018.27963440769;36038;36038.639613603526;45683.54316456793;45929.540704592524;46640.600781976595;47322.526774731814;47407.76296118497;34479;35380.823095884356;36167;36589.81705091458;38325.808370957966;37505.81247093747;37654;37833.243335133695;37921.4311785329;38601;33040.347982601255;38192.61807381891;38279.61720382872;38580.228395432496;38985.805070974464;33059.33881322408;33911.49214529918;33965.83017084899;34267.65732342644;34354.96935091951;25535.97856085736;25633.487330252916;25670.486590268465;25711.74288257168;25882.87058564695 03:10:39 INFO - PROCESS | 1666 | |2;jquery.html;382.76077451592755;387.4517557655917;388.23130202199656;394.76906009984157;394.87561418153297;19712.99999999998;21599.352019439404;21908.685478871277;21928.45178870527;21930.232441864537;12173.573924912629;12515.43680534376;19101.23595056196;19543.804561954377;20475.488112797186;5422.728863556817;5555.944440555583;5591.524720398771;5614.719264036782;5616.63491873029;4175.269327867626;4362.0621566363225;5903.380145084769;6112.113743507189;6117.388261173892;6066.332703402622;6101.908471372933;6105.084237364386;6120.234970628671;6121;6397.200349956255;6580.4406625436895;6631.403173714365;6637.800865974028;6640.302768209341;4013.7993100345157;5655.0103731847175;5887.8233652990475;5891.23413956183;5921.674307913063;12352;14192.716145677132;14254.714905701932;25451.49097018068;26412.81142348599;2317.6407656813053;2459.594166962449;2540.1744433059143;2649.377396311865;2710.3246899099095;10576;11595.826062608983;13628.386722597506;15600.141992190425;15870.761938570931;1792.4622613216113;1810.6650269700017;1832.065646520271;1852.9814701852945;1891.810818918111;107194.46402767937;108190.91809081887;108440;111007;112274;11472.541098355972;11669.824952625717;11669.941650291865;11686.590969316034;11840;14729.96890217696;14749.262536873328;14750.704985900222;14791.852081479048;14797.260136993107;8964.462132272085;8973.910260897437;9030.729078127666;9108.134727200906;9184.357095003286;9332.813343733087;9336;9338.346315757832;9368.859467107999;9434.528273586293;4571.588557029883;4609.815607375667;4640.164770341304;4644.976775116171;4690.343351930733;1780.3352127906169;1800.873938824296;1866.7106598477258;1937.7093435984716;1938.7867334593184;900.9189172974463;927.2813569483704;980.3970558106855;1009.106940357774;1049.234059136819;21728;22487.550248995256;22571.210007649654;23257.090941765153;23281.18515851937;983.4492684096929;1036.383351905615;1055.466989170464;1065.5311662868314;1077.1813421799488;9629.711108666752;11695.356755378365;11993.880061199276;12065.819012714815;12081.45633446497;535039;556602;669527;673074;677753;112262;114843;116173;117260.41369793097;120443;1060.16247164739;1084.7125511739396;1103.3931337764197;1105.209775010871;1112.0603090388609;18931.716024259924;19519.512012199808;19811.41508679331;20046.077191789573;20087;43887;48723.53829385124;53920.38238852841;54681.45318546764;55241.72379138239;74063.6296818534;77704.61147694226;77891;78844;80391;7954.482958607672;8325.666973321;8441.409101362846;8472.44929079608;8569.742907712778;9862.605495780088;12062.165391133252;13417.731645367234;13821.378037988114;14152.929235353757;11295.943520282675;11683.357415342238;11769.705757356134;11792.882071179178;11855.76288474243;11344.489497972447;11476;11670.649880503599;11744.647660570197;11918.702032448911;11625.6512304631;11777.941110294394;11825.290482571074;11973;12188.634340969431;8059.758207253792;8281;8463.322934165375;8562.914370856211;8721.56392180401;10434.165266778487;10468.842967355344;11664.358460284426;12004.459799308877;12063.457144428347 03:10:39 INFO - PROCESS | 1666 | |3;mootools.html;1524.7255494011088;1668.2659629762904;1696.915154242288;2051.917923283069;2102;8472.661093556258;9097;9252;9270.072992700734;9287;7292.7447539336135;9151.725448236546;9162.954185229064;9170.358074934757;9179.265658747301;2295.5064661097945;2538.4542323400465;2580.9870950645222;2603.778678812303;2605.101240072172;2604.127617248224;2648.4703059388103;2650.8144429889917;2651.376926422289;2653.827501212415;2528.9241322760345;2608.686957565095;2609.517239310724;2613.6994245661804;2615.1762194908542;2555.629433732108;2579.445419234864;2603.856787876666;2605.596132599441;2611.2427396055123;2345.5308938212424;2618.5155746186824;2619.965532012388;2632;2636.775874050708;8943.10568943107;9044.77388065297;9044.773880653036;9054.139856713602;9074.591643376063;4887.853364399074;5600.0759874620635;5840.591158618899;5853.239078919756;5854.736536855852;3682.6133256008;3761.1349389640536;3814.675752561008;3827.9808600956817;3833.271678381099;1076.0745758647556;1121.0191082802548;1653.3469279634596;1670.4738007527712;1687.8734094942806;12296.323702196376;12468.81296780549;12473.50105995759;12474.937625311906;12511.3744312784;5018.673786203885;5069.619778516552;5149.613778966517;5156.845294641167;5202.97398513005;9775.608975641037;9802.215822734164;10775.08411785007;10777.407242601732;10793.24447288698;5779.335376431764;5830.067189249699;5831.154482599999;5846.327672317653;5895.145203945404;4633.629309655287;4815.085133824562;4992.026554821775;5104.438511763703;5155.458676838953;4129.855455059119;4159.812808423628;4162.250794856895;4201.45381100455;4201.7268877522865;1258.2890666773244;1299.7270573179737;1387.084524214034;1389.3930729257236;1400.78988151776;1131.4286285425972;1155.9537618495335;1171.2386948483384;1291.728736965229;1377.235634223016;8457.70398036078;8593.398462107718;8617.09520500351;8617.439866408664;8657.913420865836;531.3225637312457;534.6340101041875;541.6181591977646;543.6248988198131;548.5611510791351;5385.865353366119;6403.64779937108;6484.124643173205;6489.1888513935755;6495.090687303781;10981.6156434526;11458.255213411101;11459.197856150156;11461.312321260584;11472.369019703829;10721.035106840422;11130.05394541457;11218.270812397168;11285.435728213557;11309.264897781617;8730.519821409756;8772.473651580925;8809.163129502687;8820.603072861608;8830.690925817695;7777.611119443892;7800.063992320957;7817.6872925084635;7877.212278772077;7895.7236496722335;8752;9719.951400242953;9992.10071093605;10171.64399246023;10295.021972912562;10053.69838904834;10257.794844102928;10576.788464230825;10578.841317380091;10584.312019719002;6656;7834.177411371724;7839;7946.32456241226;7959.4030447715495;8580.099089595502;8627.741167764978;8658.220760131619;8670;8798.956005219932;7488.663010164447;7592.620368981418;7711.652975615999;7749.883751743616;7883.054033516015;7379.778606641809;7426;7439.479236453612;7563.886541701769;7614.657340419805;7930.206979302024;7978.720744773905;8004.599770011359;8007.759767206993;8010.439269251096;7090.184628767552;7250.3112204340505;7270.382017528569;7281.162666293232;7306;7362.558246505227;7412.110546734426;7420.109586849612;7428.517146385468;7435.8884616731875 03:10:39 INFO - PROCESS | 1666 | |4;prototype.html;283.968763436022;346.08115453471044;349.3292877674864;349.7010056401777;351.5956649852669;5435.8369248922545;6615.338466153382;6695.49783766217;6718.79843604692;6739.393454589086;6607.669616519179;6621.73513059477;6626.768063117792;6649.3350664933605;6652.900206496906;4652.395188625474;4822;4826.686265392756;4842.733649649268;4978.153713868651;4830.347903033081;4840.249761287007;4935.6545041847085;4942.505749425065;4955.1080805455;4855.805767769285;4864.8540543783565;4880.048390563824;4881.658283920127;4893.804247830082;4675.368825208588;4925.965547235085;4932.728699921503;4948.6288528360155;4962.776675049631;4127.711060225785;4234.767087810169;4242.384854196155;4242.766647834368;4254.149170165948;5008.774605142741;6263.217097862767;6271.62370257786;6313.558050936436;6385.648789316586;4963.45402005779;5712.82861514151;5863.824085277449;5877.147813567009;5880.0297950838485;7141.39298159657;7143.535670181422;7156.570605763671;7160.498765086446;7162;4583.54164583539;4760.761961901926;4766.52334766524;4770.284457331393;4773.737444440554;7484.064491938562;7560.9621951889885;7564.621768911587;7570.16728159902;7593.886091708629;4871.975640121847;4872.756362181876;4883.95116048835;4887.902241955212;4888.242322439956;4959.983203443286;4973.602111831045;4980.178270585313;4983.950160498421;4989.079204506291;5227.895442091137;5530.451473587402;5822.126680997884;5829.542614346414;5834.299884013945;6900;7176.533525320838;7177.784666460015;7209.026781384551;7211.350978411968;1695.3811858671495;1695.9660806783795;1713.9742903856452;1714.1257958441286;1714.3485475519224;931.2782593489964;1104.0505165557613;1125.043712844076;1128.9040431563244;1130.0733398613058;6263.530235232376;6409.070684750685;6456.128422662974;6470.838229044311;6496.155499784998;7317.451191160684;7328.487005909642;7333.88999165013;7424.443166762514;7435.925640743523;6548.1814773153355;6592.80221593353;6636.867262654817;6638.734450621921;6643.236027856762;3377.527146199534;3566.715982246389;3961.7226794124135;3966.424868394067;3966.900827479278;7486.85026299471;7838.529688218725;7838.529688218725;7844.803879903048;7862.8427431451055;7686.57723825195;7725.961370193226;7757.573333466601;7769.611519424119;7772.300492955661;7815.53106813593;7838.725644602411;7849.097353804385;7855.450118491765;7856.882146767689;6042.244719410074;7492.550446973199;7506.099268087864;7511.699532018876;7526.887096693445;7143.749968751069;7380.261973802577;7384.446166537424;7390.29792169743;7390.7413240536325;6436.517261205335;7834.921650783647;7879.369650428067;7883.763487095396;7886.566238856918;4893.6085113191575;4962.627802914723;4976.576990955665;4977.950220497749;4982.900341993212;6687.966560167168;6842.93157068423;7433.962830185815;7442.1441534222095;7463.738769143054;6973.163220413583;7142.321479459443;7179.389751871149;7191.640417979184;7203.243659415686;6124.663143527148;7122.21655617892;7125.1093613298335;7177.923311503317;7276.126864776261;7079.82300442493;7093.113360829896;7094.290570942864;7100.644967751488;7108.573485590881;6927.757528486479;7245.5652660840515;7249.093863267091;7256.346928776436;7267.8008128658175;6660.533762636569;6861.519693621598;7014.5440546364325;7017.684204210721;7030.648467576703 03:10:39 INFO - PROCESS | 1666 | |5;yui.html;713;716.9928300716995;725.6081715873429;772.8338407242445;821.1829229916233;15239.542813715592;15563.37746490139;15618.219089045531;15623.999999999985;15635.296411661475;14466.855331446683;14563.854361456382;14565;14568.781468277957;14574;785.8546168958761;801.4470015689155;951.8810148731409;962.90852369025;979.9706008819711;953.4279432340575;966.9806603867919;969.9757506062334;970.9611615535371;979.0454307050604;1057.6985559115653;1058.5659879449427;1060.8461773042904;1063.633046598926;1065.5844220753913;819.9754007379788;1006.3659894266602;1029.289790044874;1030.3148406309795;1031.9690409287734;776.0880964866316;777.1645481107776;780.157429975625;781.8279978404742;787.9566623835686;15308.923455382763;15494.457693980656;15497.612559685986;15499.845001549953;15527.45653902108;12968.092233543655;13051.738965220737;13330.800037999437;13382.397792099378;13494.122882012638;10075.748106297327;10120.848187277197;10434.060934515854;10455;10835.566577336896;3048.2988912550236;3055.5263934090253;3476.6697163769654;3564.322778672044;3646.7082633389264;82491.17508824894;82537.58731206306;82749.58625206836;82966.75549866757;83084.58457707673;9900.207983361313;9942.751431214278;10066.446345450924;10159.441230732233;10583.523741431654;23553;23779.286621401385;23785.286441406784;23849.046038158278;23856.880715596657;6191.4118158774845;7517.548947063085;7567.659455324413;7659.119201291811;7936.4047696423;4091.0386059276047;4153.335466325373;4176.415301857743;4252.000779816741;4307.246231909403;3728.8694895678523;3746.4193050077283;3787.5454945406727;3796.4495148203355;3799.639034291738;642.1555654314561;643.5752403413818;684.2780866186222;688.617817111508;700.6461736822872;589.7434615941993;594.4142978045468;602.0096940532799;607.4988134788817;623.2365352443221;8248.711295104642;8308.792280193044;8408.579571021424;8432;8455.069942306342;535.3950036458776;596.2219303808572;610.9602875813147;635.0220660183359;637.3626373626373;3877.5540812806325;3908.5895980922164;3927.155661532784;4062.410950412174;4119.382092686061;93408;96937.51531242298;98817.50591246998;99038;99203;82729.58635206785;83121.58439207765;83502;83607.58196209102;84017.73973390282;66397.33602663911;68013.97979030319;69439.65280173566;69531.65234173796;69552.65223673849;7685.846283074419;7856.803579910548;8033.839323213386;8190.017197936286;8304.252617264476;50846.49153508418;50909.49090509196;51378.48621513737;51459;51958.740206298724;64519.677401612695;66780.6660966692;70200.6489967547;70421;71443;10583.259171857895;10717.196210284104;10733.516991735547;10988;11018;10879.673609791718;11115.277506962346;11132.443377831238;11287.153463490107;11643.88356116428;10104.545295461576;10506.842397364198;10537.683869483928;10674.8932510677;10891.509882055168;10539.63111291101;10705.94647026791;10764.51559679832;10926.672199834018;10961.451927403758;10240.53917573696;10364.429956352473;10494.52774625159;10511.94744026275;10613.628523001658;8948.552572371485;9065.728028159167;9067.637294508146;9229.538523073954;9295.907040929504;9051.773705657411;9089.227415669478;9120.315976301936;9173.587188576663;9339.57971891253 03:10:39 INFO - PROCESS | 1666 | __end_tp_report 03:10:39 INFO - PROCESS | 1666 | __start_cc_report 03:10:39 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1052 03:10:39 INFO - PROCESS | 1666 | __end_cc_report 03:10:39 INFO - PROCESS | 1666 | __startTimestamp1460715039470__endTimestamp 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | ------- Summary: start ------- 03:10:39 INFO - PROCESS | 1666 | Number of tests: 6 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5837.13 Median:6118.42 stddev:630.98 (10.3%) stddev-sans-first:605.18 03:10:39 INFO - PROCESS | 1666 | Values: 3478.9 3537.2 3551.7 3583.6 3635.7 5903.6 5907.1 5941.8 5951.3 5962.1 5892.1 5958.6 5959.7 5962.6 5974.3 5163.9 5278.2 5279.6 5348.9 5374.0 5260.7 5265.0 5268.7 5271.2 5275.2 5263.9 5298.3 5319.0 5356.9 5358.8 5175.8 5183.0 5186.6 5188.7 5212.1 5143.5 5153.6 5314.0 5327.5 5343.5 4815.4 5846.1 5848.1 5853.8 5883.6 6118.4 6242.5 6254.9 6260.2 6269.8 6240.1 6259.2 6265.3 6320.3 6357.5 6028.7 6038.8 6052.4 6056.7 6061.6 6245.1 6342.2 6422.9 6435.0 6436.0 6192.3 6197.9 6213.6 6220.6 6222.9 6203.0 6210.8 6211.3 6215.4 6220.5 6150.2 6156.9 6171.5 6231.6 6237.9 6174.7 6211.6 6226.2 6229.4 6231.7 4972.9 4976.1 4978.9 4996.0 5011.0 4447.7 4494.3 4509.4 4545.2 4578.4 5923.9 5930.1 5945.9 5963.0 5984.3 6268.1 6278.1 6286.8 6288.9 6289.0 5509.7 5595.6 5753.0 5875.2 5948.5 5489.2 5497.9 5515.6 5519.4 5526.6 6479.8 6497.5 6520.2 6520.6 6534.7 6209.9 6278.8 6298.3 6334.2 6349.9 6438.4 6441.8 6443.1 6452.7 6463.3 6159.6 6175.6 6212.3 6212.3 6226.2 6240.2 6290.5 6291.1 6291.1 6329.9 6030.8 6200.7 6201.2 6211.8 6215.0 6042.4 6132.0 6185.1 6212.4 6233.4 6099.1 6130.9 6138.8 6140.6 6143.3 6197.3 6214.5 6229.6 6229.9 6247.4 5920.9 6022.8 6042.1 6094.6 6122.5 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:68315.34 Median:37579.91 stddev:145415.94 (387.0%) stddev-sans-first:145734.68 03:10:39 INFO - PROCESS | 1666 | Values: 483.3 592.8 602.1 676.7 678.6 41511.4 42157.2 42189.9 42262.8 42332.0 45107.5 45566.1 45753.5 45945.3 45967.3 9723.1 9920.6 9925.3 9946.7 10029.4 9758.4 9903.4 9929.6 9934.2 9954.1 9998.0 10058.3 10076.7 10081.1 10098.3 9962.4 10048.2 10049.5 10053.0 10056.6 9885.7 10005.4 10010.3 10015.8 10015.9 43981.3 44278.9 44324.3 44336.6 44343.6 3304.9 3325.4 3394.0 3538.5 3872.5 29685.7 30289.5 30575.8 30893.9 31083.0 2835.7 2841.8 2873.3 2918.5 2931.7 509773.0 513459.0 514496.0 514497.0 516298.0 50264.5 50840.0 68831.7 69965.7 70050.3 49530.8 49688.5 49764.8 49812.0 49840.5 17397.4 17565.6 17585.3 17599.5 17613.9 13544.5 13548.8 13579.9 13580.5 13584.7 15765.1 16054.7 16061.6 16070.4 16079.2 5759.5 6687.5 6744.3 6768.3 6783.7 922.5 991.5 1004.9 1066.4 1104.0 29924.6 30534.7 30608.4 31265.5 31321.0 1096.7 1207.1 1221.8 1226.5 1229.3 15389.5 15943.4 16078.5 16288.0 16963.2 645518.0 647219.5 653467.0 654057.0 655832.0 68756.0 69484.0 69568.7 69686.0 69765.7 1335.6 1524.7 1574.2 1580.3 1582.6 30424.2 30435.2 31082.0 32173.2 32491.2 54899.0 55510.0 55702.0 55755.2 56033.8 429640.0 433172.0 434498.0 434651.3 515162.0 34638.8 35163.9 36018.3 36038.0 36038.6 45683.5 45929.5 46640.6 47322.5 47407.8 34479.0 35380.8 36167.0 36589.8 38325.8 37505.8 37654.0 37833.2 37921.4 38601.0 33040.3 38192.6 38279.6 38580.2 38985.8 33059.3 33911.5 33965.8 34267.7 34355.0 25536.0 25633.5 25670.5 25711.7 25882.9 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35147.22 Median:21918.57 stddev:103701.48 (473.1%) stddev-sans-first:103959.54 03:10:39 INFO - PROCESS | 1666 | Values: 382.8 387.5 388.2 394.8 394.9 19713.0 21599.4 21908.7 21928.5 21930.2 12173.6 12515.4 19101.2 19543.8 20475.5 5422.7 5555.9 5591.5 5614.7 5616.6 4175.3 4362.1 5903.4 6112.1 6117.4 6066.3 6101.9 6105.1 6120.2 6121.0 6397.2 6580.4 6631.4 6637.8 6640.3 4013.8 5655.0 5887.8 5891.2 5921.7 12352.0 14192.7 14254.7 25451.5 26412.8 2317.6 2459.6 2540.2 2649.4 2710.3 10576.0 11595.8 13628.4 15600.1 15870.8 1792.5 1810.7 1832.1 1853.0 1891.8 107194.5 108190.9 108440.0 111007.0 112274.0 11472.5 11669.8 11669.9 11686.6 11840.0 14730.0 14749.3 14750.7 14791.9 14797.3 8964.5 8973.9 9030.7 9108.1 9184.4 9332.8 9336.0 9338.3 9368.9 9434.5 4571.6 4609.8 4640.2 4645.0 4690.3 1780.3 1800.9 1866.7 1937.7 1938.8 900.9 927.3 980.4 1009.1 1049.2 21728.0 22487.6 22571.2 23257.1 23281.2 983.4 1036.4 1055.5 1065.5 1077.2 9629.7 11695.4 11993.9 12065.8 12081.5 535039.0 556602.0 669527.0 673074.0 677753.0 112262.0 114843.0 116173.0 117260.4 120443.0 1060.2 1084.7 1103.4 1105.2 1112.1 18931.7 19519.5 19811.4 20046.1 20087.0 43887.0 48723.5 53920.4 54681.5 55241.7 74063.6 77704.6 77891.0 78844.0 80391.0 7954.5 8325.7 8441.4 8472.4 8569.7 9862.6 12062.2 13417.7 13821.4 14152.9 11295.9 11683.4 11769.7 11792.9 11855.8 11344.5 11476.0 11670.6 11744.6 11918.7 11625.7 11777.9 11825.3 11973.0 12188.6 8059.8 8281.0 8463.3 8562.9 8721.6 10434.2 10468.8 11664.4 12004.5 12063.5 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6298.84 Median:2867.15 stddev:3328.57 (116.1%) stddev-sans-first:3318.57 03:10:39 INFO - PROCESS | 1666 | Values: 1524.7 1668.3 1696.9 2051.9 2102.0 8472.7 9097.0 9252.0 9270.1 9287.0 7292.7 9151.7 9163.0 9170.4 9179.3 2295.5 2538.5 2581.0 2603.8 2605.1 2604.1 2648.5 2650.8 2651.4 2653.8 2528.9 2608.7 2609.5 2613.7 2615.2 2555.6 2579.4 2603.9 2605.6 2611.2 2345.5 2618.5 2620.0 2632.0 2636.8 8943.1 9044.8 9044.8 9054.1 9074.6 4887.9 5600.1 5840.6 5853.2 5854.7 3682.6 3761.1 3814.7 3828.0 3833.3 1076.1 1121.0 1653.3 1670.5 1687.9 12296.3 12468.8 12473.5 12474.9 12511.4 5018.7 5069.6 5149.6 5156.8 5203.0 9775.6 9802.2 10775.1 10777.4 10793.2 5779.3 5830.1 5831.2 5846.3 5895.1 4633.6 4815.1 4992.0 5104.4 5155.5 4129.9 4159.8 4162.3 4201.5 4201.7 1258.3 1299.7 1387.1 1389.4 1400.8 1131.4 1156.0 1171.2 1291.7 1377.2 8457.7 8593.4 8617.1 8617.4 8657.9 531.3 534.6 541.6 543.6 548.6 5385.9 6403.6 6484.1 6489.2 6495.1 10981.6 11458.3 11459.2 11461.3 11472.4 10721.0 11130.1 11218.3 11285.4 11309.3 8730.5 8772.5 8809.2 8820.6 8830.7 7777.6 7800.1 7817.7 7877.2 7895.7 8752.0 9720.0 9992.1 10171.6 10295.0 10053.7 10257.8 10576.8 10578.8 10584.3 6656.0 7834.2 7839.0 7946.3 7959.4 8580.1 8627.7 8658.2 8670.0 8799.0 7488.7 7592.6 7711.7 7749.9 7883.1 7379.8 7426.0 7439.5 7563.9 7614.7 7930.2 7978.7 8004.6 8007.8 8010.4 7090.2 7250.3 7270.4 7281.2 7306.0 7362.6 7412.1 7420.1 7428.5 7435.9 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5855.57 Median:6611.50 stddev:1866.75 (28.2%) stddev-sans-first:1824.54 03:10:39 INFO - PROCESS | 1666 | Values: 284.0 346.1 349.3 349.7 351.6 5435.8 6615.3 6695.5 6718.8 6739.4 6607.7 6621.7 6626.8 6649.3 6652.9 4652.4 4822.0 4826.7 4842.7 4978.2 4830.3 4840.2 4935.7 4942.5 4955.1 4855.8 4864.9 4880.0 4881.7 4893.8 4675.4 4926.0 4932.7 4948.6 4962.8 4127.7 4234.8 4242.4 4242.8 4254.1 5008.8 6263.2 6271.6 6313.6 6385.6 4963.5 5712.8 5863.8 5877.1 5880.0 7141.4 7143.5 7156.6 7160.5 7162.0 4583.5 4760.8 4766.5 4770.3 4773.7 7484.1 7561.0 7564.6 7570.2 7593.9 4872.0 4872.8 4884.0 4887.9 4888.2 4960.0 4973.6 4980.2 4984.0 4989.1 5227.9 5530.5 5822.1 5829.5 5834.3 6900.0 7176.5 7177.8 7209.0 7211.4 1695.4 1696.0 1714.0 1714.1 1714.3 931.3 1104.1 1125.0 1128.9 1130.1 6263.5 6409.1 6456.1 6470.8 6496.2 7317.5 7328.5 7333.9 7424.4 7435.9 6548.2 6592.8 6636.9 6638.7 6643.2 3377.5 3566.7 3961.7 3966.4 3966.9 7486.9 7838.5 7838.5 7844.8 7862.8 7686.6 7726.0 7757.6 7769.6 7772.3 7815.5 7838.7 7849.1 7855.5 7856.9 6042.2 7492.6 7506.1 7511.7 7526.9 7143.7 7380.3 7384.4 7390.3 7390.7 6436.5 7834.9 7879.4 7883.8 7886.6 4893.6 4962.6 4976.6 4978.0 4982.9 6688.0 6842.9 7434.0 7442.1 7463.7 6973.2 7142.3 7179.4 7191.6 7203.2 6124.7 7122.2 7125.1 7177.9 7276.1 7079.8 7093.1 7094.3 7100.6 7108.6 6927.8 7245.6 7249.1 7256.3 7267.8 6660.5 6861.5 7014.5 7017.7 7030.6 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18714.82 Median:51708.87 stddev:26641.01 (51.5%) stddev-sans-first:26681.46 03:10:39 INFO - PROCESS | 1666 | Values: 713.0 717.0 725.6 772.8 821.2 15239.5 15563.4 15618.2 15624.0 15635.3 14466.9 14563.9 14565.0 14568.8 14574.0 785.9 801.4 951.9 962.9 980.0 953.4 967.0 970.0 971.0 979.0 1057.7 1058.6 1060.8 1063.6 1065.6 820.0 1006.4 1029.3 1030.3 1032.0 776.1 777.2 780.2 781.8 788.0 15308.9 15494.5 15497.6 15499.8 15527.5 12968.1 13051.7 13330.8 13382.4 13494.1 10075.7 10120.8 10434.1 10455.0 10835.6 3048.3 3055.5 3476.7 3564.3 3646.7 82491.2 82537.6 82749.6 82966.8 83084.6 9900.2 9942.8 10066.4 10159.4 10583.5 23553.0 23779.3 23785.3 23849.0 23856.9 6191.4 7517.5 7567.7 7659.1 7936.4 4091.0 4153.3 4176.4 4252.0 4307.2 3728.9 3746.4 3787.5 3796.4 3799.6 642.2 643.6 684.3 688.6 700.6 589.7 594.4 602.0 607.5 623.2 8248.7 8308.8 8408.6 8432.0 8455.1 535.4 596.2 611.0 635.0 637.4 3877.6 3908.6 3927.2 4062.4 4119.4 93408.0 96937.5 98817.5 99038.0 99203.0 82729.6 83121.6 83502.0 83607.6 84017.7 66397.3 68014.0 69439.7 69531.7 69552.7 7685.8 7856.8 8033.8 8190.0 8304.3 50846.5 50909.5 51378.5 51459.0 51958.7 64519.7 66780.7 70200.6 70421.0 71443.0 10583.3 10717.2 10733.5 10988.0 11018.0 10879.7 11115.3 11132.4 11287.2 11643.9 10104.5 10506.8 10537.7 10674.9 10891.5 10539.6 10705.9 10764.5 10926.7 10961.5 10240.5 10364.4 10494.5 10511.9 10613.6 8948.6 9065.7 9067.6 9229.5 9295.9 9051.8 9089.2 9120.3 9173.6 9339.6 03:10:39 INFO - PROCESS | 1666 | -------- Summary: end -------- 03:10:39 INFO - PROCESS | 1666 | 03:10:39 INFO - TEST-INFO | 1666: exit 0 03:10:40 INFO - TEST-OK | dromaeo_css | took 1113554ms 03:10:40 INFO - TEST-START | kraken 03:10:40 INFO - operating with platform_type : mac_ 03:10:40 INFO - Initialising browser for kraken test... 03:10:40 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpmLx_uL/profile http://localhost:49277/getInfo.html) 03:10:42 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 03:10:42 INFO - PROCESS | 1673 | colorDepth:24 03:10:42 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 03:10:42 INFO - PROCESS | 1673 | __metrics 03:10:42 INFO - PROCESS | 1673 | 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" 03:10:42 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:10:42 INFO - TEST-INFO | 1673: exit 0 03:10:42 INFO - Browser initialized. 03:10:42 INFO - Running cycle 1/1 for kraken test... 03:10:42 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpmLx_uL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:54 INFO - PROCESS | 1676 | RSS: Main: 207626240 03:10:54 INFO - PROCESS | 1676 | 03:10:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:58 INFO - PROCESS | 1676 | RSS: Main: 262672384 03:10:58 INFO - PROCESS | 1676 | 03:11:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 03:11:01 INFO - PROCESS | 1676 | RSS: Main: 273199104 03:11:01 INFO - PROCESS | 1676 | 03:11:04 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 03:11:05 INFO - PROCESS | 1676 | RSS: Main: 262959104 03:11:05 INFO - PROCESS | 1676 | 03:11:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 03:11:07 INFO - PROCESS | 1676 | RSS: Main: 263823360 03:11:07 INFO - PROCESS | 1676 | 03:11:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:10 INFO - PROCESS | 1676 | RSS: Main: 263839744 03:11:10 INFO - PROCESS | 1676 | 03:11:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:13 INFO - PROCESS | 1676 | RSS: Main: 265134080 03:11:13 INFO - PROCESS | 1676 | 03:11:16 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:17 INFO - PROCESS | 1676 | RSS: Main: 265265152 03:11:17 INFO - PROCESS | 1676 | 03:11:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 03:11:20 INFO - PROCESS | 1676 | RSS: Main: 265641984 03:11:20 INFO - PROCESS | 1676 | 03:11:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:23 INFO - PROCESS | 1676 | RSS: Main: 298635264 03:11:23 INFO - PROCESS | 1676 | 03:11:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:25 INFO - PROCESS | 1676 | RSS: Main: 299622400 03:11:25 INFO - PROCESS | 1676 | 03:11:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:28 INFO - PROCESS | 1676 | RSS: Main: 304893952 03:11:28 INFO - PROCESS | 1676 | 03:11:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:31 INFO - PROCESS | 1676 | RSS: Main: 306622464 03:11:31 INFO - PROCESS | 1676 | 03:11:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:34 INFO - PROCESS | 1676 | RSS: Main: 306429952 03:11:34 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 03:11:36 INFO - PROCESS | 1676 | RSS: Main: 368832512 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | __start_tp_report 03:11:36 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:11:36 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:11:36 INFO - PROCESS | 1676 | |i|pagename|runs| 03:11:36 INFO - PROCESS | 1676 | |0;ai-astar;111;109;111;118;162;158;119;111;109;110 03:11:36 INFO - PROCESS | 1676 | |1;audio-beat-detection;153;119;155;148;121;140;118;153;149;118 03:11:36 INFO - PROCESS | 1676 | |2;audio-dft;185;182;186;187;186;199;260;206;184;185 03:11:36 INFO - PROCESS | 1676 | |3;audio-fft;70;82;73;115;55;57;58;56;123;57 03:11:36 INFO - PROCESS | 1676 | |4;audio-oscillator;92;96;134;92;113;119;131;75;78;120 03:11:36 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;85;84;86;83;85;83;87;83;85;83 03:11:36 INFO - PROCESS | 1676 | |6;imaging-darkroom;92;92;92;92;93;91;93;93;92;92 03:11:36 INFO - PROCESS | 1676 | |7;imaging-desaturate;86;95;133;126;87;86;85;85;84;84 03:11:36 INFO - PROCESS | 1676 | |8;json-parse-financial;55;57;55;56;80;87;86;93;53;54 03:11:36 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;68;70;77;67;66;66;66;82;94 03:11:36 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;79;82;77;81;68;79;102;103;92;85 03:11:36 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;130;130;121;133;130;118;116;116;117;131 03:11:36 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;132;125;132;133;134;116;135;158;160;135 03:11:36 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;66;64;64;66;66;65;66;65;64 03:11:36 INFO - PROCESS | 1676 | __end_tp_report 03:11:36 INFO - PROCESS | 1676 | __start_cc_report 03:11:36 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1233 03:11:36 INFO - PROCESS | 1676 | __end_cc_report 03:11:36 INFO - PROCESS | 1676 | __startTimestamp1460715096464__endTimestamp 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:11:36 INFO - PROCESS | 1676 | Number of tests: 14 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:121.80 Median:114.50 stddev:20.45 (17.9%) stddev-sans-first:21.32 03:11:36 INFO - PROCESS | 1676 | Values: 111.0 109.0 111.0 118.0 162.0 158.0 119.0 111.0 109.0 110.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:148.50 stddev:16.37 (11.0%) stddev-sans-first:16.36 03:11:36 INFO - PROCESS | 1676 | Values: 153.0 119.0 155.0 148.0 121.0 140.0 118.0 153.0 149.0 118.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:196.00 Median:186.50 stddev:23.73 (12.7%) stddev-sans-first:24.83 03:11:36 INFO - PROCESS | 1676 | Values: 185.0 182.0 186.0 187.0 186.0 199.0 260.0 206.0 184.0 185.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:74.60 Median:57.50 stddev:25.12 (43.7%) stddev-sans-first:26.59 03:11:36 INFO - PROCESS | 1676 | Values: 70.0 82.0 73.0 115.0 55.0 57.0 58.0 56.0 123.0 57.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:76.50 stddev:21.21 (27.7%) stddev-sans-first:21.97 03:11:36 INFO - PROCESS | 1676 | Values: 92.0 96.0 134.0 92.0 113.0 119.0 131.0 75.0 78.0 120.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:84.40 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 03:11:36 INFO - PROCESS | 1676 | Values: 85.0 84.0 86.0 83.0 85.0 83.0 87.0 83.0 85.0 83.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:11:36 INFO - PROCESS | 1676 | Values: 92.0 92.0 92.0 92.0 93.0 91.0 93.0 93.0 92.0 92.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:85.50 stddev:18.48 (21.6%) stddev-sans-first:19.30 03:11:36 INFO - PROCESS | 1676 | Values: 86.0 95.0 133.0 126.0 87.0 86.0 85.0 85.0 84.0 84.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.50 stddev:16.59 (24.2%) stddev-sans-first:16.96 03:11:36 INFO - PROCESS | 1676 | Values: 55.0 57.0 55.0 56.0 80.0 87.0 86.0 93.0 53.0 54.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:69.00 stddev:9.78 (14.2%) stddev-sans-first:9.71 03:11:36 INFO - PROCESS | 1676 | Values: 62.0 68.0 70.0 77.0 67.0 66.0 66.0 66.0 82.0 94.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:80.00 stddev:11.11 (13.9%) stddev-sans-first:11.59 03:11:36 INFO - PROCESS | 1676 | Values: 79.0 82.0 77.0 81.0 68.0 79.0 102.0 103.0 92.0 85.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:130.00 stddev:7.15 (5.5%) stddev-sans-first:7.26 03:11:36 INFO - PROCESS | 1676 | Values: 130.0 130.0 121.0 133.0 130.0 118.0 116.0 116.0 117.0 131.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:134.50 stddev:13.45 (10.0%) stddev-sans-first:14.19 03:11:36 INFO - PROCESS | 1676 | Values: 132.0 125.0 132.0 133.0 134.0 116.0 135.0 158.0 160.0 135.0 03:11:36 INFO - PROCESS | 1676 | 03:11:36 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:0.93 03:11:36 INFO - PROCESS | 1676 | Values: 69.0 66.0 64.0 64.0 66.0 66.0 65.0 66.0 65.0 64.0 03:11:36 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:11:36 INFO - PROCESS | 1676 | 03:11:37 INFO - TEST-INFO | 1676: exit 0 03:11:37 INFO - TEST-OK | kraken | took 57298ms 03:11:37 INFO - SUITE-END | took 1170s 03:11:37 INFO - Completed test suite (00:19:31) 03:11:37 INFO - javascript benchmark 03:11:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3478.947815782764, 3537.204129070961, 3551.680348768612, 3583.6058033616305, 3635.690966267867, 5903.582757884602, 5907.143464197688, 5941.821745347635, 5951.285845698522, 5962.075878238875, 5892.116182572616, 5958.642481451116, 5959.70201489926, 5962.552808539355, 5974.31295401029, 5163.896722065557, 5278.234655974891, 5279.5512381447625, 5348.893022139555, 5374.0, 5260.710660913648, 5264.999650066475, 5268.6575372600655, 5271.209318602221, 5275.155975043994, 5263.947360526384, 5298.311219541454, 5319.0, 5356.946430535703, 5358.785648574052, 5175.844724658266, 5182.963407318513, 5186.559142472895, 5188.7146206958605, 5212.087884620214, 5143.459936706667, 5153.613478989091, 5314.0, 5327.493888080626, 5343.465653434625, 4815.446223684286, 5846.064629659277, 5848.122781582754, 5853.795117170878, 5883.558733095035, 6118.418750218722, 6242.500599951993, 6254.906176407358, 6260.248770147566, 6269.843253918689, 6240.095186197976, 6259.217597800275, 6265.279492858334, 6320.273168585625, 6357.523185761086, 6028.6985650717725, 6038.818835434944, 6052.394760524, 6056.727447264883, 6061.636301821904, 6245.125682404467, 6342.175517182736, 6422.871542569216, 6434.967825160844, 6436.0, 6192.256929168439, 6197.876042479125, 6213.596116252519, 6220.595661282002, 6222.875542489125, 6202.968985155136, 6210.782622608187, 6211.3478084801345, 6215.409536094064, 6220.471259942956, 6150.200473938359, 6156.8917594832465, 6171.537134714914, 6231.594946328565, 6237.875242495215, 6174.676238879325, 6211.596246243979, 6226.221722284715, 6229.408206220402, 6231.719572619243, 4972.875678108004, 4976.104301225741, 4978.90042199154, 4995.975020124949, 5011.022850544109, 4447.733136011785, 4494.258447356215, 4509.391232183679, 4545.204589196877, 4578.381918440968, 5923.940760592339, 5930.11048342752, 5945.881082378328, 5962.956482615525, 5984.31180414258, 6268.09112678659, 6278.089676996901, 6286.842828929313, 6288.874222515524, 6289.0252010938375, 5509.724513774296, 5595.629070877661, 5753.0, 5875.177475153482, 5948.524118070544, 5489.231507588861, 5497.917531237034, 5515.641483303572, 5519.448055194448, 5526.58550608706, 6479.773207937699, 6497.545171837926, 6520.217573891164, 6520.608763474207, 6534.738610455529, 6209.906851397142, 6278.843028924313, 6298.275698294755, 6334.1765570475545, 6349.904751428639, 6438.420542151229, 6441.838954026187, 6443.065755465525, 6452.709628066842, 6463.256725476443, 6159.630422174684, 6175.5677102602385, 6212.316645169119, 6212.316645169119, 6226.159468471698, 6240.219972503437, 6290.49676025926, 6291.087792270004, 6291.1192433058495, 6329.936700632935, 6030.819075427744, 6200.720967556381, 6201.224846894138, 6211.844703882259, 6214.9689251553455, 6042.425969532887, 6131.988406491147, 6185.072239164161, 6212.378762123933, 6233.438990490878, 6099.146119543356, 6130.9179418630665, 6138.785142519991, 6140.565599444613, 6143.327652471189, 6197.25632924052, 6214.471769899609, 6229.563930525001, 6229.937700623117, 6247.437730604267, 5920.940790592039, 6022.819315420545, 6042.123892035718, 6094.603850749687, 6122.510199183966], "unit": "score", "name": "dojo.html", "value": 5798.087980108636}, {"lowerIsBetter": false, "replicates": [483.30645523673553, 592.8458600763801, 602.1118849696697, 676.732690587218, 678.6437120511732, 41511.37732934008, 42157.15685686284, 42189.945251368656, 42262.78868605661, 42332.0, 45107.548924510746, 45566.08867822641, 45753.542464575345, 45945.31082033772, 45967.310490342585, 9723.076307750753, 9920.603175872957, 9925.305228633999, 9946.701598952042, 10029.448380339078, 9758.365706229073, 9903.405795652285, 9929.553170107363, 9934.205263578897, 9954.054364835329, 9998.0, 10058.295919285652, 10076.69769906904, 10081.09270165685, 10098.343607665514, 9962.352447090916, 10048.196144308438, 10049.497525123714, 10053.0, 10056.648017319432, 9885.654002109892, 10005.449700266483, 10010.349327293776, 10015.849762253572, 10015.899841001643, 43981.34027989583, 44278.89302767425, 44324.335134973, 44336.55663443357, 44343.556564434264, 3304.9173770655684, 3325.384803811303, 3394.032700680319, 3538.5399898013093, 3872.477215575889, 29685.70314296851, 30289.545656815164, 30575.847120764254, 30893.918712845167, 31083.0, 2835.716428357148, 2841.8152820066834, 2873.310405502685, 2918.518444456662, 2931.736143747073, 509773.0, 513459.0, 514496.0, 514497.0, 516298.0, 50264.49735502598, 50840.0, 68831.65584172147, 69965.65017174983, 70050.2994970054, 49530.76173095629, 49688.503114968385, 49764.75117624461, 49812.0037599246, 49840.501594984315, 17397.391091311743, 17565.560860978578, 17585.296588136585, 17599.472015839547, 17613.911930440267, 13544.458221671022, 13548.796768048487, 13579.932100339434, 13580.524681636292, 13584.660383490294, 15765.054096754231, 16054.678906421806, 16061.598460038358, 16070.43753468623, 16079.18614242503, 5759.452851979056, 6687.465002799764, 6744.291849355845, 6768.289329620319, 6783.660816959133, 922.4695799915075, 991.4546999150439, 1004.8795592913848, 1066.4454483668449, 1104.0394856474918, 29924.551131733042, 30534.694653053186, 30608.387832243232, 31265.531017034762, 31321.0, 1096.7313008313015, 1207.088648070701, 1221.8472690913636, 1226.4603574427224, 1229.3238718704677, 15389.46136885226, 15943.44197953066, 16078.517644470685, 16288.02271863692, 16963.236654350585, 645518.0, 647219.5278047253, 653467.0, 654057.0, 655832.0, 68756.0, 69484.0, 69568.6521567389, 69686.0, 69765.65117174381, 1335.5726167626267, 1524.7255494010963, 1574.157825563318, 1580.2651766928434, 1582.5647946814488, 30424.239394015327, 30435.2391190222, 31082.0, 32173.195670108435, 32491.18772030718, 54899.0, 55510.0, 55702.0, 55755.16367254576, 56033.75864965519, 429640.0, 433172.0, 434498.0, 434651.2674366206, 515162.0, 34638.78764243239, 35163.945081647595, 36018.27963440769, 36038.0, 36038.639613603526, 45683.54316456793, 45929.540704592524, 46640.600781976595, 47322.526774731814, 47407.76296118497, 34479.0, 35380.823095884356, 36167.0, 36589.81705091458, 38325.808370957966, 37505.81247093747, 37654.0, 37833.243335133695, 37921.4311785329, 38601.0, 33040.347982601255, 38192.61807381891, 38279.61720382872, 38580.228395432496, 38985.805070974464, 33059.33881322408, 33911.49214529918, 33965.83017084899, 34267.65732342644, 34354.96935091951, 25535.97856085736, 25633.487330252916, 25670.486590268465, 25711.74288257168, 25882.87058564695], "unit": "score", "name": "ext.html", "value": 20435.81869438936}, {"lowerIsBetter": false, "replicates": [382.76077451592755, 387.4517557655917, 388.23130202199656, 394.76906009984157, 394.87561418153297, 19712.99999999998, 21599.352019439404, 21908.685478871277, 21928.45178870527, 21930.232441864537, 12173.573924912629, 12515.43680534376, 19101.23595056196, 19543.804561954377, 20475.488112797186, 5422.728863556817, 5555.944440555583, 5591.524720398771, 5614.719264036782, 5616.63491873029, 4175.269327867626, 4362.0621566363225, 5903.380145084769, 6112.113743507189, 6117.388261173892, 6066.332703402622, 6101.908471372933, 6105.084237364386, 6120.234970628671, 6121.0, 6397.200349956255, 6580.4406625436895, 6631.403173714365, 6637.800865974028, 6640.302768209341, 4013.7993100345157, 5655.0103731847175, 5887.8233652990475, 5891.23413956183, 5921.674307913063, 12352.0, 14192.716145677132, 14254.714905701932, 25451.49097018068, 26412.81142348599, 2317.6407656813053, 2459.594166962449, 2540.1744433059143, 2649.377396311865, 2710.3246899099095, 10576.0, 11595.826062608983, 13628.386722597506, 15600.141992190425, 15870.761938570931, 1792.4622613216113, 1810.6650269700017, 1832.065646520271, 1852.9814701852945, 1891.810818918111, 107194.46402767937, 108190.91809081887, 108440.0, 111007.0, 112274.0, 11472.541098355972, 11669.824952625717, 11669.941650291865, 11686.590969316034, 11840.0, 14729.96890217696, 14749.262536873328, 14750.704985900222, 14791.852081479048, 14797.260136993107, 8964.462132272085, 8973.910260897437, 9030.729078127666, 9108.134727200906, 9184.357095003286, 9332.813343733087, 9336.0, 9338.346315757832, 9368.859467107999, 9434.528273586293, 4571.588557029883, 4609.815607375667, 4640.164770341304, 4644.976775116171, 4690.343351930733, 1780.3352127906169, 1800.873938824296, 1866.7106598477258, 1937.7093435984716, 1938.7867334593184, 900.9189172974463, 927.2813569483704, 980.3970558106855, 1009.106940357774, 1049.234059136819, 21728.0, 22487.550248995256, 22571.210007649654, 23257.090941765153, 23281.18515851937, 983.4492684096929, 1036.383351905615, 1055.466989170464, 1065.5311662868314, 1077.1813421799488, 9629.711108666752, 11695.356755378365, 11993.880061199276, 12065.819012714815, 12081.45633446497, 535039.0, 556602.0, 669527.0, 673074.0, 677753.0, 112262.0, 114843.0, 116173.0, 117260.41369793097, 120443.0, 1060.16247164739, 1084.7125511739396, 1103.3931337764197, 1105.209775010871, 1112.0603090388609, 18931.716024259924, 19519.512012199808, 19811.41508679331, 20046.077191789573, 20087.0, 43887.0, 48723.53829385124, 53920.38238852841, 54681.45318546764, 55241.72379138239, 74063.6296818534, 77704.61147694226, 77891.0, 78844.0, 80391.0, 7954.482958607672, 8325.666973321, 8441.409101362846, 8472.44929079608, 8569.742907712778, 9862.605495780088, 12062.165391133252, 13417.731645367234, 13821.378037988114, 14152.929235353757, 11295.943520282675, 11683.357415342238, 11769.705757356134, 11792.882071179178, 11855.76288474243, 11344.489497972447, 11476.0, 11670.649880503599, 11744.647660570197, 11918.702032448911, 11625.6512304631, 11777.941110294394, 11825.290482571074, 11973.0, 12188.634340969431, 8059.758207253792, 8281.0, 8463.322934165375, 8562.914370856211, 8721.56392180401, 10434.165266778487, 10468.842967355344, 11664.358460284426, 12004.459799308877, 12063.457144428347], "unit": "score", "name": "jquery.html", "value": 9743.479156571806}, {"lowerIsBetter": false, "replicates": [1524.7255494011088, 1668.2659629762904, 1696.915154242288, 2051.917923283069, 2102.0, 8472.661093556258, 9097.0, 9252.0, 9270.072992700734, 9287.0, 7292.7447539336135, 9151.725448236546, 9162.954185229064, 9170.358074934757, 9179.265658747301, 2295.5064661097945, 2538.4542323400465, 2580.9870950645222, 2603.778678812303, 2605.101240072172, 2604.127617248224, 2648.4703059388103, 2650.8144429889917, 2651.376926422289, 2653.827501212415, 2528.9241322760345, 2608.686957565095, 2609.517239310724, 2613.6994245661804, 2615.1762194908542, 2555.629433732108, 2579.445419234864, 2603.856787876666, 2605.596132599441, 2611.2427396055123, 2345.5308938212424, 2618.5155746186824, 2619.965532012388, 2632.0, 2636.775874050708, 8943.10568943107, 9044.77388065297, 9044.773880653036, 9054.139856713602, 9074.591643376063, 4887.853364399074, 5600.0759874620635, 5840.591158618899, 5853.239078919756, 5854.736536855852, 3682.6133256008, 3761.1349389640536, 3814.675752561008, 3827.9808600956817, 3833.271678381099, 1076.0745758647556, 1121.0191082802548, 1653.3469279634596, 1670.4738007527712, 1687.8734094942806, 12296.323702196376, 12468.81296780549, 12473.50105995759, 12474.937625311906, 12511.3744312784, 5018.673786203885, 5069.619778516552, 5149.613778966517, 5156.845294641167, 5202.97398513005, 9775.608975641037, 9802.215822734164, 10775.08411785007, 10777.407242601732, 10793.24447288698, 5779.335376431764, 5830.067189249699, 5831.154482599999, 5846.327672317653, 5895.145203945404, 4633.629309655287, 4815.085133824562, 4992.026554821775, 5104.438511763703, 5155.458676838953, 4129.855455059119, 4159.812808423628, 4162.250794856895, 4201.45381100455, 4201.7268877522865, 1258.2890666773244, 1299.7270573179737, 1387.084524214034, 1389.3930729257236, 1400.78988151776, 1131.4286285425972, 1155.9537618495335, 1171.2386948483384, 1291.728736965229, 1377.235634223016, 8457.70398036078, 8593.398462107718, 8617.09520500351, 8617.439866408664, 8657.913420865836, 531.3225637312457, 534.6340101041875, 541.6181591977646, 543.6248988198131, 548.5611510791351, 5385.865353366119, 6403.64779937108, 6484.124643173205, 6489.1888513935755, 6495.090687303781, 10981.6156434526, 11458.255213411101, 11459.197856150156, 11461.312321260584, 11472.369019703829, 10721.035106840422, 11130.05394541457, 11218.270812397168, 11285.435728213557, 11309.264897781617, 8730.519821409756, 8772.473651580925, 8809.163129502687, 8820.603072861608, 8830.690925817695, 7777.611119443892, 7800.063992320957, 7817.6872925084635, 7877.212278772077, 7895.7236496722335, 8752.0, 9719.951400242953, 9992.10071093605, 10171.64399246023, 10295.021972912562, 10053.69838904834, 10257.794844102928, 10576.788464230825, 10578.841317380091, 10584.312019719002, 6656.0, 7834.177411371724, 7839.0, 7946.32456241226, 7959.4030447715495, 8580.099089595502, 8627.741167764978, 8658.220760131619, 8670.0, 8798.956005219932, 7488.663010164447, 7592.620368981418, 7711.652975615999, 7749.883751743616, 7883.054033516015, 7379.778606641809, 7426.0, 7439.479236453612, 7563.886541701769, 7614.657340419805, 7930.206979302024, 7978.720744773905, 8004.599770011359, 8007.759767206993, 8010.439269251096, 7090.184628767552, 7250.3112204340505, 7270.382017528569, 7281.162666293232, 7306.0, 7362.558246505227, 7412.110546734426, 7420.109586849612, 7428.517146385468, 7435.8884616731875], "unit": "score", "name": "mootools.html", "value": 5078.390622601551}, {"lowerIsBetter": false, "replicates": [283.968763436022, 346.08115453471044, 349.3292877674864, 349.7010056401777, 351.5956649852669, 5435.8369248922545, 6615.338466153382, 6695.49783766217, 6718.79843604692, 6739.393454589086, 6607.669616519179, 6621.73513059477, 6626.768063117792, 6649.3350664933605, 6652.900206496906, 4652.395188625474, 4822.0, 4826.686265392756, 4842.733649649268, 4978.153713868651, 4830.347903033081, 4840.249761287007, 4935.6545041847085, 4942.505749425065, 4955.1080805455, 4855.805767769285, 4864.8540543783565, 4880.048390563824, 4881.658283920127, 4893.804247830082, 4675.368825208588, 4925.965547235085, 4932.728699921503, 4948.6288528360155, 4962.776675049631, 4127.711060225785, 4234.767087810169, 4242.384854196155, 4242.766647834368, 4254.149170165948, 5008.774605142741, 6263.217097862767, 6271.62370257786, 6313.558050936436, 6385.648789316586, 4963.45402005779, 5712.82861514151, 5863.824085277449, 5877.147813567009, 5880.0297950838485, 7141.39298159657, 7143.535670181422, 7156.570605763671, 7160.498765086446, 7162.0, 4583.54164583539, 4760.761961901926, 4766.52334766524, 4770.284457331393, 4773.737444440554, 7484.064491938562, 7560.9621951889885, 7564.621768911587, 7570.16728159902, 7593.886091708629, 4871.975640121847, 4872.756362181876, 4883.95116048835, 4887.902241955212, 4888.242322439956, 4959.983203443286, 4973.602111831045, 4980.178270585313, 4983.950160498421, 4989.079204506291, 5227.895442091137, 5530.451473587402, 5822.126680997884, 5829.542614346414, 5834.299884013945, 6900.0, 7176.533525320838, 7177.784666460015, 7209.026781384551, 7211.350978411968, 1695.3811858671495, 1695.9660806783795, 1713.9742903856452, 1714.1257958441286, 1714.3485475519224, 931.2782593489964, 1104.0505165557613, 1125.043712844076, 1128.9040431563244, 1130.0733398613058, 6263.530235232376, 6409.070684750685, 6456.128422662974, 6470.838229044311, 6496.155499784998, 7317.451191160684, 7328.487005909642, 7333.88999165013, 7424.443166762514, 7435.925640743523, 6548.1814773153355, 6592.80221593353, 6636.867262654817, 6638.734450621921, 6643.236027856762, 3377.527146199534, 3566.715982246389, 3961.7226794124135, 3966.424868394067, 3966.900827479278, 7486.85026299471, 7838.529688218725, 7838.529688218725, 7844.803879903048, 7862.8427431451055, 7686.57723825195, 7725.961370193226, 7757.573333466601, 7769.611519424119, 7772.300492955661, 7815.53106813593, 7838.725644602411, 7849.097353804385, 7855.450118491765, 7856.882146767689, 6042.244719410074, 7492.550446973199, 7506.099268087864, 7511.699532018876, 7526.887096693445, 7143.749968751069, 7380.261973802577, 7384.446166537424, 7390.29792169743, 7390.7413240536325, 6436.517261205335, 7834.921650783647, 7879.369650428067, 7883.763487095396, 7886.566238856918, 4893.6085113191575, 4962.627802914723, 4976.576990955665, 4977.950220497749, 4982.900341993212, 6687.966560167168, 6842.93157068423, 7433.962830185815, 7442.1441534222095, 7463.738769143054, 6973.163220413583, 7142.321479459443, 7179.389751871149, 7191.640417979184, 7203.243659415686, 6124.663143527148, 7122.21655617892, 7125.1093613298335, 7177.923311503317, 7276.126864776261, 7079.82300442493, 7093.113360829896, 7094.290570942864, 7100.644967751488, 7108.573485590881, 6927.757528486479, 7245.5652660840515, 7249.093863267091, 7256.346928776436, 7267.8008128658175, 6660.533762636569, 6861.519693621598, 7014.5440546364325, 7017.684204210721, 7030.648467576703], "unit": "score", "name": "prototype.html", "value": 5234.348964981782}, {"lowerIsBetter": false, "replicates": [713.0, 716.9928300716995, 725.6081715873429, 772.8338407242445, 821.1829229916233, 15239.542813715592, 15563.37746490139, 15618.219089045531, 15623.999999999985, 15635.296411661475, 14466.855331446683, 14563.854361456382, 14565.0, 14568.781468277957, 14574.0, 785.8546168958761, 801.4470015689155, 951.8810148731409, 962.90852369025, 979.9706008819711, 953.4279432340575, 966.9806603867919, 969.9757506062334, 970.9611615535371, 979.0454307050604, 1057.6985559115653, 1058.5659879449427, 1060.8461773042904, 1063.633046598926, 1065.5844220753913, 819.9754007379788, 1006.3659894266602, 1029.289790044874, 1030.3148406309795, 1031.9690409287734, 776.0880964866316, 777.1645481107776, 780.157429975625, 781.8279978404742, 787.9566623835686, 15308.923455382763, 15494.457693980656, 15497.612559685986, 15499.845001549953, 15527.45653902108, 12968.092233543655, 13051.738965220737, 13330.800037999437, 13382.397792099378, 13494.122882012638, 10075.748106297327, 10120.848187277197, 10434.060934515854, 10455.0, 10835.566577336896, 3048.2988912550236, 3055.5263934090253, 3476.6697163769654, 3564.322778672044, 3646.7082633389264, 82491.17508824894, 82537.58731206306, 82749.58625206836, 82966.75549866757, 83084.58457707673, 9900.207983361313, 9942.751431214278, 10066.446345450924, 10159.441230732233, 10583.523741431654, 23553.0, 23779.286621401385, 23785.286441406784, 23849.046038158278, 23856.880715596657, 6191.4118158774845, 7517.548947063085, 7567.659455324413, 7659.119201291811, 7936.4047696423, 4091.0386059276047, 4153.335466325373, 4176.415301857743, 4252.000779816741, 4307.246231909403, 3728.8694895678523, 3746.4193050077283, 3787.5454945406727, 3796.4495148203355, 3799.639034291738, 642.1555654314561, 643.5752403413818, 684.2780866186222, 688.617817111508, 700.6461736822872, 589.7434615941993, 594.4142978045468, 602.0096940532799, 607.4988134788817, 623.2365352443221, 8248.711295104642, 8308.792280193044, 8408.579571021424, 8432.0, 8455.069942306342, 535.3950036458776, 596.2219303808572, 610.9602875813147, 635.0220660183359, 637.3626373626373, 3877.5540812806325, 3908.5895980922164, 3927.155661532784, 4062.410950412174, 4119.382092686061, 93408.0, 96937.51531242298, 98817.50591246998, 99038.0, 99203.0, 82729.58635206785, 83121.58439207765, 83502.0, 83607.58196209102, 84017.73973390282, 66397.33602663911, 68013.97979030319, 69439.65280173566, 69531.65234173796, 69552.65223673849, 7685.846283074419, 7856.803579910548, 8033.839323213386, 8190.017197936286, 8304.252617264476, 50846.49153508418, 50909.49090509196, 51378.48621513737, 51459.0, 51958.740206298724, 64519.677401612695, 66780.6660966692, 70200.6489967547, 70421.0, 71443.0, 10583.259171857895, 10717.196210284104, 10733.516991735547, 10988.0, 11018.0, 10879.673609791718, 11115.277506962346, 11132.443377831238, 11287.153463490107, 11643.88356116428, 10104.545295461576, 10506.842397364198, 10537.683869483928, 10674.8932510677, 10891.509882055168, 10539.63111291101, 10705.94647026791, 10764.51559679832, 10926.672199834018, 10961.451927403758, 10240.53917573696, 10364.429956352473, 10494.52774625159, 10511.94744026275, 10613.628523001658, 8948.552572371485, 9065.728028159167, 9067.637294508146, 9229.538523073954, 9295.907040929504, 9051.773705657411, 9089.227415669478, 9120.315976301936, 9173.587188576663, 9339.57971891253], "unit": "score", "name": "yui.html", "value": 7030.0709369254355}], "name": "dromaeo_css", "value": 7744.540421222464}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 118.0, 162.0, 158.0, 119.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 121.8}, {"lowerIsBetter": true, "replicates": [153.0, 119.0, 155.0, 148.0, 121.0, 140.0, 118.0, 153.0, 149.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 137.4}, {"lowerIsBetter": true, "replicates": [185.0, 182.0, 186.0, 187.0, 186.0, 199.0, 260.0, 206.0, 184.0, 185.0], "unit": "score", "name": "audio-dft", "value": 196.0}, {"lowerIsBetter": true, "replicates": [70.0, 82.0, 73.0, 115.0, 55.0, 57.0, 58.0, 56.0, 123.0, 57.0], "unit": "score", "name": "audio-fft", "value": 74.6}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 134.0, 92.0, 113.0, 119.0, 131.0, 75.0, 78.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 83.0, 85.0, 83.0, 87.0, 83.0, 85.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 92.0, 93.0, 91.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.2}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 133.0, 126.0, 87.0, 86.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 55.0, 56.0, 80.0, 87.0, 86.0, 93.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 67.6}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 70.0, 77.0, 67.0, 66.0, 66.0, 66.0, 82.0, 94.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 77.0, 81.0, 68.0, 79.0, 102.0, 103.0, 92.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [130.0, 130.0, 121.0, 133.0, 130.0, 118.0, 116.0, 116.0, 117.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [132.0, 125.0, 132.0, 133.0, 134.0, 116.0, 135.0, 158.0, 160.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 64.0, 64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1456.4}]} 03:11:37 INFO - Return code: 0 03:11:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:37 INFO - # TBPL SUCCESS # 03:11:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:37 INFO - 2016-04-15 03:11:37.806 screenresolution[1680:9919] starting screenresolution argv=screenresolution get 03:11:37 INFO - 2016-04-15 03:11:37.808 screenresolution[1680:9919] Display 0: 1600x1200x32@60 03:11:37 INFO - 2016-04-15 03:11:37.814 screenresolution[1681:9922] starting screenresolution argv=screenresolution list 03:11:37 INFO - Available Modes on Display 0 03:11:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:38 INFO - Intel Iris: 03:11:38 INFO - Chipset Model: Intel Iris 03:11:38 INFO - Type: GPU 03:11:38 INFO - Bus: Built-In 03:11:38 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:38 INFO - Vendor: Intel (0x8086) 03:11:38 INFO - Device ID: 0x0a2e 03:11:38 INFO - Revision ID: 0x0009 03:11:38 INFO - Displays: 03:11:38 INFO - Display: 03:11:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:38 INFO - Display Serial Number: 1600x1200 60 03:11:38 INFO - Main Display: Yes 03:11:38 INFO - Mirror: Off 03:11:38 INFO - Online: Yes 03:11:38 INFO - Rotation: Supported 03:11:38 INFO - Return code: 0 03:11:38 INFO - Running post-action listener: _resource_record_post_action 03:11:38 INFO - Running post-run listener: _resource_record_post_run 03:11:39 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37783040; Write bytes: 664851968; Read time: 398; Write time: 1949 03:11:39 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 352672256; Write bytes: 354355200; Read time: 27068; Write time: 640 03:11:39 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 36828672; Write bytes: 300154368; Read time: 383; Write time: 1272 03:11:39 INFO - Running post-run listener: _upload_blobber_files 03:11:39 INFO - Blob upload gear active. 03:11:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:11:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:40 INFO - (blobuploader) - INFO - Done attempting. 03:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:41 INFO - (blobuploader) - INFO - Done attempting. 03:11:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:41 INFO - Return code: 0 03:11:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af85ca2182186b48a007e1d0ad6001b71fb234f548769045d85e942bac24ba17a799bd8027610740e8b4172391a32f91528ad8f4940ed92f96f2a11022d83b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a302e0cb721064e53494177198bdecc1d351eebdc8140afeab0046a60ad575a5441dd1d7db760d86a59c197ebff2ccdb84949c7db883dad89bed96a189a9689"} 03:11:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:41 INFO - Contents: 03:11:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af85ca2182186b48a007e1d0ad6001b71fb234f548769045d85e942bac24ba17a799bd8027610740e8b4172391a32f91528ad8f4940ed92f96f2a11022d83b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a302e0cb721064e53494177198bdecc1d351eebdc8140afeab0046a60ad575a5441dd1d7db760d86a59c197ebff2ccdb84949c7db883dad89bed96a189a9689"} 03:11:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:41 INFO - Copying logs to upload dir... 03:11:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.197156 ========= master_lag: 1.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-15 03:11:43.433639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 03:11:43.438331) ========= 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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af85ca2182186b48a007e1d0ad6001b71fb234f548769045d85e942bac24ba17a799bd8027610740e8b4172391a32f91528ad8f4940ed92f96f2a11022d83b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a302e0cb721064e53494177198bdecc1d351eebdc8140afeab0046a60ad575a5441dd1d7db760d86a59c197ebff2ccdb84949c7db883dad89bed96a189a9689"} build_url:https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/M5bjiJmwSFy7BOoa7S64RA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af85ca2182186b48a007e1d0ad6001b71fb234f548769045d85e942bac24ba17a799bd8027610740e8b4172391a32f91528ad8f4940ed92f96f2a11022d83b0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a302e0cb721064e53494177198bdecc1d351eebdc8140afeab0046a60ad575a5441dd1d7db760d86a59c197ebff2ccdb84949c7db883dad89bed96a189a9689"}' ========= master_lag: 1.83 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 03:11:45.274518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-15 03:11:45.274877) ========= 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.xE6K5z2Xy3/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.jRJGi76Arf/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.005216 ========= master_lag: 6.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-15 03:11:51.312780) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-15 03:11:51.313084) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-15 03:11:53.702891) ========= ========= Total master_lag: 14.29 =========