builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0061 starttime: 1462834830.15 results: success (0) buildid: 20160509134909 builduid: 86d329654490450a809378ee1a4ed0ce revision: beaf4d37d01c85e87cee2682604083a889beeb29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.148159) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.148551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.148821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.168636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.169007) ========= 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.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-05-09 16:00:30-- 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% 7.95M=0.001s 2016-05-09 16:00:30 (7.95 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.263983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.267374) ========= 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.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.020207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:30.315891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:00:30.316242) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev beaf4d37d01c85e87cee2682604083a889beeb29 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev beaf4d37d01c85e87cee2682604083a889beeb29 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-05-09 16:00:30,386 truncating revision to first 12 chars 2016-05-09 16:00:30,386 Setting DEBUG logging. 2016-05-09 16:00:30,386 attempt 1/10 2016-05-09 16:00:30,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/beaf4d37d01c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:00:31,358 unpacking tar archive at: mozilla-beta-beaf4d37d01c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 16:00:31.560656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:31.560978) ========= script_repo_revision: beaf4d37d01c85e87cee2682604083a889beeb29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:31.564536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:31.564819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:00:31.578328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-09 16:00:31.578726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:00:31 INFO - MultiFileLogger online at 20160509 16:00:31 in /builds/slave/test 16:00:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:00:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:00:31 INFO - {'append_to_log': False, 16:00:31 INFO - 'base_work_dir': '/builds/slave/test', 16:00:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:00:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:00:31 INFO - 'branch': 'Mozilla-Beta', 16:00:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:31 INFO - 'config_files': ('talos/mac_config.py',), 16:00:31 INFO - 'default_actions': ('clobber', 16:00:31 INFO - 'read-buildbot-config', 16:00:31 INFO - 'download-and-extract', 16:00:31 INFO - 'populate-webroot', 16:00:31 INFO - 'create-virtualenv', 16:00:31 INFO - 'install', 16:00:31 INFO - 'run-tests'), 16:00:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:31 INFO - 'download_minidump_stackwalk': True, 16:00:31 INFO - 'download_symbols': 'ondemand', 16:00:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:00:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:00:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:00:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:00:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:31 INFO - 'installer_path': 'installer.exe', 16:00:31 INFO - 'log_level': 'info', 16:00:31 INFO - 'log_name': 'talos', 16:00:31 INFO - 'log_to_console': True, 16:00:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:00:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:00:31 INFO - 'opt_config_files': (), 16:00:31 INFO - 'pip_index': False, 16:00:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:00:31 INFO - 'cmd': ('bash', 16:00:31 INFO - '-c', 16:00:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:00:31 INFO - 'enabled': True, 16:00:31 INFO - 'halt_on_failure': False, 16:00:31 INFO - 'name': 'check_screen_resolution'},), 16:00:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:00:31 INFO - 'cmd': ('bash', 16:00:31 INFO - '-c', 16:00:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:00:31 INFO - 'enabled': True, 16:00:31 INFO - 'halt_on_failure': False, 16:00:31 INFO - 'name': 'check_screen_resolution'},), 16:00:31 INFO - 'run_cmd_checks_enabled': True, 16:00:31 INFO - 'sps_profile': False, 16:00:31 INFO - 'sps_profile_interval': 0, 16:00:31 INFO - 'suite': 'dromaeojs-e10s', 16:00:31 INFO - 'system_bits': '32', 16:00:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:31 INFO - 'title': 't-yosemite-r7-0061', 16:00:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:31 INFO - 'use_talos_json': True, 16:00:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:00:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:31 INFO - 'work_dir': 'build'} 16:00:31 INFO - ##### 16:00:31 INFO - ##### Running clobber step. 16:00:31 INFO - ##### 16:00:31 INFO - Running pre-action listener: _resource_record_pre_action 16:00:31 INFO - Running main action method: clobber 16:00:31 INFO - rmtree: /builds/slave/test/build 16:00:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:00:33 INFO - Running post-action listener: _resource_record_post_action 16:00:33 INFO - ##### 16:00:33 INFO - ##### Running read-buildbot-config step. 16:00:33 INFO - ##### 16:00:33 INFO - Running pre-action listener: _resource_record_pre_action 16:00:33 INFO - Running main action method: read_buildbot_config 16:00:33 INFO - Using buildbot properties: 16:00:33 INFO - { 16:00:33 INFO - "project": "", 16:00:33 INFO - "product": "firefox", 16:00:33 INFO - "script_repo_revision": "production", 16:00:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:00:33 INFO - "repository": "", 16:00:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:00:33 INFO - "buildid": "20160509134909", 16:00:33 INFO - "pgo_build": "False", 16:00:33 INFO - "basedir": "/builds/slave/test", 16:00:33 INFO - "buildnumber": 1, 16:00:33 INFO - "slavename": "t-yosemite-r7-0061", 16:00:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:00:33 INFO - "platform": "yosemite_r7", 16:00:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:00:33 INFO - "branch": "mozilla-beta", 16:00:33 INFO - "repo_path": "releases/mozilla-beta", 16:00:33 INFO - "revision": "beaf4d37d01c85e87cee2682604083a889beeb29", 16:00:33 INFO - "stage_platform": "macosx64", 16:00:33 INFO - "builduid": "86d329654490450a809378ee1a4ed0ce", 16:00:33 INFO - "slavebuilddir": "test" 16:00:33 INFO - } 16:00:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 16:00:33 INFO - Running post-action listener: _resource_record_post_action 16:00:33 INFO - ##### 16:00:33 INFO - ##### Running download-and-extract step. 16:00:33 INFO - ##### 16:00:33 INFO - Running pre-action listener: _resource_record_pre_action 16:00:33 INFO - Running main action method: download_and_extract 16:00:33 INFO - mkdir: /builds/slave/test/build/tests 16:00:33 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')]} 16:00:33 INFO - https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 16:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 16:00:45 INFO - Downloaded 1241 bytes. 16:00:45 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 16:00:45 INFO - Using the following test package requirements: 16:00:45 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:00:45 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 16:00:45 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 16:00:45 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:00:45 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 16:00:45 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:00:45 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 16:00:45 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 16:00:45 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 16:00:45 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:00:45 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:00:45 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 16:00:45 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 16:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:45 INFO - https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 16:00:46 INFO - Downloaded 17747492 bytes. 16:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:00:49 INFO - Return code: 0 16:00:49 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:49 INFO - https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 16:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 16:00:58 INFO - Downloaded 17747492 bytes. 16:00:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:00:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:01:02 INFO - Return code: 0 16:01: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')]} 16:01:02 INFO - https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:01:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:01:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:01:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 16:01:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 16:01:03 INFO - Downloaded 10845194 bytes. 16:01:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:01:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:01:03 INFO - Return code: 0 16:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:03 INFO - https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 16:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 16:01:12 INFO - Downloaded 88341506 bytes. 16:01:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:01:12 INFO - mkdir: /builds/slave/test/properties 16:01:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:12 INFO - Contents: 16:01:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:01:13 INFO - Running post-action listener: _resource_record_post_action 16:01:13 INFO - Running post-action listener: set_extra_try_arguments 16:01:13 INFO - ##### 16:01:13 INFO - ##### Running populate-webroot step. 16:01:13 INFO - ##### 16:01:13 INFO - Running pre-action listener: _resource_record_pre_action 16:01:13 INFO - Running main action method: populate_webroot 16:01:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:13 INFO - '--tppagecycles', 16:01:13 INFO - '7'], 16:01:13 INFO - 'tests': ['tsvgm']}}, 16:01:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:01:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:01:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'tests': ['damp', 'tps']}, 16:01:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['damp', 'tps']}, 16:01:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:01:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:13 INFO - 'other': {'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'other_l64': {'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'other_nol64': {'tests': ['a11yr', 16:01:13 INFO - 'ts_paint', 16:01:13 INFO - 'tpaint', 16:01:13 INFO - 'sessionrestore', 16:01:13 INFO - 'sessionrestore_no_auto_restore', 16:01:13 INFO - 'tabpaint']}, 16:01:13 INFO - 'svgr': {'tests': ['tsvgx', 16:01:13 INFO - 'tsvgr_opacity', 16:01:13 INFO - 'tart', 16:01:13 INFO - 'tscrollx', 16:01:13 INFO - 'cart']}, 16:01:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['tsvgx', 16:01:13 INFO - 'tsvgr_opacity', 16:01:13 INFO - 'tart', 16:01:13 INFO - 'tscrollx', 16:01:13 INFO - 'cart']}, 16:01:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'tests': ['tp5o']}, 16:01:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'talos_options': ['--e10s'], 16:01:13 INFO - 'tests': ['tp5o']}, 16:01:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'talos_options': ['--xperf_path', 16:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:13 INFO - 'tests': ['tp5n']}, 16:01:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:13 INFO - 'talos_options': ['--e10s', 16:01:13 INFO - '--xperf_path', 16:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:13 INFO - 'tests': ['tp5n']}}, 16:01:13 INFO - 'talos.zip': {'path': '', 16:01:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:13 INFO - Running post-action listener: _resource_record_post_action 16:01:13 INFO - ##### 16:01:13 INFO - ##### Running create-virtualenv step. 16:01:13 INFO - ##### 16:01:13 INFO - Running pre-action listener: _resource_record_pre_action 16:01:13 INFO - Running main action method: create_virtualenv 16:01:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:13 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 16:01:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:13 INFO - Using real prefix '/tools/python27' 16:01:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:14 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:17 INFO - Installing pip.................done. 16:01:17 INFO - Return code: 0 16:01:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:17 INFO - 'HOME': '/Users/cltbld', 16:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:17 INFO - 'LOGNAME': 'cltbld', 16:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:17 INFO - 'MOZ_NO_REMOTE': '1', 16:01:17 INFO - 'NO_EM_RESTART': '1', 16:01:17 INFO - 'PAGER': '/bin/cat', 16:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:17 INFO - 'PWD': '/builds/slave/test', 16:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:17 INFO - 'SHELL': '/bin/bash', 16:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:17 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:17 INFO - 'USER': 'cltbld', 16:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:17 INFO - 'XPC_FLAGS': '0x0', 16:01:17 INFO - 'XPC_SERVICE_NAME': '0', 16:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:17 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 16:01:17 INFO - Cleaning up... 16:01:17 INFO - Return code: 0 16:01:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:17 INFO - 'HOME': '/Users/cltbld', 16:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:17 INFO - 'LOGNAME': 'cltbld', 16:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:17 INFO - 'MOZ_NO_REMOTE': '1', 16:01:17 INFO - 'NO_EM_RESTART': '1', 16:01:17 INFO - 'PAGER': '/bin/cat', 16:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:17 INFO - 'PWD': '/builds/slave/test', 16:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:17 INFO - 'SHELL': '/bin/bash', 16:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:17 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:17 INFO - 'USER': 'cltbld', 16:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:17 INFO - 'XPC_FLAGS': '0x0', 16:01:17 INFO - 'XPC_SERVICE_NAME': '0', 16:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:17 INFO - Downloading/unpacking psutil>=0.7.1 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:20 INFO - Installing collected packages: psutil 16:01:20 INFO - Running setup.py install for psutil 16:01:20 INFO - building 'psutil._psutil_osx' extension 16:01:20 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 16:01:20 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 16:01:20 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 16:01:20 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 16:01:20 INFO - building 'psutil._psutil_posix' extension 16:01:20 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 16:01:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:01:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:01:20 INFO - ^ 16:01:20 INFO - 1 warning generated. 16:01:20 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 16:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:20 INFO - Successfully installed psutil 16:01:20 INFO - Cleaning up... 16:01:21 INFO - Return code: 0 16:01:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:21 INFO - 'HOME': '/Users/cltbld', 16:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:21 INFO - 'LOGNAME': 'cltbld', 16:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:21 INFO - 'MOZ_NO_REMOTE': '1', 16:01:21 INFO - 'NO_EM_RESTART': '1', 16:01:21 INFO - 'PAGER': '/bin/cat', 16:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:21 INFO - 'PWD': '/builds/slave/test', 16:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:21 INFO - 'SHELL': '/bin/bash', 16:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:21 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:21 INFO - 'USER': 'cltbld', 16:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:21 INFO - 'XPC_FLAGS': '0x0', 16:01:21 INFO - 'XPC_SERVICE_NAME': '0', 16:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:01:23 INFO - Installing collected packages: mozsystemmonitor 16:01:23 INFO - Running setup.py install for mozsystemmonitor 16:01:23 INFO - Successfully installed mozsystemmonitor 16:01:23 INFO - Cleaning up... 16:01:24 INFO - Return code: 0 16:01:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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')]} 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01: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', '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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:01: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 blobuploader==1.2.4 16:01:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:24 INFO - 'HOME': '/Users/cltbld', 16:01:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:24 INFO - 'LOGNAME': 'cltbld', 16:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:24 INFO - 'MOZ_NO_REMOTE': '1', 16:01:24 INFO - 'NO_EM_RESTART': '1', 16:01:24 INFO - 'PAGER': '/bin/cat', 16:01:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:24 INFO - 'PWD': '/builds/slave/test', 16:01:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:24 INFO - 'SHELL': '/bin/bash', 16:01:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:24 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:24 INFO - 'USER': 'cltbld', 16:01:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:24 INFO - 'XPC_FLAGS': '0x0', 16:01:24 INFO - 'XPC_SERVICE_NAME': '0', 16:01:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:24 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:26 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:26 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 16:01:26 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 16:01:26 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 16:01:26 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 16:01:26 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 16:01:26 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 16:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01: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 16:01:27 INFO - Downloading docopt-0.6.1.tar.gz 16:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:27 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:27 INFO - Running setup.py install for blobuploader 16:01:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:28 INFO - Running setup.py install for requests 16:01:28 INFO - Running setup.py install for docopt 16:01:28 INFO - Successfully installed blobuploader requests docopt 16:01:28 INFO - Cleaning up... 16:01:28 INFO - Return code: 0 16:01:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:29 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')]} 16:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:29 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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:29 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 16:01:29 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 16:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:29 INFO - 'HOME': '/Users/cltbld', 16:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:29 INFO - 'LOGNAME': 'cltbld', 16:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:29 INFO - 'MOZ_NO_REMOTE': '1', 16:01:29 INFO - 'NO_EM_RESTART': '1', 16:01:29 INFO - 'PAGER': '/bin/cat', 16:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:29 INFO - 'PWD': '/builds/slave/test', 16:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:29 INFO - 'SHELL': '/bin/bash', 16:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:29 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:29 INFO - 'USER': 'cltbld', 16:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:29 INFO - 'XPC_FLAGS': '0x0', 16:01:29 INFO - 'XPC_SERVICE_NAME': '0', 16:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-yCB6X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-uRn7s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ihNGbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jVfIIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nihvfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:29 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-4cxB89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-rOuXOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HVij19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-TWDszW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-c9ur9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-UZJZIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7XuoM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-iiRLRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nyf7zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-kKJrHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:30 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-vGljZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:31 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-E5kX8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:31 INFO - Running setup.py install for manifestparser 16:01:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:31 INFO - Running setup.py install for mozcrash 16:01:31 INFO - Running setup.py install for mozdebug 16:01:31 INFO - Running setup.py install for mozdevice 16:01:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:01:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:31 INFO - Running setup.py install for mozfile 16:01:31 INFO - Running setup.py install for mozhttpd 16:01:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Running setup.py install for mozinfo 16:01:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Running setup.py install for mozInstall 16:01:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Running setup.py install for mozleak 16:01:32 INFO - Running setup.py install for mozlog 16:01:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Running setup.py install for moznetwork 16:01:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:32 INFO - Running setup.py install for mozprocess 16:01:32 INFO - Running setup.py install for mozprofile 16:01:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:33 INFO - Running setup.py install for mozrunner 16:01:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:33 INFO - Running setup.py install for mozscreenshot 16:01:33 INFO - Running setup.py install for moztest 16:01:33 INFO - Running setup.py install for mozversion 16:01:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:33 INFO - Cleaning up... 16:01:33 INFO - Return code: 0 16:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:33 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')]} 16:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:33 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')]} 16:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:33 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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:33 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 16:01:33 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 16:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:33 INFO - 'HOME': '/Users/cltbld', 16:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:33 INFO - 'LOGNAME': 'cltbld', 16:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:33 INFO - 'MOZ_NO_REMOTE': '1', 16:01:33 INFO - 'NO_EM_RESTART': '1', 16:01:33 INFO - 'PAGER': '/bin/cat', 16:01:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:33 INFO - 'PWD': '/builds/slave/test', 16:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:33 INFO - 'SHELL': '/bin/bash', 16:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:33 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:33 INFO - 'USER': 'cltbld', 16:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:33 INFO - 'XPC_FLAGS': '0x0', 16:01:33 INFO - 'XPC_SERVICE_NAME': '0', 16:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jI0PoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ThiD2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jGfl51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7yrR2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-YzcLS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-g36mr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Y4mFhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DJol6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-w5pLcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:34 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)) 16:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:34 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-KOzyHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HWMWXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-PhwYO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-jrkbZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-6sGzrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-VJkCCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Zo4x1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:35 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)) 16:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:35 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7nEFgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:35 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)) 16:01:35 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)) 16:01:35 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)) 16:01:35 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)) 16:01:35 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)) 16:01:35 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)) 16:01:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:35 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 16:01:35 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 16:01:35 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 16:01:35 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 16:01:35 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 16:01:35 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 16:01:38 INFO - Downloading blessings-1.6.tar.gz 16:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:38 INFO - Installing collected packages: blessings 16:01:38 INFO - Running setup.py install for blessings 16:01:39 INFO - Successfully installed blessings 16:01:39 INFO - Cleaning up... 16:01:39 INFO - Return code: 0 16:01:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:39 INFO - Reading from file tmpfile_stdout 16:01:39 INFO - Current package versions: 16:01:39 INFO - blessings == 1.6 16:01:39 INFO - blobuploader == 1.2.4 16:01:39 INFO - docopt == 0.6.1 16:01:39 INFO - manifestparser == 1.1 16:01:39 INFO - mozInstall == 1.12 16:01:39 INFO - mozcrash == 0.17 16:01:39 INFO - mozdebug == 0.1 16:01:39 INFO - mozdevice == 0.48 16:01:39 INFO - mozfile == 1.2 16:01:39 INFO - mozhttpd == 0.7 16:01:39 INFO - mozinfo == 0.9 16:01:39 INFO - mozleak == 0.1 16:01:39 INFO - mozlog == 3.1 16:01:39 INFO - moznetwork == 0.27 16:01:39 INFO - mozprocess == 0.22 16:01:39 INFO - mozprofile == 0.28 16:01:39 INFO - mozrunner == 6.11 16:01:39 INFO - mozscreenshot == 0.1 16:01:39 INFO - mozsystemmonitor == 0.0 16:01:39 INFO - moztest == 0.7 16:01:39 INFO - mozversion == 1.4 16:01:39 INFO - psutil == 3.1.1 16:01:39 INFO - requests == 1.2.3 16:01:39 INFO - wsgiref == 0.1.2 16:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:39 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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:39 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 16:01:39 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 16:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:39 INFO - 'HOME': '/Users/cltbld', 16:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:39 INFO - 'LOGNAME': 'cltbld', 16:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:39 INFO - 'MOZ_NO_REMOTE': '1', 16:01:39 INFO - 'NO_EM_RESTART': '1', 16:01:39 INFO - 'PAGER': '/bin/cat', 16:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:39 INFO - 'PWD': '/builds/slave/test', 16:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:39 INFO - 'SHELL': '/bin/bash', 16:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:39 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:39 INFO - 'USER': 'cltbld', 16:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:39 INFO - 'XPC_FLAGS': '0x0', 16:01:39 INFO - 'XPC_SERVICE_NAME': '0', 16:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 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)) 16:01:39 INFO - Cleaning up... 16:01:39 INFO - Return code: 0 16:01:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:39 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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:39 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 16:01:39 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 16:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:39 INFO - 'HOME': '/Users/cltbld', 16:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:39 INFO - 'LOGNAME': 'cltbld', 16:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:39 INFO - 'MOZ_NO_REMOTE': '1', 16:01:39 INFO - 'NO_EM_RESTART': '1', 16:01:39 INFO - 'PAGER': '/bin/cat', 16:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:39 INFO - 'PWD': '/builds/slave/test', 16:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:39 INFO - 'SHELL': '/bin/bash', 16:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:39 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:39 INFO - 'USER': 'cltbld', 16:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:39 INFO - 'XPC_FLAGS': '0x0', 16:01:39 INFO - 'XPC_SERVICE_NAME': '0', 16:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:39 INFO - Downloading/unpacking jsonschema 16:01:39 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 16:01:39 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 16:01:39 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 16:01:40 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 16:01:40 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 16:01:40 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 16:01:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:42 INFO - Downloading/unpacking functools32 (from jsonschema) 16:01:42 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 16:01:42 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 16:01:42 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 16:01:42 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 16:01:42 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 16:01:42 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 16:01:42 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:42 INFO - warning: no files found matching '*.txt' 16:01:42 INFO - no previously-included directories found matching 'build' 16:01:42 INFO - no previously-included directories found matching 'dist' 16:01:42 INFO - no previously-included directories found matching '.git*' 16:01:42 INFO - Installing collected packages: jsonschema, functools32 16:01:42 INFO - Running setup.py install for functools32 16:01:43 INFO - warning: no files found matching '*.txt' 16:01:43 INFO - no previously-included directories found matching 'build' 16:01:43 INFO - no previously-included directories found matching 'dist' 16:01:43 INFO - no previously-included directories found matching '.git*' 16:01:43 INFO - Successfully installed jsonschema functools32 16:01:43 INFO - Cleaning up... 16:01:43 INFO - Return code: 0 16:01:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:01:43 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')]} 16:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:43 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')]} 16:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:43 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 0x1075d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb71d71300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, '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.5gQmjImjYv/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.g27med5UsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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 16:01:43 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 16:01:43 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 16:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:43 INFO - 'HOME': '/Users/cltbld', 16:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:43 INFO - 'LOGNAME': 'cltbld', 16:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:43 INFO - 'MOZ_NO_REMOTE': '1', 16:01:43 INFO - 'NO_EM_RESTART': '1', 16:01:43 INFO - 'PAGER': '/bin/cat', 16:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:43 INFO - 'PWD': '/builds/slave/test', 16:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:43 INFO - 'SHELL': '/bin/bash', 16:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:01:43 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:43 INFO - 'USER': 'cltbld', 16:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:43 INFO - 'XPC_FLAGS': '0x0', 16:01:43 INFO - 'XPC_SERVICE_NAME': '0', 16:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:43 INFO - Downloading/unpacking flake8 16:01:43 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 16:01:43 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 16:01:43 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 16:01:43 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 16:01:43 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 16:01:43 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 16:01:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:01:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:01:45 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 16:01:45 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 16:01:45 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 16:01:45 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 16:01:45 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 16:01:45 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 16:01:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:01:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 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 16:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:01:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:47 INFO - no previously-included directories found matching 'docs/_build' 16:01:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:01:47 INFO - Running setup.py install for pep8 16:01:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:47 INFO - no previously-included directories found matching 'docs/_build' 16:01:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:01:47 INFO - Cleaning up... 16:01:47 INFO - Return code: 0 16:01:47 INFO - Running post-action listener: _resource_record_post_action 16:01:47 INFO - Running post-action listener: _start_resource_monitoring 16:01:47 INFO - Starting resource monitoring. 16:01:47 INFO - ##### 16:01:47 INFO - ##### Running install step. 16:01:47 INFO - ##### 16:01:47 INFO - Running pre-action listener: _resource_record_pre_action 16:01:47 INFO - Running main action method: install 16:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:47 INFO - Reading from file tmpfile_stdout 16:01:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:47 INFO - Reading from file tmpfile_stdout 16:01:47 INFO - Output received: 16:01:47 INFO - Usage: mozinstall [options] installer 16:01:47 INFO - Options: 16:01:47 INFO - -h, --help show this help message and exit 16:01:47 INFO - -d DEST, --destination=DEST 16:01:47 INFO - Directory to install application into. [default: 16:01:47 INFO - "/builds/slave/test"] 16:01:47 INFO - --app=APP Application being installed. [default: firefox] 16:01:47 INFO - mkdir: /builds/slave/test/build/application 16:01:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:02:10 INFO - Reading from file tmpfile_stdout 16:02:10 INFO - Output received: 16:02:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:02:10 INFO - Running post-action listener: _resource_record_post_action 16:02:10 INFO - ##### 16:02:10 INFO - ##### Running run-tests step. 16:02:10 INFO - ##### 16:02:10 INFO - Running pre-action listener: _resource_record_pre_action 16:02:10 INFO - Running main action method: run_tests 16:02:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:02:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:02:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:02:10 INFO - 2016-05-09 16:02:10.385 screenresolution[2191:24515] starting screenresolution argv=screenresolution get 16:02:10 INFO - 2016-05-09 16:02:10.388 screenresolution[2191:24515] Display 0: 1600x1200x32@60 16:02:10 INFO - 2016-05-09 16:02:10.394 screenresolution[2192:24518] starting screenresolution argv=screenresolution list 16:02:10 INFO - Available Modes on Display 0 16:02:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:02:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:02:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:02:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:02:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:02:10 INFO - Intel Iris: 16:02:10 INFO - Chipset Model: Intel Iris 16:02:10 INFO - Type: GPU 16:02:10 INFO - Bus: Built-In 16:02:10 INFO - VRAM (Dynamic, Max): 1536 MB 16:02:10 INFO - Vendor: Intel (0x8086) 16:02:10 INFO - Device ID: 0x0a2e 16:02:10 INFO - Revision ID: 0x0009 16:02:10 INFO - Displays: 16:02:10 INFO - Display: 16:02:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:02:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:02:10 INFO - Display Serial Number: 1600x1200 60 16:02:10 INFO - Main Display: Yes 16:02:10 INFO - Mirror: Off 16:02:10 INFO - Online: Yes 16:02:10 INFO - Rotation: Supported 16:02:10 INFO - Return code: 0 16:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:10 INFO - Python 2.7.3 16:02:10 INFO - Return code: 0 16:02:10 INFO - grabbing minidump binary from tooltool 16:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:10 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 0x107478d30>, '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 0x1072dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10746fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:10 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 16:02:10 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 16:02:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:10 INFO - Return code: 0 16:02:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:02:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:02:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:02:11 INFO - Return code: 0 16:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:02:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5gQmjImjYv/Render', 16:02:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:11 INFO - 'HOME': '/Users/cltbld', 16:02:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:11 INFO - 'LOGNAME': 'cltbld', 16:02:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:11 INFO - 'MOZ_NO_REMOTE': '1', 16:02:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:11 INFO - 'NO_EM_RESTART': '1', 16:02:11 INFO - 'PAGER': '/bin/cat', 16:02:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:11 INFO - 'PWD': '/builds/slave/test', 16:02:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:11 INFO - 'SHELL': '/bin/bash', 16:02:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g27med5UsH/Listeners', 16:02:11 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 16:02:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:11 INFO - 'USER': 'cltbld', 16:02:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:11 INFO - 'XPC_FLAGS': '0x0', 16:02:11 INFO - 'XPC_SERVICE_NAME': '0', 16:02:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:02:12 INFO - mozversion application_buildid: 20160509134909 16:02:12 INFO - mozversion application_changeset: beaf4d37d01c85e87cee2682604083a889beeb29 16:02:12 INFO - mozversion application_display_name: Firefox 16:02:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:12 INFO - mozversion application_name: Firefox 16:02:12 INFO - mozversion application_remotingname: firefox 16:02:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:02:12 INFO - mozversion application_vendor: Mozilla 16:02:12 INFO - mozversion application_version: 47.0 16:02:12 INFO - mozversion platform_buildid: 20160509134909 16:02:12 INFO - mozversion platform_changeset: beaf4d37d01c85e87cee2682604083a889beeb29 16:02:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:02:12 INFO - mozversion platform_version: 47.0 16:02:12 INFO - using testdate: 1462834932 16:02:12 INFO - actual date: 1462834932 16:02:12 INFO - starting webserver on 'localhost:56147' 16:02:12 INFO - SUITE-START | Running 2 tests 16:02:12 INFO - TEST-START | dromaeo_css 16:02:12 INFO - operating with platform_type : mac_ 16:02:12 INFO - Initialising browser for dromaeo_css test... 16:02:12 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmp5wN0vx/profile http://localhost:56147/getInfo.html) 16:02:14 INFO - PROCESS | 2210 | __metrics Screen width/height:1600/1200 16:02:14 INFO - PROCESS | 2210 | colorDepth:24 16:02:14 INFO - PROCESS | 2210 | Browser inner width/height: 1024/689 16:02:14 INFO - PROCESS | 2210 | __metrics 16:02:14 ERROR - PROCESS | 2210 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:02:15 INFO - TEST-INFO | 2210: exit 0 16:02:15 INFO - Browser initialized. 16:02:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:15 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmp5wN0vx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:27 INFO - PROCESS | 2214 | RSS: Main: 167903232 16:02:27 INFO - PROCESS | 2214 | 16:03:16 INFO - PROCESS | 2214 | 1462834996655 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] 16:05:27 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56147/tests/dromaeo/cssquery-ext.html) 16:05:28 INFO - PROCESS | 2214 | RSS: Main: 181309440 16:05:28 INFO - PROCESS | 2214 | 16:08:30 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-ext.html (next: http://localhost:56147/tests/dromaeo/cssquery-jquery.html) 16:08:30 INFO - PROCESS | 2214 | RSS: Main: 192491520 16:08:30 INFO - PROCESS | 2214 | 16:11:32 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56147/tests/dromaeo/cssquery-mootools.html) 16:11:33 INFO - PROCESS | 2214 | RSS: Main: 193658880 16:11:33 INFO - PROCESS | 2214 | 16:14:34 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56147/tests/dromaeo/cssquery-prototype.html) 16:14:35 INFO - PROCESS | 2214 | RSS: Main: 196997120 16:14:35 INFO - PROCESS | 2214 | 16:17:38 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56147/tests/dromaeo/cssquery-yui.html) 16:17:38 INFO - PROCESS | 2214 | RSS: Main: 196239360 16:17:38 INFO - PROCESS | 2214 | 16:20:40 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:56147/tests/dromaeo/cssquery-yui.html (next: http://localhost:56147/tests/dromaeo/cssquery-dojo.html) 16:20:40 INFO - PROCESS | 2214 | RSS: Main: 201797632 16:20:40 INFO - PROCESS | 2214 | 16:20:40 INFO - PROCESS | 2214 | __start_tp_report 16:20:40 INFO - PROCESS | 2214 | _x_x_mozilla_page_load 16:20:40 INFO - PROCESS | 2214 | _x_x_mozilla_page_load_details 16:20:40 INFO - PROCESS | 2214 | |i|pagename|runs| 16:20:40 INFO - PROCESS | 2214 | |0;dojo.html;3538.5930617978925;3658.798766067866;3680.4847321374996;3704.9814750926244;3756.8872933811995;5934.546036221121;5993.700314984244;5998.400159984005;6018;6053.031514957607;5932.644041357522;5992.250968628921;6037.335893051761;6081.847953801157;6116.296625888013;5346.1713434417725;5376.973115134419;5417.485338892819;5463.235147079412;5503.174523821419;5360.65155764876;5467.20725494803;5468.070428027245;5477.808276710316;5477.808276710316;5357.919631205535;5383.192521121843;5383.623146379755;5390.245365648812;5431.21247419124;5459.727013649342;5472.781088756445;5478.780848766045;5484.341878974528;5551.278333816598;5227.686338819683;5310.44240354761;5406.8918621627345;5454.836354909359;5485.6982865942355;4441.977790111061;5867;5885.970570147165;5903.321118071433;5981.970090149522;6263.624182549016;6301.873962520724;6306.495480361606;6330.556861019731;6330.936690633081;5472.945270547323;6345.302016778151;6366.045093236005;6388.265349484822;6391.169148010776;6000.309964354112;6026.969865150646;6117.431594453911;6132.478739307165;6144.341027922525;6486.578372405778;6487.870242595121;6492.805215843532;6512.674366281762;6514.9348506514325;6262.968685156545;6295.18162638854;6313.40022697843;6332.52506062038;6345.270293916166;6280.2777680566405;6304.275008374096;6326.778562750374;6366.26787919386;6392.840178995562;6226.719797609118;6255.74977000924;6275.466585340206;6282.623042617458;6293;6201.81394558155;6226.40849119333;6295.024271237966;6301.905471417932;6310.652914089677;4337.631301339421;5091.541761241506;5093.668911520739;5107.438181799999;5144.125498665236;4530.29780384041;4536.818527258873;4564.885877853014;4575.084983003413;4602.88492787683;5996.2504686914135;6084.148219249309;6091.964366057781;6120.051392034242;6155.753769849156;6219.440250377397;6287.685615719196;6299.275583307886;6354.936450635434;6371.203599550056;6088.908666370008;6094.39056094387;6118.388161183846;6119.479844213202;6171.444569988723;5526.861828454241;5576.7211639417865;5605.859853503695;5621.241132447068;5621.409751976065;6473.967630161819;6521.8695626088165;6564.343565643398;6567.934320656828;6611.636360000054;5673.77304907799;5731.914021289601;6339.936600633934;6374.74501019954;6402.6066184922065;6340.4293613575;6448.258450278278;6511.34886511364;6543.574667646588;6569.80290591283;6284.811455656338;6285.811425657238;6300.842478938063;6309.747610095545;6318.684065796784;4677.812887484599;6342.270638876404;6346.301906790157;6357.4596159326975;6373.6175829450385;6163.722632481638;6175.073738939195;6227.221597300338;6251.624902505864;6256.968715156395;6208.596441231305;6242.843928901813;6258.530610204344;6263.09185168139;6288.811335659938;6079.483243924316;6229.314775374796;6239.251289845248;6250.749970001149;6258.780942666985;6169.444749972524;6214.378562143749;6236.6258024518675;6257.561970662192;6276.905846412216;6251.062340648939;6259.061140828912;6261.24865016201;6283.151774510383;6310.684465776784 16:20:41 INFO - PROCESS | 2214 | |1;ext.html;461.9006913513596;606.9696515174242;607.441154138193;616.9969150154249;665.8535122273099;38839.02902427437;39492.40761388574;39525.80237098814;39579.40630890539;39648.60351396485;36629.81685091578;40200.59799402005;42283.15433691324;42879.78560107195;43122.35316470255;9805.166560842319;10033.147182489498;10059.195264378868;10059.547320370564;10067.395956242612;9909.207263418944;10001.549930253119;10077.24420668449;10121.544530496109;10121.848172277385;10065.396076235413;10126.797464050715;10142.18862490999;10151;10162.23783216258;8593.441426307301;9997.950010249902;10050.04524570172;10127.493625318704;10132.189424845994;9848.90151098487;9943.353682010718;9962.501874906298;9983.351082179635;9986.900130998669;34563;40580.1883962322;40784.592154078375;40834;41117.588824111976;3154.41643295991;3364.49532570114;3460.7750496217664;3970.5235371755575;4059.5737447567876;27047.1885843425;27533;27738.861305693543;27812.721872781214;28571.57142642862;2794.594783756344;2832.391035927265;2858.1854171561004;2890.7976441649093;2924.947019073132;355220;356982.2150889229;357768;358553;360467;48251.79370515765;48682;48764.512354875995;48990.510094899306;67066.32933670699;45569.316460253125;46732.53267467282;46925.061498769835;46953.765231173624;47086.52913470822;17343.826561734473;17499.475015749547;17533.21100550478;17560.209790559198;17588.560285992953;13693;13809.585712428643;13900.652483687989;13930.37313320903;14253.78619320711;15125;15175.924120379328;15477.922610386877;15567.988080774714;15624.843751562566;6540.351157781106;6650.401463868178;6695.397414232742;6701.229358623723;6702.631355275409;972.7568107973007;1081.4862940103387;1147.3173461790223;1147.9610952088374;1187.1511869013696;24352.512949740907;31328.37343253122;32717.67282327194;33146;33294.8335258327;1097.5664612478026;1138.2260063156966;1163.6567212672282;1165.0213820390743;1208.2146604707011;13584.320783960762;14814.40742370293;15243;15509.84490155084;15775.368985240462;599405;657231;659344.7032764805;661271.0809337863;664317;62196.68901655553;62504.68747656233;62516.06225906615;62642.37357626457;62701.372986269555;1541.2524925411167;1558.7817705521236;1583.065991065277;1585.0727324515058;1586.8333824948445;30580.694193057785;30927;30953.535696964114;31050.68949310478;31495.68504315019;53894.73052634712;54107.45892541182;54203.72898135484;54331;54600.72699636476;508795;511024.44487777323;512297;513277;513801;33711;34860.9541713749;34881.65118348784;35234.11914702153;35293.764718234735;46192;46553.53446465492;46658.833529162046;46841.06317873691;46854;28962.565561516174;37834.86495405142;38589.4211586832;38923.80538097292;39657.80171099126;30146.84926575353;37138.814305928296;37755.811220944815;37767;38197.80901095477;37126;37977.62022379851;38147.61852381441;38705.612943871325;38721.41917871178;32447.513287301183;33458.49812252867;33472.330553389285;33568.83215583907;33775.49336759902;25418.110366137098;25611.231663050137;25628;25955.351116222246;25966.57183854906 16:20:41 INFO - PROCESS | 2214 | |2;jquery.html;325.1400046876013;325.54748899030346;369.3886617647794;374.73768362146507;379.9797543595445;19913.103910324033;20055.19779208832;21304.4673883153;21338.506304558687;21367.99999999998;20137.093830777612;20483.38549843507;20693.68959465609;21169.894150529224;21193.682094768592;5793.855153621172;6011.789587364443;6048.2137322148055;6054.48536874364;6072.301685306202;4345;4846.927296090562;5954.285485741717;6700.363465470772;6791.626460544693;6693.297203793604;6693.297203793604;6707.1616047994;6721.26066132725;6729.427998620124;6550.344965503436;6609.306022867602;6681.498887583451;6682.632455214961;6703.865922681519;5661.433856614347;5673.546116310686;5678;5744.994625940443;5782.392848750905;26426.86786566074;26458.86770566135;26549.07078252271;26689.599656005175;26893.462130757274;1929.8552608554414;2234.1733558583264;2297.5519773644146;2578.690557133156;2664.640273563083;14813;15200.46798362052;15313.464028759052;15428.151451670154;15511.301991410413;1719.5013446100616;1772.8315809998157;1814.8185181481747;1850.9722354164699;1871.3824437935584;78917.21082789155;80508.99999999942;81471.59264203641;97601.5119924403;100143.9985600142;11165.330080195214;11366.090712743126;11877.406129693654;11896.04831613469;11997.580084696994;13111.344432778324;13790.862091378958;14408.567742967727;14782.926085369505;14852.480163194236;7480.812979675443;9263.842019747532;9322.906770932204;9371.297152713574;9392.8591071134;9390.671326503676;9419.199368053793;9548.809023819624;9586;9646.807063858683;4191.287481128215;4429.693240494062;4627.95372046282;4641.582257596765;4641.675082744176;1938.265252598916;1993.063260267672;1997.7702564205013;2022.322521955132;2029.52306208041;928.4939707859232;935.4574346878794;982.381099907054;1044.154235069596;1063.3991794636006;19254.22983080689;20044.59910801805;20186.798132018786;20210.494737631678;20420.0810963507;901.5987885390938;1014.2190513304714;1022.5347466902541;1063.723431907694;1096.2928910852456;10734.570617175226;10996.395198264012;11000.889991099986;11058.655436156436;11109.166812488935;578286.3257051148;654952;659993;675470;693667;115938;125758.37120814521;127791.36104319606;129226;132087;998.825205589019;1046.4924511611862;1094.6825420628088;1095.7534554725282;1104.282216559243;18297.81702182961;18544.721829172304;18776.342828000954;18805.435836924913;18948.810511894706;44157.77921110502;50787.746061269456;51208.23187652263;51308.97382052263;54301.72849135729;74440.62779686067;79481.60259198667;80317.3936521278;80897;81136.59431702804;7965.721199757981;8174.182581741778;8310.459820111915;8316.750497485085;8327.875081873655;12131.21147125434;13202.80195797083;13473.258970756702;13497.595072147851;13570.846478049081;11302.43487825622;11367.829482557934;11441.713957151138;11456.140789440658;11472.082233421474;11277.774444511228;11557.537698491966;11579.536818527502;11697.883021169679;11782.82325765097;11914.821277681016;11929.880701193224;12000.699982500508;12192.634220973385;12312.507499699912;8144;8358.832823343377;8425.789355266168;8428.45215061019;8638.308935285288;8706.608202631023;11114.16643751738;11934.641960741192;11984.520619175484;12149.149559530748 16:20:41 INFO - PROCESS | 2214 | |3;mootools.html;1643.7123503386908;1651.8430749078836;1979.9307024254153;2059.5468996820696;2075.2217918280644;8364.498130112197;9045.1407116324;9094.499802510867;9272.953635231823;9348.532573371338;9022.278217742582;9030.916290045203;9075.228605568518;9111.635534578625;9120.817583648322;1996.7703714072923;2435.6833611630464;2594.701609314934;2600.6099085137284;2617.7251388604113;2533.3160046787357;2586.8447893126377;2603.1149409200866;2604.1146010356474;2613.255222261656;2588.404666926608;2594.4681340325283;2627.290631529486;2636.894524219029;2641.656584644003;2600.06397696829;2621.423286876884;2621.5412302846926;2625.7242989486117;2648.20553833851;2589.3526618345413;2602.778763805079;2623.6720409948757;2624.829386089898;2630.552806022981;9360.719178424659;9380.108889655472;9383.624655013791;9395.62417503299;9402.106799854002;5776.653400795965;5798.768049278066;5987.670678112702;5990.820275391745;5995.2206213192;3665.1020499977676;3715.294094122108;3731.6081811409954;3808.638179372955;3814.6566808987045;1052.4001319248032;1069.4118234970736;1073.1843798712957;1111.3054341036852;1112.821948488246;12103.576374826838;12281.385930703518;12377.876221237762;12409.06931980105;12447.564335248222;4220.556841531595;4999.175136102575;5031.698098114125;5087.923681144785;5123.666961647556;10387.896121038844;10502.789944201073;10514;10527;10533.473326333653;5710.5146062585145;5717.656940583578;5738.368779434259;5745.3105627324985;5770.19217309577;4642.442906851199;5129.410117836422;5207.114790485626;5261.552768014762;5269.209618557247;4125.617917997504;4139.710220284551;4160.292750232467;4169.937450938239;4172.666186705117;1373.4231622718482;1376.029898921258;1386.6325423762712;1390.6731917999261;1398.4965412451509;1245.2590708528412;1403.0459287684268;1448.4351103069812;1452.3899962015978;1462.510059130182;8442.197991190827;8542.615582298811;8561.914380856237;8569.657213711382;8576.142385761374;536.493014101678;544.8583368324264;547.9397266300704;553.0432352031008;555.3169601390313;6214.347493513116;6303.212098487689;6345.746170153235;6376.29860715321;6382.297947225801;10822.67531974042;11091.057260132819;11107.83338249927;11147.777044459066;11153.330800151854;10556.313839600401;10659.840102398315;10788.51451684676;11017.614383496539;11032.779344413068;8672.089430609822;8699.695510657097;8751.56242187888;8794.516301603473;8835.98386185597;7986.840263194587;8021.197880212166;8066.435349525477;8103.878441823495;8200.466969647192;9612.951935240279;9970.30207885441;9992.65025724096;10040.598376064876;10049.598016079275;10109.595616175271;10235.232357573062;10346.793064138825;10377.066064054272;10402.58389664405;7525.887111693439;7722.768316950501;7735.6518956648215;7793.142754297136;7823.200663847233;8424.789380265542;8478.576071196292;8494.362922780692;8556.957215213884;8591.183837535424;7498.400127989857;7554.848903021799;7604.163542010485;7605.961970190335;7840.529568225925;6232.657203853832;7586.658600362886;7608.733694320672;7633.465657403928;7713.92286077132;7954.284114429729;7999.880001799861;8011.038675358995;8018.198180181935;8062.596870156586;7213.278672132745;7225.277472252733;7366.77899663011;7371.41028717712;7384.150822655249;7415.666295016845;7467.813304667427;7485.7754267372065;7494.775156745089;7496.587687677012 16:20:41 INFO - PROCESS | 2214 | |4;prototype.html;331.4481388488167;334.1395905543225;339.4467018759423;339.9235172086279;343.3082339086741;5888.028475301581;6623.07276981223;6791.913293872982;6852.931470685292;6866.347696968793;6759.45924326054;6776.627285499296;6808;6819;6837.17953845538;3897.2400381925395;4841.7337046462435;4989.600831933455;5037.974810125963;5092.949070509294;5011.924821127686;5016.8996620067755;5024.196128619422;5031.446540880518;5034.395872495287;4946.530079642428;4973.278874563186;4973.626977976648;4975.7263350515705;4977.800887964477;4927.7536123193695;4969.82605608802;4988.201887697969;4994.800207991676;4996.300517927493;3648.6898613617873;4249.638780703613;4331.566843315643;4351.28203846365;4352.412424322708;6244.875102497925;6612.570182938141;6633.2040155181685;6633.900491492584;6655.534112612119;5860.384659610722;5867.354590994987;5870.911936320958;5884.5582832205955;5894.381089985575;7290.854182916365;7300.780976570712;7300.96349518249;7303.7078516859265;7314.195438501761;4720.811167553294;4722.952770472286;4735.763211839394;4749.1926372516755;4749.62003039756;7282.344588986964;7643.694252229904;7732.729354472623;7742.341900938427;7749.263819937097;4590.977045114753;4648.604868586208;4713.67004309695;4728.905421891543;4740.3837501124635;3929.2730844793805;4810.975945120322;4875.829345972874;4880.951190488121;4895.388076490439;5807.535397168216;5849.444302791228;5860.941390586039;5879.059350503984;5880.588358814842;7085.645717714094;7317.378022868116;7336.889946650805;7340.339369456775;7354.227806080285;1403.4035534897628;1436.6623843396794;1689.1723055702616;1692.1370101248451;1693.2888186961507;908.336914052732;1043.12377602814;1077.0737166037202;1088.7441451258949;1091.170710260208;6810.659467026629;7104;7107.502474826816;7128.928710712827;7145.285471452813;7571.734989275349;7572.697092116254;7574.886376704354;7586.81032974169;7614.314711675976;5513.448655134534;5694.316681998187;6917.066196063568;6964.756233531802;6977.232504424509;3976.1252524444576;4008.5590585035625;4014.8996275093355;4022.336314508132;4040.111175541435;7636.885446718304;7667.961660191663;7991;8042.356611471068;8053.791931210365;7876.251756083163;7929.920700793034;7961.601919903982;7967.0439547253545;7990.9200907991335;8008.71969481077;8022.638981245858;8025.919740802634;8044.994375703037;8063.959680201561;7350.816229594303;7581.01446811933;7637.618119093912;7682.846343073219;7694.1536430993665;7437.962810185914;7452.403807695263;7489.737859174903;7494.887576686245;7532.380538184317;7952.6421311042295;7993.200679931961;7993.320567751573;7995.200479951958;8018.438709290293;4748.691335063209;4804.279358096313;4804.495527969513;4823.252395878644;4846.80612775485;7283.817904552428;7402;7585.848283034419;7640.808979775327;7654.885176722465;7364.926350736639;7376.7049318026675;7380.520266182681;7381.520201186906;7391.113066432063;7328.487005909536;7337.3396394322635;7375.741849035258;7392.112946446246;7393.778186654194;6971.407430368476;7207.639618018973;7224.566526008456;7237.529560578546;7266.527675701062;7291.781246562611;7331.596762178131;7358.337749602561;7362.116546014512;7396.4822462429265;7204.819879502845;7216.206217315986;7228.49400541957;7231.63841807897;7243.3843123333 16:20:41 INFO - PROCESS | 2214 | |5;yui.html;688.8209065642932;782.3350152370482;786.6578038553226;803.4737247103146;815.9469634473757;15623.984441011326;15666.53000409988;15844.84155158448;15888.126153061577;15904.920475397636;14700.779488307684;14777.556673299792;14798.186099764509;14798.556043318691;14807.111573305609;808.9919100808976;961.4375590279694;983.2772911909741;993.8409854423294;996.0487734213845;784.9725259615915;992.6773798515475;993.7515621094726;1002.8946960569144;1004.7739258666778;943.6555657185147;1010.8433192855119;1065.408698172514;1067.2209287220335;1068.529846867376;953.3469573342283;1047.9685609431729;1057.4659796802605;1058.222206678091;1060.1095080132648;765.74730338988;786.7482405630201;790.6837265093951;791.3076058448858;797.5135167547792;15302.540923772305;15561.766573501407;15583.922080389639;15591.922040389725;15607.531774046796;12435.75128497434;13428.19430834153;13476.86523134766;13565.389557469838;13573.796393054112;10338.276320657556;10359.27485076045;10412.219083568763;10516.053555180071;10841.403722795243;3573.767705099186;3590.5152804371337;3636.1273294409416;3720.3489389356755;3879.1853710720784;82750;83029;85895;86243;86910.565447173;9871.40771553709;9936.056074672895;10005;10055.949720251352;10225.846612300673;23540;23562.939667714993;23574.528509429714;23582.820858956984;23664;7618.733344332922;7625.084989801259;7688.346490548366;7846.411519136088;7888.447808653454;4139.461869956946;4203.327467605169;4213.136307057046;4250.852269887113;4395.7142785718825;3247.399231142246;3759.2481503698823;3802.866899658499;3813.599572044951;3834.846606135779;670.8624731929942;673.8551211489455;674.6727836999052;678.067656971664;685.8868286732733;613.1109890658474;616.0820377637289;624.2633692243197;633.6198281031344;634.9809505714836;8447;8533.701320453754;8630.568471576396;8695.652173912973;8746.212840844355;582.3506789929198;586.393083158937;602.9698515074228;625.5808608232495;631.703099543214;3956.287868183697;3968.1270120573427;3974.6224108709625;4075.449814275035;4194.077302993336;93909.0609093914;93953;101198.49400753096;103091.45362819564;103725;80256;81725;83628.74556881652;84509;84572;72038.63980680169;72752.63623681848;72990.63504682548;73354.2664573358;73507;7369.447291453055;8138.819871118773;8426.4944103354;8552.230299273095;8928.839250897341;50152.749236253585;50240.748796255786;50636;50714;51517.742411287705;61594.69202653958;62340.12979610619;66536;72238.55522889618;73692;10839.566417343218;11277.71805704864;11672.124590655565;11673.883261167279;11679.76640467203;9879.901200987899;12183.939080304543;12286.139970202357;12300;12821;11292.717682058013;11444.198906076495;11454.312741235553;11508.827367589325;11653.417329133339;11638.243514171552;11798.823017654913;11823.46794394237;12110.152289340014;12189.024878009915;9369.81260374775;9466.574004169692;11356.375399352784;11603.941980290045;11612.303261804318;9725;9995.400275983464;10100.84848727255;10162.441065741456;10192;7654.502457340255;9993.650222242186;10149.89761634968;10228.437435941094;10240.846387304346 16:20:41 INFO - PROCESS | 2214 | __end_tp_report 16:20:41 INFO - PROCESS | 2214 | __start_cc_report 16:20:41 INFO - PROCESS | 2214 | _x_x_mozilla_cycle_collect,352 16:20:41 INFO - PROCESS | 2214 | __end_cc_report 16:20:41 INFO - PROCESS | 2214 | __startTimestamp1462836040993__endTimestamp 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | ------- Summary: start ------- 16:20:41 INFO - PROCESS | 2214 | Number of tests: 6 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#0] dojo.html Cycles:165 Average:5907.97 Median:6175.07 stddev:635.74 (10.3%) stddev-sans-first:609.92 16:20:41 INFO - PROCESS | 2214 | Values: 3538.6 3658.8 3680.5 3705.0 3756.9 5934.5 5993.7 5998.4 6018.0 6053.0 5932.6 5992.3 6037.3 6081.8 6116.3 5346.2 5377.0 5417.5 5463.2 5503.2 5360.7 5467.2 5468.1 5477.8 5477.8 5357.9 5383.2 5383.6 5390.2 5431.2 5459.7 5472.8 5478.8 5484.3 5551.3 5227.7 5310.4 5406.9 5454.8 5485.7 4442.0 5867.0 5886.0 5903.3 5982.0 6263.6 6301.9 6306.5 6330.6 6330.9 5472.9 6345.3 6366.0 6388.3 6391.2 6000.3 6027.0 6117.4 6132.5 6144.3 6486.6 6487.9 6492.8 6512.7 6514.9 6263.0 6295.2 6313.4 6332.5 6345.3 6280.3 6304.3 6326.8 6366.3 6392.8 6226.7 6255.7 6275.5 6282.6 6293.0 6201.8 6226.4 6295.0 6301.9 6310.7 4337.6 5091.5 5093.7 5107.4 5144.1 4530.3 4536.8 4564.9 4575.1 4602.9 5996.3 6084.1 6092.0 6120.1 6155.8 6219.4 6287.7 6299.3 6354.9 6371.2 6088.9 6094.4 6118.4 6119.5 6171.4 5526.9 5576.7 5605.9 5621.2 5621.4 6474.0 6521.9 6564.3 6567.9 6611.6 5673.8 5731.9 6339.9 6374.7 6402.6 6340.4 6448.3 6511.3 6543.6 6569.8 6284.8 6285.8 6300.8 6309.7 6318.7 4677.8 6342.3 6346.3 6357.5 6373.6 6163.7 6175.1 6227.2 6251.6 6257.0 6208.6 6242.8 6258.5 6263.1 6288.8 6079.5 6229.3 6239.3 6250.7 6258.8 6169.4 6214.4 6236.6 6257.6 6276.9 6251.1 6259.1 6261.2 6283.2 6310.7 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#1] ext.html Cycles:180 Average:64563.37 Median:195256.88 stddev:138933.09 (71.2%) stddev-sans-first:139239.47 16:20:41 INFO - PROCESS | 2214 | Values: 461.9 607.0 607.4 617.0 665.9 38839.0 39492.4 39525.8 39579.4 39648.6 36629.8 40200.6 42283.2 42879.8 43122.4 9805.2 10033.1 10059.2 10059.5 10067.4 9909.2 10001.5 10077.2 10121.5 10121.8 10065.4 10126.8 10142.2 10151.0 10162.2 8593.4 9998.0 10050.0 10127.5 10132.2 9848.9 9943.4 9962.5 9983.4 9986.9 34563.0 40580.2 40784.6 40834.0 41117.6 3154.4 3364.5 3460.8 3970.5 4059.6 27047.2 27533.0 27738.9 27812.7 28571.6 2794.6 2832.4 2858.2 2890.8 2924.9 355220.0 356982.2 357768.0 358553.0 360467.0 48251.8 48682.0 48764.5 48990.5 67066.3 45569.3 46732.5 46925.1 46953.8 47086.5 17343.8 17499.5 17533.2 17560.2 17588.6 13693.0 13809.6 13900.7 13930.4 14253.8 15125.0 15175.9 15477.9 15568.0 15624.8 6540.4 6650.4 6695.4 6701.2 6702.6 972.8 1081.5 1147.3 1148.0 1187.2 24352.5 31328.4 32717.7 33146.0 33294.8 1097.6 1138.2 1163.7 1165.0 1208.2 13584.3 14814.4 15243.0 15509.8 15775.4 599405.0 657231.0 659344.7 661271.1 664317.0 62196.7 62504.7 62516.1 62642.4 62701.4 1541.3 1558.8 1583.1 1585.1 1586.8 30580.7 30927.0 30953.5 31050.7 31495.7 53894.7 54107.5 54203.7 54331.0 54600.7 508795.0 511024.4 512297.0 513277.0 513801.0 33711.0 34861.0 34881.7 35234.1 35293.8 46192.0 46553.5 46658.8 46841.1 46854.0 28962.6 37834.9 38589.4 38923.8 39657.8 30146.8 37138.8 37755.8 37767.0 38197.8 37126.0 37977.6 38147.6 38705.6 38721.4 32447.5 33458.5 33472.3 33568.8 33775.5 25418.1 25611.2 25628.0 25955.4 25966.6 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#2] jquery.html Cycles:180 Average:35951.89 Median:11801.09 stddev:107999.85 (915.2%) stddev-sans-first:108269.68 16:20:41 INFO - PROCESS | 2214 | Values: 325.1 325.5 369.4 374.7 380.0 19913.1 20055.2 21304.5 21338.5 21368.0 20137.1 20483.4 20693.7 21169.9 21193.7 5793.9 6011.8 6048.2 6054.5 6072.3 4345.0 4846.9 5954.3 6700.4 6791.6 6693.3 6693.3 6707.2 6721.3 6729.4 6550.3 6609.3 6681.5 6682.6 6703.9 5661.4 5673.5 5678.0 5745.0 5782.4 26426.9 26458.9 26549.1 26689.6 26893.5 1929.9 2234.2 2297.6 2578.7 2664.6 14813.0 15200.5 15313.5 15428.2 15511.3 1719.5 1772.8 1814.8 1851.0 1871.4 78917.2 80509.0 81471.6 97601.5 100144.0 11165.3 11366.1 11877.4 11896.0 11997.6 13111.3 13790.9 14408.6 14782.9 14852.5 7480.8 9263.8 9322.9 9371.3 9392.9 9390.7 9419.2 9548.8 9586.0 9646.8 4191.3 4429.7 4628.0 4641.6 4641.7 1938.3 1993.1 1997.8 2022.3 2029.5 928.5 935.5 982.4 1044.2 1063.4 19254.2 20044.6 20186.8 20210.5 20420.1 901.6 1014.2 1022.5 1063.7 1096.3 10734.6 10996.4 11000.9 11058.7 11109.2 578286.3 654952.0 659993.0 675470.0 693667.0 115938.0 125758.4 127791.4 129226.0 132087.0 998.8 1046.5 1094.7 1095.8 1104.3 18297.8 18544.7 18776.3 18805.4 18948.8 44157.8 50787.7 51208.2 51309.0 54301.7 74440.6 79481.6 80317.4 80897.0 81136.6 7965.7 8174.2 8310.5 8316.8 8327.9 12131.2 13202.8 13473.3 13497.6 13570.8 11302.4 11367.8 11441.7 11456.1 11472.1 11277.8 11557.5 11579.5 11697.9 11782.8 11914.8 11929.9 12000.7 12192.6 12312.5 8144.0 8358.8 8425.8 8428.5 8638.3 8706.6 11114.2 11934.6 11984.5 12149.1 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#3] mootools.html Cycles:180 Average:6300.68 Median:5265.38 stddev:3313.55 (62.9%) stddev-sans-first:3304.36 16:20:41 INFO - PROCESS | 2214 | Values: 1643.7 1651.8 1979.9 2059.5 2075.2 8364.5 9045.1 9094.5 9273.0 9348.5 9022.3 9030.9 9075.2 9111.6 9120.8 1996.8 2435.7 2594.7 2600.6 2617.7 2533.3 2586.8 2603.1 2604.1 2613.3 2588.4 2594.5 2627.3 2636.9 2641.7 2600.1 2621.4 2621.5 2625.7 2648.2 2589.4 2602.8 2623.7 2624.8 2630.6 9360.7 9380.1 9383.6 9395.6 9402.1 5776.7 5798.8 5987.7 5990.8 5995.2 3665.1 3715.3 3731.6 3808.6 3814.7 1052.4 1069.4 1073.2 1111.3 1112.8 12103.6 12281.4 12377.9 12409.1 12447.6 4220.6 4999.2 5031.7 5087.9 5123.7 10387.9 10502.8 10514.0 10527.0 10533.5 5710.5 5717.7 5738.4 5745.3 5770.2 4642.4 5129.4 5207.1 5261.6 5269.2 4125.6 4139.7 4160.3 4169.9 4172.7 1373.4 1376.0 1386.6 1390.7 1398.5 1245.3 1403.0 1448.4 1452.4 1462.5 8442.2 8542.6 8561.9 8569.7 8576.1 536.5 544.9 547.9 553.0 555.3 6214.3 6303.2 6345.7 6376.3 6382.3 10822.7 11091.1 11107.8 11147.8 11153.3 10556.3 10659.8 10788.5 11017.6 11032.8 8672.1 8699.7 8751.6 8794.5 8836.0 7986.8 8021.2 8066.4 8103.9 8200.5 9613.0 9970.3 9992.7 10040.6 10049.6 10109.6 10235.2 10346.8 10377.1 10402.6 7525.9 7722.8 7735.7 7793.1 7823.2 8424.8 8478.6 8494.4 8557.0 8591.2 7498.4 7554.8 7604.2 7606.0 7840.5 6232.7 7586.7 7608.7 7633.5 7713.9 7954.3 7999.9 8011.0 8018.2 8062.6 7213.3 7225.3 7366.8 7371.4 7384.2 7415.7 7467.8 7485.8 7494.8 7496.6 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#4] prototype.html Cycles:180 Average:5991.78 Median:6859.64 stddev:1961.37 (28.6%) stddev-sans-first:1920.30 16:20:41 INFO - PROCESS | 2214 | Values: 331.4 334.1 339.4 339.9 343.3 5888.0 6623.1 6791.9 6852.9 6866.3 6759.5 6776.6 6808.0 6819.0 6837.2 3897.2 4841.7 4989.6 5038.0 5092.9 5011.9 5016.9 5024.2 5031.4 5034.4 4946.5 4973.3 4973.6 4975.7 4977.8 4927.8 4969.8 4988.2 4994.8 4996.3 3648.7 4249.6 4331.6 4351.3 4352.4 6244.9 6612.6 6633.2 6633.9 6655.5 5860.4 5867.4 5870.9 5884.6 5894.4 7290.9 7300.8 7301.0 7303.7 7314.2 4720.8 4723.0 4735.8 4749.2 4749.6 7282.3 7643.7 7732.7 7742.3 7749.3 4591.0 4648.6 4713.7 4728.9 4740.4 3929.3 4811.0 4875.8 4881.0 4895.4 5807.5 5849.4 5860.9 5879.1 5880.6 7085.6 7317.4 7336.9 7340.3 7354.2 1403.4 1436.7 1689.2 1692.1 1693.3 908.3 1043.1 1077.1 1088.7 1091.2 6810.7 7104.0 7107.5 7128.9 7145.3 7571.7 7572.7 7574.9 7586.8 7614.3 5513.4 5694.3 6917.1 6964.8 6977.2 3976.1 4008.6 4014.9 4022.3 4040.1 7636.9 7668.0 7991.0 8042.4 8053.8 7876.3 7929.9 7961.6 7967.0 7990.9 8008.7 8022.6 8025.9 8045.0 8064.0 7350.8 7581.0 7637.6 7682.8 7694.2 7438.0 7452.4 7489.7 7494.9 7532.4 7952.6 7993.2 7993.3 7995.2 8018.4 4748.7 4804.3 4804.5 4823.3 4846.8 7283.8 7402.0 7585.8 7640.8 7654.9 7364.9 7376.7 7380.5 7381.5 7391.1 7328.5 7337.3 7375.7 7392.1 7393.8 6971.4 7207.6 7224.6 7237.5 7266.5 7291.8 7331.6 7358.3 7362.1 7396.5 7204.8 7216.2 7228.5 7231.6 7243.4 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - PROCESS | 2214 | [#5] yui.html Cycles:180 Average:19061.49 Median:4208.23 stddev:26998.01 (641.6%) stddev-sans-first:27038.50 16:20:41 INFO - PROCESS | 2214 | Values: 688.8 782.3 786.7 803.5 815.9 15624.0 15666.5 15844.8 15888.1 15904.9 14700.8 14777.6 14798.2 14798.6 14807.1 809.0 961.4 983.3 993.8 996.0 785.0 992.7 993.8 1002.9 1004.8 943.7 1010.8 1065.4 1067.2 1068.5 953.3 1048.0 1057.5 1058.2 1060.1 765.7 786.7 790.7 791.3 797.5 15302.5 15561.8 15583.9 15591.9 15607.5 12435.8 13428.2 13476.9 13565.4 13573.8 10338.3 10359.3 10412.2 10516.1 10841.4 3573.8 3590.5 3636.1 3720.3 3879.2 82750.0 83029.0 85895.0 86243.0 86910.6 9871.4 9936.1 10005.0 10055.9 10225.8 23540.0 23562.9 23574.5 23582.8 23664.0 7618.7 7625.1 7688.3 7846.4 7888.4 4139.5 4203.3 4213.1 4250.9 4395.7 3247.4 3759.2 3802.9 3813.6 3834.8 670.9 673.9 674.7 678.1 685.9 613.1 616.1 624.3 633.6 635.0 8447.0 8533.7 8630.6 8695.7 8746.2 582.4 586.4 603.0 625.6 631.7 3956.3 3968.1 3974.6 4075.4 4194.1 93909.1 93953.0 101198.5 103091.5 103725.0 80256.0 81725.0 83628.7 84509.0 84572.0 72038.6 72752.6 72990.6 73354.3 73507.0 7369.4 8138.8 8426.5 8552.2 8928.8 50152.7 50240.7 50636.0 50714.0 51517.7 61594.7 62340.1 66536.0 72238.6 73692.0 10839.6 11277.7 11672.1 11673.9 11679.8 9879.9 12183.9 12286.1 12300.0 12821.0 11292.7 11444.2 11454.3 11508.8 11653.4 11638.2 11798.8 11823.5 12110.2 12189.0 9369.8 9466.6 11356.4 11603.9 11612.3 9725.0 9995.4 10100.8 10162.4 10192.0 7654.5 9993.7 10149.9 10228.4 10240.8 16:20:41 INFO - PROCESS | 2214 | -------- Summary: end -------- 16:20:41 INFO - PROCESS | 2214 | 16:20:41 INFO - TEST-INFO | 2214: exit 0 16:20:41 INFO - TEST-OK | dromaeo_css | took 1109407ms 16:20:41 INFO - TEST-START | kraken 16:20:41 INFO - operating with platform_type : mac_ 16:20:41 INFO - Initialising browser for kraken test... 16:20:41 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmp0K9e0t/profile http://localhost:56147/getInfo.html) 16:20:43 INFO - PROCESS | 2218 | __metrics Screen width/height:1600/1200 16:20:43 INFO - PROCESS | 2218 | colorDepth:24 16:20:43 INFO - PROCESS | 2218 | Browser inner width/height: 1024/689 16:20:43 INFO - PROCESS | 2218 | __metrics 16:20:43 ERROR - PROCESS | 2218 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:20:44 INFO - TEST-INFO | 2218: exit 0 16:20:44 INFO - Browser initialized. 16:20:44 INFO - Running cycle 1/1 for kraken test... 16:20:44 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmp0K9e0t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:56 INFO - PROCESS | 2222 | RSS: Main: 168263680 16:20:56 INFO - PROCESS | 2222 | 16:20:59 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56147/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:59 INFO - PROCESS | 2222 | RSS: Main: 179830784 16:20:59 INFO - PROCESS | 2222 | 16:21:02 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56147/tests/kraken/driver.html?testName=audio-dft) 16:21:02 INFO - PROCESS | 2222 | RSS: Main: 188755968 16:21:02 INFO - PROCESS | 2222 | 16:21:06 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56147/tests/kraken/driver.html?testName=audio-fft) 16:21:06 INFO - PROCESS | 2222 | RSS: Main: 192360448 16:21:06 INFO - PROCESS | 2222 | 16:21:08 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56147/tests/kraken/driver.html?testName=audio-oscillator) 16:21:09 INFO - PROCESS | 2222 | RSS: Main: 193961984 16:21:09 INFO - PROCESS | 2222 | 16:21:11 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:11 INFO - PROCESS | 2222 | RSS: Main: 194289664 16:21:11 INFO - PROCESS | 2222 | 16:21:14 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56147/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:15 INFO - PROCESS | 2222 | RSS: Main: 195088384 16:21:15 INFO - PROCESS | 2222 | 16:21:18 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56147/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:19 INFO - PROCESS | 2222 | RSS: Main: 194990080 16:21:19 INFO - PROCESS | 2222 | 16:21:22 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56147/tests/kraken/driver.html?testName=json-parse-financial) 16:21:22 INFO - PROCESS | 2222 | RSS: Main: 195321856 16:21:22 INFO - PROCESS | 2222 | 16:21:24 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:24 INFO - PROCESS | 2222 | RSS: Main: 194404352 16:21:24 INFO - PROCESS | 2222 | 16:21:26 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:27 INFO - PROCESS | 2222 | RSS: Main: 194482176 16:21:27 INFO - PROCESS | 2222 | 16:21:29 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:29 INFO - PROCESS | 2222 | RSS: Main: 194682880 16:21:29 INFO - PROCESS | 2222 | 16:21:32 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:33 INFO - PROCESS | 2222 | RSS: Main: 194727936 16:21:33 INFO - PROCESS | 2222 | 16:21:35 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:36 INFO - PROCESS | 2222 | RSS: Main: 194871296 16:21:36 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:56147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56147/tests/kraken/driver.html?testName=ai-astar) 16:21:38 INFO - PROCESS | 2222 | RSS: Main: 196440064 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | __start_tp_report 16:21:38 INFO - PROCESS | 2222 | _x_x_mozilla_page_load 16:21:38 INFO - PROCESS | 2222 | _x_x_mozilla_page_load_details 16:21:38 INFO - PROCESS | 2222 | |i|pagename|runs| 16:21:38 INFO - PROCESS | 2222 | |0;ai-astar;125;115;114;115;115;130;115;112;116;116 16:21:38 INFO - PROCESS | 2222 | |1;audio-beat-detection;147;120;157;149;121;144;177;150;159;120 16:21:38 INFO - PROCESS | 2222 | |2;audio-dft;194;199;201;200;196;196;198;201;199;197 16:21:38 INFO - PROCESS | 2222 | |3;audio-fft;65;78;72;113;56;55;58;60;127;57 16:21:38 INFO - PROCESS | 2222 | |4;audio-oscillator;88;81;127;80;84;112;158;116;79;121 16:21:38 INFO - PROCESS | 2222 | |5;imaging-gaussian-blur;89;86;88;104;122;87;94;123;88;85 16:21:38 INFO - PROCESS | 2222 | |6;imaging-darkroom;115;150;114;143;150;108;152;131;95;96 16:21:38 INFO - PROCESS | 2222 | |7;imaging-desaturate;133;151;146;92;109;92;121;119;91;90 16:21:38 INFO - PROCESS | 2222 | |8;json-parse-financial;57;59;58;60;60;58;60;67;57;54 16:21:38 INFO - PROCESS | 2222 | |9;json-stringify-tinderbox;64;56;67;82;79;74;68;66;64;66 16:21:38 INFO - PROCESS | 2222 | |10;stanford-crypto-aes;85;81;83;82;83;83;82;82;85;83 16:21:38 INFO - PROCESS | 2222 | |11;stanford-crypto-ccm;131;130;113;128;138;120;142;139;131;122 16:21:38 INFO - PROCESS | 2222 | |12;stanford-crypto-pbkdf2;133;173;147;139;154;133;133;138;138;154 16:21:38 INFO - PROCESS | 2222 | |13;stanford-crypto-sha256-iterative;66;67;68;78;96;99;96;96;81;69 16:21:38 INFO - PROCESS | 2222 | __end_tp_report 16:21:38 INFO - PROCESS | 2222 | __start_cc_report 16:21:38 INFO - PROCESS | 2222 | _x_x_mozilla_cycle_collect,889 16:21:38 INFO - PROCESS | 2222 | __end_cc_report 16:21:38 INFO - PROCESS | 2222 | __startTimestamp1462836098353__endTimestamp 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | ------- Summary: start ------- 16:21:38 INFO - PROCESS | 2222 | Number of tests: 14 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#0] ai-astar Cycles:10 Average:117.30 Median:115.50 stddev:5.62 (4.9%) stddev-sans-first:5.22 16:21:38 INFO - PROCESS | 2222 | Values: 125.0 115.0 114.0 115.0 115.0 130.0 115.0 112.0 116.0 116.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:149.50 stddev:18.95 (12.7%) stddev-sans-first:20.08 16:21:38 INFO - PROCESS | 2222 | Values: 147.0 120.0 157.0 149.0 121.0 144.0 177.0 150.0 159.0 120.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#2] audio-dft Cycles:10 Average:198.10 Median:199.00 stddev:2.33 (1.2%) stddev-sans-first:1.94 16:21:38 INFO - PROCESS | 2222 | Values: 194.0 199.0 201.0 200.0 196.0 196.0 198.0 201.0 199.0 197.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#3] audio-fft Cycles:10 Average:74.10 Median:59.00 stddev:25.51 (43.2%) stddev-sans-first:26.84 16:21:38 INFO - PROCESS | 2222 | Values: 65.0 78.0 72.0 113.0 56.0 55.0 58.0 60.0 127.0 57.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:79.50 stddev:26.51 (33.3%) stddev-sans-first:27.43 16:21:38 INFO - PROCESS | 2222 | Values: 88.0 81.0 127.0 80.0 84.0 112.0 158.0 116.0 79.0 121.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:87.50 stddev:14.71 (16.8%) stddev-sans-first:15.35 16:21:38 INFO - PROCESS | 2222 | Values: 89.0 86.0 88.0 104.0 122.0 87.0 94.0 123.0 88.0 85.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#6] imaging-darkroom Cycles:10 Average:125.40 Median:150.00 stddev:22.58 (15.1%) stddev-sans-first:23.63 16:21:38 INFO - PROCESS | 2222 | Values: 115.0 150.0 114.0 143.0 150.0 108.0 152.0 131.0 95.0 96.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#7] imaging-desaturate Cycles:10 Average:114.40 Median:120.50 stddev:23.39 (19.4%) stddev-sans-first:23.82 16:21:38 INFO - PROCESS | 2222 | Values: 133.0 151.0 146.0 92.0 109.0 92.0 121.0 119.0 91.0 90.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:3.37 (5.7%) stddev-sans-first:3.49 16:21:38 INFO - PROCESS | 2222 | Values: 57.0 59.0 58.0 60.0 60.0 58.0 60.0 67.0 57.0 54.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:67.50 stddev:7.71 (11.4%) stddev-sans-first:7.99 16:21:38 INFO - PROCESS | 2222 | Values: 64.0 56.0 67.0 82.0 79.0 74.0 68.0 66.0 64.0 66.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.29 (1.6%) stddev-sans-first:1.12 16:21:38 INFO - PROCESS | 2222 | Values: 85.0 81.0 83.0 82.0 83.0 83.0 82.0 82.0 85.0 83.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:131.00 stddev:9.09 (6.9%) stddev-sans-first:9.63 16:21:38 INFO - PROCESS | 2222 | Values: 131.0 130.0 113.0 128.0 138.0 120.0 142.0 139.0 131.0 122.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:143.00 stddev:12.95 (9.1%) stddev-sans-first:13.09 16:21:38 INFO - PROCESS | 2222 | Values: 133.0 173.0 147.0 139.0 154.0 133.0 133.0 138.0 138.0 154.0 16:21:38 INFO - PROCESS | 2222 | 16:21:38 INFO - PROCESS | 2222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.60 Median:88.50 stddev:13.90 (15.7%) stddev-sans-first:13.55 16:21:38 INFO - PROCESS | 2222 | Values: 66.0 67.0 68.0 78.0 96.0 99.0 96.0 96.0 81.0 69.0 16:21:38 INFO - PROCESS | 2222 | -------- Summary: end -------- 16:21:38 INFO - PROCESS | 2222 | 16:21:39 INFO - TEST-INFO | 2222: exit 0 16:21:39 INFO - TEST-OK | kraken | took 57740ms 16:21:39 INFO - SUITE-END | took 1167s 16:21:39 INFO - Completed test suite (00:19:27) 16:21:39 INFO - javascript benchmark 16:21:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3538.5930617978925, 3658.798766067866, 3680.4847321374996, 3704.9814750926244, 3756.8872933811995, 5934.546036221121, 5993.700314984244, 5998.400159984005, 6018.0, 6053.031514957607, 5932.644041357522, 5992.250968628921, 6037.335893051761, 6081.847953801157, 6116.296625888013, 5346.1713434417725, 5376.973115134419, 5417.485338892819, 5463.235147079412, 5503.174523821419, 5360.65155764876, 5467.20725494803, 5468.070428027245, 5477.808276710316, 5477.808276710316, 5357.919631205535, 5383.192521121843, 5383.623146379755, 5390.245365648812, 5431.21247419124, 5459.727013649342, 5472.781088756445, 5478.780848766045, 5484.341878974528, 5551.278333816598, 5227.686338819683, 5310.44240354761, 5406.8918621627345, 5454.836354909359, 5485.6982865942355, 4441.977790111061, 5867.0, 5885.970570147165, 5903.321118071433, 5981.970090149522, 6263.624182549016, 6301.873962520724, 6306.495480361606, 6330.556861019731, 6330.936690633081, 5472.945270547323, 6345.302016778151, 6366.045093236005, 6388.265349484822, 6391.169148010776, 6000.309964354112, 6026.969865150646, 6117.431594453911, 6132.478739307165, 6144.341027922525, 6486.578372405778, 6487.870242595121, 6492.805215843532, 6512.674366281762, 6514.9348506514325, 6262.968685156545, 6295.18162638854, 6313.40022697843, 6332.52506062038, 6345.270293916166, 6280.2777680566405, 6304.275008374096, 6326.778562750374, 6366.26787919386, 6392.840178995562, 6226.719797609118, 6255.74977000924, 6275.466585340206, 6282.623042617458, 6293.0, 6201.81394558155, 6226.40849119333, 6295.024271237966, 6301.905471417932, 6310.652914089677, 4337.631301339421, 5091.541761241506, 5093.668911520739, 5107.438181799999, 5144.125498665236, 4530.29780384041, 4536.818527258873, 4564.885877853014, 4575.084983003413, 4602.88492787683, 5996.2504686914135, 6084.148219249309, 6091.964366057781, 6120.051392034242, 6155.753769849156, 6219.440250377397, 6287.685615719196, 6299.275583307886, 6354.936450635434, 6371.203599550056, 6088.908666370008, 6094.39056094387, 6118.388161183846, 6119.479844213202, 6171.444569988723, 5526.861828454241, 5576.7211639417865, 5605.859853503695, 5621.241132447068, 5621.409751976065, 6473.967630161819, 6521.8695626088165, 6564.343565643398, 6567.934320656828, 6611.636360000054, 5673.77304907799, 5731.914021289601, 6339.936600633934, 6374.74501019954, 6402.6066184922065, 6340.4293613575, 6448.258450278278, 6511.34886511364, 6543.574667646588, 6569.80290591283, 6284.811455656338, 6285.811425657238, 6300.842478938063, 6309.747610095545, 6318.684065796784, 4677.812887484599, 6342.270638876404, 6346.301906790157, 6357.4596159326975, 6373.6175829450385, 6163.722632481638, 6175.073738939195, 6227.221597300338, 6251.624902505864, 6256.968715156395, 6208.596441231305, 6242.843928901813, 6258.530610204344, 6263.09185168139, 6288.811335659938, 6079.483243924316, 6229.314775374796, 6239.251289845248, 6250.749970001149, 6258.780942666985, 6169.444749972524, 6214.378562143749, 6236.6258024518675, 6257.561970662192, 6276.905846412216, 6251.062340648939, 6259.061140828912, 6261.24865016201, 6283.151774510383, 6310.684465776784], "unit": "score", "name": "dojo.html", "value": 5871.58794706904}, {"lowerIsBetter": false, "replicates": [461.9006913513596, 606.9696515174242, 607.441154138193, 616.9969150154249, 665.8535122273099, 38839.02902427437, 39492.40761388574, 39525.80237098814, 39579.40630890539, 39648.60351396485, 36629.81685091578, 40200.59799402005, 42283.15433691324, 42879.78560107195, 43122.35316470255, 9805.166560842319, 10033.147182489498, 10059.195264378868, 10059.547320370564, 10067.395956242612, 9909.207263418944, 10001.549930253119, 10077.24420668449, 10121.544530496109, 10121.848172277385, 10065.396076235413, 10126.797464050715, 10142.18862490999, 10151.0, 10162.23783216258, 8593.441426307301, 9997.950010249902, 10050.04524570172, 10127.493625318704, 10132.189424845994, 9848.90151098487, 9943.353682010718, 9962.501874906298, 9983.351082179635, 9986.900130998669, 34563.0, 40580.1883962322, 40784.592154078375, 40834.0, 41117.588824111976, 3154.41643295991, 3364.49532570114, 3460.7750496217664, 3970.5235371755575, 4059.5737447567876, 27047.1885843425, 27533.0, 27738.861305693543, 27812.721872781214, 28571.57142642862, 2794.594783756344, 2832.391035927265, 2858.1854171561004, 2890.7976441649093, 2924.947019073132, 355220.0, 356982.2150889229, 357768.0, 358553.0, 360467.0, 48251.79370515765, 48682.0, 48764.512354875995, 48990.510094899306, 67066.32933670699, 45569.316460253125, 46732.53267467282, 46925.061498769835, 46953.765231173624, 47086.52913470822, 17343.826561734473, 17499.475015749547, 17533.21100550478, 17560.209790559198, 17588.560285992953, 13693.0, 13809.585712428643, 13900.652483687989, 13930.37313320903, 14253.78619320711, 15125.0, 15175.924120379328, 15477.922610386877, 15567.988080774714, 15624.843751562566, 6540.351157781106, 6650.401463868178, 6695.397414232742, 6701.229358623723, 6702.631355275409, 972.7568107973007, 1081.4862940103387, 1147.3173461790223, 1147.9610952088374, 1187.1511869013696, 24352.512949740907, 31328.37343253122, 32717.67282327194, 33146.0, 33294.8335258327, 1097.5664612478026, 1138.2260063156966, 1163.6567212672282, 1165.0213820390743, 1208.2146604707011, 13584.320783960762, 14814.40742370293, 15243.0, 15509.84490155084, 15775.368985240462, 599405.0, 657231.0, 659344.7032764805, 661271.0809337863, 664317.0, 62196.68901655553, 62504.68747656233, 62516.06225906615, 62642.37357626457, 62701.372986269555, 1541.2524925411167, 1558.7817705521236, 1583.065991065277, 1585.0727324515058, 1586.8333824948445, 30580.694193057785, 30927.0, 30953.535696964114, 31050.68949310478, 31495.68504315019, 53894.73052634712, 54107.45892541182, 54203.72898135484, 54331.0, 54600.72699636476, 508795.0, 511024.44487777323, 512297.0, 513277.0, 513801.0, 33711.0, 34860.9541713749, 34881.65118348784, 35234.11914702153, 35293.764718234735, 46192.0, 46553.53446465492, 46658.833529162046, 46841.06317873691, 46854.0, 28962.565561516174, 37834.86495405142, 38589.4211586832, 38923.80538097292, 39657.80171099126, 30146.84926575353, 37138.814305928296, 37755.811220944815, 37767.0, 38197.80901095477, 37126.0, 37977.62022379851, 38147.61852381441, 38705.612943871325, 38721.41917871178, 32447.513287301183, 33458.49812252867, 33472.330553389285, 33568.83215583907, 33775.49336759902, 25418.110366137098, 25611.231663050137, 25628.0, 25955.351116222246, 25966.57183854906], "unit": "score", "name": "ext.html", "value": 19865.99580398653}, {"lowerIsBetter": false, "replicates": [325.1400046876013, 325.54748899030346, 369.3886617647794, 374.73768362146507, 379.9797543595445, 19913.103910324033, 20055.19779208832, 21304.4673883153, 21338.506304558687, 21367.99999999998, 20137.093830777612, 20483.38549843507, 20693.68959465609, 21169.894150529224, 21193.682094768592, 5793.855153621172, 6011.789587364443, 6048.2137322148055, 6054.48536874364, 6072.301685306202, 4345.0, 4846.927296090562, 5954.285485741717, 6700.363465470772, 6791.626460544693, 6693.297203793604, 6693.297203793604, 6707.1616047994, 6721.26066132725, 6729.427998620124, 6550.344965503436, 6609.306022867602, 6681.498887583451, 6682.632455214961, 6703.865922681519, 5661.433856614347, 5673.546116310686, 5678.0, 5744.994625940443, 5782.392848750905, 26426.86786566074, 26458.86770566135, 26549.07078252271, 26689.599656005175, 26893.462130757274, 1929.8552608554414, 2234.1733558583264, 2297.5519773644146, 2578.690557133156, 2664.640273563083, 14813.0, 15200.46798362052, 15313.464028759052, 15428.151451670154, 15511.301991410413, 1719.5013446100616, 1772.8315809998157, 1814.8185181481747, 1850.9722354164699, 1871.3824437935584, 78917.21082789155, 80508.99999999942, 81471.59264203641, 97601.5119924403, 100143.9985600142, 11165.330080195214, 11366.090712743126, 11877.406129693654, 11896.04831613469, 11997.580084696994, 13111.344432778324, 13790.862091378958, 14408.567742967727, 14782.926085369505, 14852.480163194236, 7480.812979675443, 9263.842019747532, 9322.906770932204, 9371.297152713574, 9392.8591071134, 9390.671326503676, 9419.199368053793, 9548.809023819624, 9586.0, 9646.807063858683, 4191.287481128215, 4429.693240494062, 4627.95372046282, 4641.582257596765, 4641.675082744176, 1938.265252598916, 1993.063260267672, 1997.7702564205013, 2022.322521955132, 2029.52306208041, 928.4939707859232, 935.4574346878794, 982.381099907054, 1044.154235069596, 1063.3991794636006, 19254.22983080689, 20044.59910801805, 20186.798132018786, 20210.494737631678, 20420.0810963507, 901.5987885390938, 1014.2190513304714, 1022.5347466902541, 1063.723431907694, 1096.2928910852456, 10734.570617175226, 10996.395198264012, 11000.889991099986, 11058.655436156436, 11109.166812488935, 578286.3257051148, 654952.0, 659993.0, 675470.0, 693667.0, 115938.0, 125758.37120814521, 127791.36104319606, 129226.0, 132087.0, 998.825205589019, 1046.4924511611862, 1094.6825420628088, 1095.7534554725282, 1104.282216559243, 18297.81702182961, 18544.721829172304, 18776.342828000954, 18805.435836924913, 18948.810511894706, 44157.77921110502, 50787.746061269456, 51208.23187652263, 51308.97382052263, 54301.72849135729, 74440.62779686067, 79481.60259198667, 80317.3936521278, 80897.0, 81136.59431702804, 7965.721199757981, 8174.182581741778, 8310.459820111915, 8316.750497485085, 8327.875081873655, 12131.21147125434, 13202.80195797083, 13473.258970756702, 13497.595072147851, 13570.846478049081, 11302.43487825622, 11367.829482557934, 11441.713957151138, 11456.140789440658, 11472.082233421474, 11277.774444511228, 11557.537698491966, 11579.536818527502, 11697.883021169679, 11782.82325765097, 11914.821277681016, 11929.880701193224, 12000.699982500508, 12192.634220973385, 12312.507499699912, 8144.0, 8358.832823343377, 8425.789355266168, 8428.45215061019, 8638.308935285288, 8706.608202631023, 11114.16643751738, 11934.641960741192, 11984.520619175484, 12149.149559530748], "unit": "score", "name": "jquery.html", "value": 9862.256191632941}, {"lowerIsBetter": false, "replicates": [1643.7123503386908, 1651.8430749078836, 1979.9307024254153, 2059.5468996820696, 2075.2217918280644, 8364.498130112197, 9045.1407116324, 9094.499802510867, 9272.953635231823, 9348.532573371338, 9022.278217742582, 9030.916290045203, 9075.228605568518, 9111.635534578625, 9120.817583648322, 1996.7703714072923, 2435.6833611630464, 2594.701609314934, 2600.6099085137284, 2617.7251388604113, 2533.3160046787357, 2586.8447893126377, 2603.1149409200866, 2604.1146010356474, 2613.255222261656, 2588.404666926608, 2594.4681340325283, 2627.290631529486, 2636.894524219029, 2641.656584644003, 2600.06397696829, 2621.423286876884, 2621.5412302846926, 2625.7242989486117, 2648.20553833851, 2589.3526618345413, 2602.778763805079, 2623.6720409948757, 2624.829386089898, 2630.552806022981, 9360.719178424659, 9380.108889655472, 9383.624655013791, 9395.62417503299, 9402.106799854002, 5776.653400795965, 5798.768049278066, 5987.670678112702, 5990.820275391745, 5995.2206213192, 3665.1020499977676, 3715.294094122108, 3731.6081811409954, 3808.638179372955, 3814.6566808987045, 1052.4001319248032, 1069.4118234970736, 1073.1843798712957, 1111.3054341036852, 1112.821948488246, 12103.576374826838, 12281.385930703518, 12377.876221237762, 12409.06931980105, 12447.564335248222, 4220.556841531595, 4999.175136102575, 5031.698098114125, 5087.923681144785, 5123.666961647556, 10387.896121038844, 10502.789944201073, 10514.0, 10527.0, 10533.473326333653, 5710.5146062585145, 5717.656940583578, 5738.368779434259, 5745.3105627324985, 5770.19217309577, 4642.442906851199, 5129.410117836422, 5207.114790485626, 5261.552768014762, 5269.209618557247, 4125.617917997504, 4139.710220284551, 4160.292750232467, 4169.937450938239, 4172.666186705117, 1373.4231622718482, 1376.029898921258, 1386.6325423762712, 1390.6731917999261, 1398.4965412451509, 1245.2590708528412, 1403.0459287684268, 1448.4351103069812, 1452.3899962015978, 1462.510059130182, 8442.197991190827, 8542.615582298811, 8561.914380856237, 8569.657213711382, 8576.142385761374, 536.493014101678, 544.8583368324264, 547.9397266300704, 553.0432352031008, 555.3169601390313, 6214.347493513116, 6303.212098487689, 6345.746170153235, 6376.29860715321, 6382.297947225801, 10822.67531974042, 11091.057260132819, 11107.83338249927, 11147.777044459066, 11153.330800151854, 10556.313839600401, 10659.840102398315, 10788.51451684676, 11017.614383496539, 11032.779344413068, 8672.089430609822, 8699.695510657097, 8751.56242187888, 8794.516301603473, 8835.98386185597, 7986.840263194587, 8021.197880212166, 8066.435349525477, 8103.878441823495, 8200.466969647192, 9612.951935240279, 9970.30207885441, 9992.65025724096, 10040.598376064876, 10049.598016079275, 10109.595616175271, 10235.232357573062, 10346.793064138825, 10377.066064054272, 10402.58389664405, 7525.887111693439, 7722.768316950501, 7735.6518956648215, 7793.142754297136, 7823.200663847233, 8424.789380265542, 8478.576071196292, 8494.362922780692, 8556.957215213884, 8591.183837535424, 7498.400127989857, 7554.848903021799, 7604.163542010485, 7605.961970190335, 7840.529568225925, 6232.657203853832, 7586.658600362886, 7608.733694320672, 7633.465657403928, 7713.92286077132, 7954.284114429729, 7999.880001799861, 8011.038675358995, 8018.198180181935, 8062.596870156586, 7213.278672132745, 7225.277472252733, 7366.77899663011, 7371.41028717712, 7384.150822655249, 7415.666295016845, 7467.813304667427, 7485.7754267372065, 7494.775156745089, 7496.587687677012], "unit": "score", "name": "mootools.html", "value": 5072.151579813139}, {"lowerIsBetter": false, "replicates": [331.4481388488167, 334.1395905543225, 339.4467018759423, 339.9235172086279, 343.3082339086741, 5888.028475301581, 6623.07276981223, 6791.913293872982, 6852.931470685292, 6866.347696968793, 6759.45924326054, 6776.627285499296, 6808.0, 6819.0, 6837.17953845538, 3897.2400381925395, 4841.7337046462435, 4989.600831933455, 5037.974810125963, 5092.949070509294, 5011.924821127686, 5016.8996620067755, 5024.196128619422, 5031.446540880518, 5034.395872495287, 4946.530079642428, 4973.278874563186, 4973.626977976648, 4975.7263350515705, 4977.800887964477, 4927.7536123193695, 4969.82605608802, 4988.201887697969, 4994.800207991676, 4996.300517927493, 3648.6898613617873, 4249.638780703613, 4331.566843315643, 4351.28203846365, 4352.412424322708, 6244.875102497925, 6612.570182938141, 6633.2040155181685, 6633.900491492584, 6655.534112612119, 5860.384659610722, 5867.354590994987, 5870.911936320958, 5884.5582832205955, 5894.381089985575, 7290.854182916365, 7300.780976570712, 7300.96349518249, 7303.7078516859265, 7314.195438501761, 4720.811167553294, 4722.952770472286, 4735.763211839394, 4749.1926372516755, 4749.62003039756, 7282.344588986964, 7643.694252229904, 7732.729354472623, 7742.341900938427, 7749.263819937097, 4590.977045114753, 4648.604868586208, 4713.67004309695, 4728.905421891543, 4740.3837501124635, 3929.2730844793805, 4810.975945120322, 4875.829345972874, 4880.951190488121, 4895.388076490439, 5807.535397168216, 5849.444302791228, 5860.941390586039, 5879.059350503984, 5880.588358814842, 7085.645717714094, 7317.378022868116, 7336.889946650805, 7340.339369456775, 7354.227806080285, 1403.4035534897628, 1436.6623843396794, 1689.1723055702616, 1692.1370101248451, 1693.2888186961507, 908.336914052732, 1043.12377602814, 1077.0737166037202, 1088.7441451258949, 1091.170710260208, 6810.659467026629, 7104.0, 7107.502474826816, 7128.928710712827, 7145.285471452813, 7571.734989275349, 7572.697092116254, 7574.886376704354, 7586.81032974169, 7614.314711675976, 5513.448655134534, 5694.316681998187, 6917.066196063568, 6964.756233531802, 6977.232504424509, 3976.1252524444576, 4008.5590585035625, 4014.8996275093355, 4022.336314508132, 4040.111175541435, 7636.885446718304, 7667.961660191663, 7991.0, 8042.356611471068, 8053.791931210365, 7876.251756083163, 7929.920700793034, 7961.601919903982, 7967.0439547253545, 7990.9200907991335, 8008.71969481077, 8022.638981245858, 8025.919740802634, 8044.994375703037, 8063.959680201561, 7350.816229594303, 7581.01446811933, 7637.618119093912, 7682.846343073219, 7694.1536430993665, 7437.962810185914, 7452.403807695263, 7489.737859174903, 7494.887576686245, 7532.380538184317, 7952.6421311042295, 7993.200679931961, 7993.320567751573, 7995.200479951958, 8018.438709290293, 4748.691335063209, 4804.279358096313, 4804.495527969513, 4823.252395878644, 4846.80612775485, 7283.817904552428, 7402.0, 7585.848283034419, 7640.808979775327, 7654.885176722465, 7364.926350736639, 7376.7049318026675, 7380.520266182681, 7381.520201186906, 7391.113066432063, 7328.487005909536, 7337.3396394322635, 7375.741849035258, 7392.112946446246, 7393.778186654194, 6971.407430368476, 7207.639618018973, 7224.566526008456, 7237.529560578546, 7266.527675701062, 7291.781246562611, 7331.596762178131, 7358.337749602561, 7362.116546014512, 7396.4822462429265, 7204.819879502845, 7216.206217315986, 7228.49400541957, 7231.63841807897, 7243.3843123333], "unit": "score", "name": "prototype.html", "value": 5323.595476015856}, {"lowerIsBetter": false, "replicates": [688.8209065642932, 782.3350152370482, 786.6578038553226, 803.4737247103146, 815.9469634473757, 15623.984441011326, 15666.53000409988, 15844.84155158448, 15888.126153061577, 15904.920475397636, 14700.779488307684, 14777.556673299792, 14798.186099764509, 14798.556043318691, 14807.111573305609, 808.9919100808976, 961.4375590279694, 983.2772911909741, 993.8409854423294, 996.0487734213845, 784.9725259615915, 992.6773798515475, 993.7515621094726, 1002.8946960569144, 1004.7739258666778, 943.6555657185147, 1010.8433192855119, 1065.408698172514, 1067.2209287220335, 1068.529846867376, 953.3469573342283, 1047.9685609431729, 1057.4659796802605, 1058.222206678091, 1060.1095080132648, 765.74730338988, 786.7482405630201, 790.6837265093951, 791.3076058448858, 797.5135167547792, 15302.540923772305, 15561.766573501407, 15583.922080389639, 15591.922040389725, 15607.531774046796, 12435.75128497434, 13428.19430834153, 13476.86523134766, 13565.389557469838, 13573.796393054112, 10338.276320657556, 10359.27485076045, 10412.219083568763, 10516.053555180071, 10841.403722795243, 3573.767705099186, 3590.5152804371337, 3636.1273294409416, 3720.3489389356755, 3879.1853710720784, 82750.0, 83029.0, 85895.0, 86243.0, 86910.565447173, 9871.40771553709, 9936.056074672895, 10005.0, 10055.949720251352, 10225.846612300673, 23540.0, 23562.939667714993, 23574.528509429714, 23582.820858956984, 23664.0, 7618.733344332922, 7625.084989801259, 7688.346490548366, 7846.411519136088, 7888.447808653454, 4139.461869956946, 4203.327467605169, 4213.136307057046, 4250.852269887113, 4395.7142785718825, 3247.399231142246, 3759.2481503698823, 3802.866899658499, 3813.599572044951, 3834.846606135779, 670.8624731929942, 673.8551211489455, 674.6727836999052, 678.067656971664, 685.8868286732733, 613.1109890658474, 616.0820377637289, 624.2633692243197, 633.6198281031344, 634.9809505714836, 8447.0, 8533.701320453754, 8630.568471576396, 8695.652173912973, 8746.212840844355, 582.3506789929198, 586.393083158937, 602.9698515074228, 625.5808608232495, 631.703099543214, 3956.287868183697, 3968.1270120573427, 3974.6224108709625, 4075.449814275035, 4194.077302993336, 93909.0609093914, 93953.0, 101198.49400753096, 103091.45362819564, 103725.0, 80256.0, 81725.0, 83628.74556881652, 84509.0, 84572.0, 72038.63980680169, 72752.63623681848, 72990.63504682548, 73354.2664573358, 73507.0, 7369.447291453055, 8138.819871118773, 8426.4944103354, 8552.230299273095, 8928.839250897341, 50152.749236253585, 50240.748796255786, 50636.0, 50714.0, 51517.742411287705, 61594.69202653958, 62340.12979610619, 66536.0, 72238.55522889618, 73692.0, 10839.566417343218, 11277.71805704864, 11672.124590655565, 11673.883261167279, 11679.76640467203, 9879.901200987899, 12183.939080304543, 12286.139970202357, 12300.0, 12821.0, 11292.717682058013, 11444.198906076495, 11454.312741235553, 11508.827367589325, 11653.417329133339, 11638.243514171552, 11798.823017654913, 11823.46794394237, 12110.152289340014, 12189.024878009915, 9369.81260374775, 9466.574004169692, 11356.375399352784, 11603.941980290045, 11612.303261804318, 9725.0, 9995.400275983464, 10100.84848727255, 10162.441065741456, 10192.0, 7654.502457340255, 9993.650222242186, 10149.89761634968, 10228.437435941094, 10240.846387304346], "unit": "score", "name": "yui.html", "value": 7212.73791931817}], "name": "dromaeo_css", "value": 7793.432076589627}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [125.0, 115.0, 114.0, 115.0, 115.0, 130.0, 115.0, 112.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 157.0, 149.0, 121.0, 144.0, 177.0, 150.0, 159.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [194.0, 199.0, 201.0, 200.0, 196.0, 196.0, 198.0, 201.0, 199.0, 197.0], "unit": "score", "name": "audio-dft", "value": 198.1}, {"lowerIsBetter": true, "replicates": [65.0, 78.0, 72.0, 113.0, 56.0, 55.0, 58.0, 60.0, 127.0, 57.0], "unit": "score", "name": "audio-fft", "value": 74.1}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 127.0, 80.0, 84.0, 112.0, 158.0, 116.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 104.0, 122.0, 87.0, 94.0, 123.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.6}, {"lowerIsBetter": true, "replicates": [115.0, 150.0, 114.0, 143.0, 150.0, 108.0, 152.0, 131.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 125.4}, {"lowerIsBetter": true, "replicates": [133.0, 151.0, 146.0, 92.0, 109.0, 92.0, 121.0, 119.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 114.4}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 58.0, 60.0, 60.0, 58.0, 60.0, 67.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [64.0, 56.0, 67.0, 82.0, 79.0, 74.0, 68.0, 66.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 83.0, 82.0, 83.0, 83.0, 82.0, 82.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [131.0, 130.0, 113.0, 128.0, 138.0, 120.0, 142.0, 139.0, 131.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [133.0, 173.0, 147.0, 139.0, 154.0, 133.0, 133.0, 138.0, 138.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 78.0, 96.0, 99.0, 96.0, 96.0, 81.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.6}], "name": "kraken", "value": 1540.6000000000001}]} 16:21:39 INFO - Return code: 0 16:21:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:21:39 ERROR - # TBPL SUCCESS # 16:21:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:21:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:21:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:21:39 INFO - 2016-05-09 16:21:39.677 screenresolution[2227:27146] starting screenresolution argv=screenresolution get 16:21:39 INFO - 2016-05-09 16:21:39.679 screenresolution[2227:27146] Display 0: 1600x1200x32@60 16:21:39 INFO - 2016-05-09 16:21:39.686 screenresolution[2228:27149] starting screenresolution argv=screenresolution list 16:21:39 INFO - Available Modes on Display 0 16:21:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:21:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:21:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:21:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:21:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:21:39 INFO - Intel Iris: 16:21:39 INFO - Chipset Model: Intel Iris 16:21:39 INFO - Type: GPU 16:21:39 INFO - Bus: Built-In 16:21:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:21:39 INFO - Vendor: Intel (0x8086) 16:21:39 INFO - Device ID: 0x0a2e 16:21:39 INFO - Revision ID: 0x0009 16:21:39 INFO - Displays: 16:21:39 INFO - Display: 16:21:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:21:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:21:39 INFO - Display Serial Number: 1600x1200 60 16:21:39 INFO - Main Display: Yes 16:21:39 INFO - Mirror: Off 16:21:39 INFO - Online: Yes 16:21:39 INFO - Rotation: Supported 16:21:39 INFO - Return code: 0 16:21:39 INFO - Running post-action listener: _resource_record_post_action 16:21:39 INFO - Running post-run listener: _resource_record_post_run 16:21:40 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 425984; Write bytes: 511885824; Read time: 6; Write time: 1924 16:21:40 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 195566080; Write bytes: 198420480; Read time: 18322; Write time: 411 16:21:40 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 425984; Write bytes: 302549504; Read time: 6; Write time: 1479 16:21:40 INFO - Running post-run listener: _upload_blobber_files 16:21:40 INFO - Blob upload gear active. 16:21:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:40 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 16:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:21:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:42 INFO - (blobuploader) - INFO - Done attempting. 16:21:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:21:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:21:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:43 INFO - (blobuploader) - INFO - Done attempting. 16:21:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:43 INFO - Return code: 0 16:21:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cb44e8474340233e4987ff872381e5f838a896bcee1ab41d7dc243e0fa9d2f9e93c7631535bbb96df5c4a9a99ae5c6413601509ba8efe36ba025111abbbf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deec8ea8c3116263d4c30f8726c2395c5a9c78a166c62d35da730df2791840f7b04af586d5bd1e21e15fe4f493d72b18fd7a8115fc8d38ca3c158d5296933505"} 16:21:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:43 INFO - Contents: 16:21:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cb44e8474340233e4987ff872381e5f838a896bcee1ab41d7dc243e0fa9d2f9e93c7631535bbb96df5c4a9a99ae5c6413601509ba8efe36ba025111abbbf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deec8ea8c3116263d4c30f8726c2395c5a9c78a166c62d35da730df2791840f7b04af586d5bd1e21e15fe4f493d72b18fd7a8115fc8d38ca3c158d5296933505"} 16:21:43 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:43 INFO - Copying logs to upload dir... 16:21:43 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.789582 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-09 16:21:43.401362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:21:43.404443) ========= 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.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cb44e8474340233e4987ff872381e5f838a896bcee1ab41d7dc243e0fa9d2f9e93c7631535bbb96df5c4a9a99ae5c6413601509ba8efe36ba025111abbbf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deec8ea8c3116263d4c30f8726c2395c5a9c78a166c62d35da730df2791840f7b04af586d5bd1e21e15fe4f493d72b18fd7a8115fc8d38ca3c158d5296933505"} build_url:https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/Vsz4U4rdQlSIT2XzlAlhbQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cb44e8474340233e4987ff872381e5f838a896bcee1ab41d7dc243e0fa9d2f9e93c7631535bbb96df5c4a9a99ae5c6413601509ba8efe36ba025111abbbf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deec8ea8c3116263d4c30f8726c2395c5a9c78a166c62d35da730df2791840f7b04af586d5bd1e21e15fe4f493d72b18fd7a8115fc8d38ca3c158d5296933505"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:21:43.431603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:21:43.431913) ========= 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.5gQmjImjYv/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.g27med5UsH/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:21:43.479778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:21:43.480100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:21:43.480399) ========= ========= Total master_lag: 0.16 =========