builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0122 starttime: 1460654803.6 results: success (0) buildid: 20160414083550 builduid: dae1c97054494a3fb8bd65c3cd4acac6 revision: b40daaf112476e4d07b3fcfec36223d0852449d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:43.603060) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:43.603476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:43.603749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:43.810559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:43.811082) ========= 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.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-14 10:26:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-04-14 10:26:43 (14.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169497 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:44.011400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:44.011729) ========= 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.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.026778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:44.071963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 10:26:44.072347) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b40daaf112476e4d07b3fcfec36223d0852449d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b40daaf112476e4d07b3fcfec36223d0852449d4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-14 10:26:44,151 truncating revision to first 12 chars 2016-04-14 10:26:44,151 Setting DEBUG logging. 2016-04-14 10:26:44,151 attempt 1/10 2016-04-14 10:26:44,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b40daaf11247?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 10:26:44,812 unpacking tar archive at: fx-team-b40daaf11247/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912234 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 10:26:45.258555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:45.258932) ========= script_repo_revision: b40daaf112476e4d07b3fcfec36223d0852449d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:45.259347) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:45.259613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 10:26:45.343349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-14 10:26:45.343818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:26:45 INFO - MultiFileLogger online at 20160414 10:26:45 in /builds/slave/test 10:26:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:26:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:26:45 INFO - {'append_to_log': False, 10:26:45 INFO - 'base_work_dir': '/builds/slave/test', 10:26:45 INFO - 'blob_upload_branch': 'Fx-Team', 10:26:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:26:45 INFO - 'branch': 'Fx-Team', 10:26:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:26:45 INFO - 'config_files': ('talos/mac_config.py',), 10:26:45 INFO - 'default_actions': ('clobber', 10:26:45 INFO - 'read-buildbot-config', 10:26:45 INFO - 'download-and-extract', 10:26:45 INFO - 'populate-webroot', 10:26:45 INFO - 'create-virtualenv', 10:26:45 INFO - 'install', 10:26:45 INFO - 'run-tests'), 10:26:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:26:45 INFO - 'download_minidump_stackwalk': True, 10:26:45 INFO - 'download_symbols': 'ondemand', 10:26:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:26:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:26:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:26:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:26:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:26:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:26:45 INFO - 'installer_path': 'installer.exe', 10:26:45 INFO - 'log_level': 'info', 10:26:45 INFO - 'log_name': 'talos', 10:26:45 INFO - 'log_to_console': True, 10:26:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:26:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:26:45 INFO - 'opt_config_files': (), 10:26:45 INFO - 'pip_index': False, 10:26:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:26:45 INFO - 'cmd': ('bash', 10:26:45 INFO - '-c', 10:26:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:26:45 INFO - 'enabled': True, 10:26:45 INFO - 'halt_on_failure': False, 10:26:45 INFO - 'name': 'check_screen_resolution'},), 10:26:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:26:45 INFO - 'cmd': ('bash', 10:26:45 INFO - '-c', 10:26:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:26:45 INFO - 'enabled': True, 10:26:45 INFO - 'halt_on_failure': False, 10:26:45 INFO - 'name': 'check_screen_resolution'},), 10:26:45 INFO - 'run_cmd_checks_enabled': True, 10:26:45 INFO - 'sps_profile': False, 10:26:45 INFO - 'sps_profile_interval': 0, 10:26:45 INFO - 'suite': 'dromaeojs', 10:26:45 INFO - 'system_bits': '32', 10:26:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:26:45 INFO - 'title': 't-yosemite-r7-0122', 10:26:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:26:45 INFO - 'use_talos_json': True, 10:26:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:26:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:26:45 INFO - 'work_dir': 'build'} 10:26:45 INFO - ##### 10:26:45 INFO - ##### Running clobber step. 10:26:45 INFO - ##### 10:26:45 INFO - Running pre-action listener: _resource_record_pre_action 10:26:45 INFO - Running main action method: clobber 10:26:45 INFO - rmtree: /builds/slave/test/build 10:26:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:26:47 INFO - Running post-action listener: _resource_record_post_action 10:26:47 INFO - ##### 10:26:47 INFO - ##### Running read-buildbot-config step. 10:26:47 INFO - ##### 10:26:47 INFO - Running pre-action listener: _resource_record_pre_action 10:26:47 INFO - Running main action method: read_buildbot_config 10:26:47 INFO - Using buildbot properties: 10:26:47 INFO - { 10:26:47 INFO - "project": "", 10:26:47 INFO - "product": "firefox", 10:26:47 INFO - "script_repo_revision": "production", 10:26:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:26:47 INFO - "repository": "", 10:26:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:26:47 INFO - "buildid": "20160414083550", 10:26:47 INFO - "pgo_build": "False", 10:26:47 INFO - "basedir": "/builds/slave/test", 10:26:47 INFO - "buildnumber": 720, 10:26:47 INFO - "slavename": "t-yosemite-r7-0122", 10:26:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:26:47 INFO - "platform": "yosemite_r7", 10:26:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:26:47 INFO - "branch": "fx-team", 10:26:47 INFO - "repo_path": "integration/fx-team", 10:26:47 INFO - "revision": "b40daaf112476e4d07b3fcfec36223d0852449d4", 10:26:47 INFO - "stage_platform": "macosx64", 10:26:47 INFO - "builduid": "dae1c97054494a3fb8bd65c3cd4acac6", 10:26:47 INFO - "slavebuilddir": "test" 10:26:47 INFO - } 10:26:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:26:47 INFO - Running post-action listener: _resource_record_post_action 10:26:47 INFO - ##### 10:26:47 INFO - ##### Running download-and-extract step. 10:26:47 INFO - ##### 10:26:47 INFO - Running pre-action listener: _resource_record_pre_action 10:26:47 INFO - Running main action method: download_and_extract 10:26:47 INFO - mkdir: /builds/slave/test/build/tests 10:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:47 INFO - https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 10:26:50 INFO - Downloaded 1199 bytes. 10:26:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:26:50 INFO - Using the following test package requirements: 10:26:50 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:26:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:26:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:26:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'jsshell-mac.zip'], 10:26:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:26:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:26:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:26:50 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:26:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:26:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:26:50 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:26:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:50 INFO - https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:26:52 INFO - Downloaded 18031182 bytes. 10:26:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:26:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:26:55 INFO - Return code: 0 10:26:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:26:55 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')]} 10:26:55 INFO - https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:26:56 INFO - Downloaded 18031182 bytes. 10:26:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:26:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:27:00 INFO - Return code: 0 10:27:00 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')]} 10:27:00 INFO - https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:27:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:27:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:27:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:27:02 INFO - Downloaded 10841076 bytes. 10:27:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:27:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:27:02 INFO - Return code: 0 10:27: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')]} 10:27:02 INFO - https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:27:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:27:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:27:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:27:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 10:27:06 INFO - Downloaded 109834047 bytes. 10:27:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:27:06 INFO - mkdir: /builds/slave/test/properties 10:27:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:06 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:06 INFO - Contents: 10:27:06 INFO - build_url:https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:27:07 INFO - Running post-action listener: _resource_record_post_action 10:27:07 INFO - Running post-action listener: set_extra_try_arguments 10:27:07 INFO - ##### 10:27:07 INFO - ##### Running populate-webroot step. 10:27:07 INFO - ##### 10:27:07 INFO - Running pre-action listener: _resource_record_pre_action 10:27:07 INFO - Running main action method: populate_webroot 10:27:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:27:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:27:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:27:07 INFO - '--tppagecycles', 10:27:07 INFO - '7'], 10:27:07 INFO - 'tests': ['tsvgm']}}, 10:27:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:27:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:27:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['damp', 'tps']}, 10:27:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'tests': ['damp', 'tps']}, 10:27:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['dromaeo_dom']}, 10:27:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['a11yr', 10:27:07 INFO - 'ts_paint', 10:27:07 INFO - 'tpaint', 10:27:07 INFO - 'sessionrestore', 10:27:07 INFO - 'sessionrestore_no_auto_restore', 10:27:07 INFO - 'tabpaint']}, 10:27:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['tsvgx', 10:27:07 INFO - 'tsvgr_opacity', 10:27:07 INFO - 'tart', 10:27:07 INFO - 'tscrollx', 10:27:07 INFO - 'cart']}, 10:27:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:07 INFO - 'tsvgr_opacity', 10:27:07 INFO - 'tart', 10:27:07 INFO - 'tscrollx', 10:27:07 INFO - 'cart']}, 10:27:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'talos_options': ['--disable-e10s'], 10:27:07 INFO - 'tests': ['tp5o']}, 10:27:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'tests': ['tp5o']}, 10:27:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'talos_options': ['--disable-e10s', 10:27:07 INFO - '--xperf_path', 10:27:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:07 INFO - 'tests': ['tp5n']}, 10:27:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:07 INFO - 'talos_options': ['--xperf_path', 10:27:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:07 INFO - 'tests': ['tp5n']}}, 10:27:07 INFO - 'talos.zip': {'path': '', 10:27:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:27:07 INFO - Running post-action listener: _resource_record_post_action 10:27:07 INFO - ##### 10:27:07 INFO - ##### Running create-virtualenv step. 10:27:07 INFO - ##### 10:27:07 INFO - Running pre-action listener: _resource_record_pre_action 10:27:07 INFO - Running main action method: create_virtualenv 10:27:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27:07 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 10:27:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:27:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:07 INFO - Using real prefix '/tools/python27' 10:27:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:08 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:11 INFO - Installing pip.................done. 10:27:11 INFO - Return code: 0 10:27:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:11 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:11 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 10:27:11 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 10:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:11 INFO - 'HOME': '/Users/cltbld', 10:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:11 INFO - 'LOGNAME': 'cltbld', 10:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:11 INFO - 'MOZ_NO_REMOTE': '1', 10:27:11 INFO - 'NO_EM_RESTART': '1', 10:27:11 INFO - 'PAGER': '/bin/cat', 10:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:11 INFO - 'PWD': '/builds/slave/test', 10:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:11 INFO - 'SHELL': '/bin/bash', 10:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:11 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:11 INFO - 'USER': 'cltbld', 10:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:11 INFO - 'XPC_FLAGS': '0x0', 10:27:11 INFO - 'XPC_SERVICE_NAME': '0', 10:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:11 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 10:27:11 INFO - Cleaning up... 10:27:11 INFO - Return code: 0 10:27:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:11 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:11 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 10:27:11 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 10:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:11 INFO - 'HOME': '/Users/cltbld', 10:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:11 INFO - 'LOGNAME': 'cltbld', 10:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:11 INFO - 'MOZ_NO_REMOTE': '1', 10:27:11 INFO - 'NO_EM_RESTART': '1', 10:27:11 INFO - 'PAGER': '/bin/cat', 10:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:11 INFO - 'PWD': '/builds/slave/test', 10:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:11 INFO - 'SHELL': '/bin/bash', 10:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:11 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:11 INFO - 'USER': 'cltbld', 10:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:11 INFO - 'XPC_FLAGS': '0x0', 10:27:11 INFO - 'XPC_SERVICE_NAME': '0', 10:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:12 INFO - Downloading/unpacking psutil>=0.7.1 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:15 INFO - Installing collected packages: psutil 10:27:15 INFO - Running setup.py install for psutil 10:27:15 INFO - building 'psutil._psutil_osx' extension 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 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 10:27:15 INFO - building 'psutil._psutil_posix' extension 10:27:15 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 10:27:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:27:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:27:16 INFO - ^ 10:27:16 INFO - 1 warning generated. 10:27:16 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 10:27:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:16 INFO - Successfully installed psutil 10:27:16 INFO - Cleaning up... 10:27:16 INFO - Return code: 0 10:27:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:27:16 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')]} 10:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:16 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')]} 10:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:16 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:16 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 10:27:16 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 10:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:16 INFO - 'HOME': '/Users/cltbld', 10:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:16 INFO - 'LOGNAME': 'cltbld', 10:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:16 INFO - 'MOZ_NO_REMOTE': '1', 10:27:16 INFO - 'NO_EM_RESTART': '1', 10:27:16 INFO - 'PAGER': '/bin/cat', 10:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:16 INFO - 'PWD': '/builds/slave/test', 10:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:16 INFO - 'SHELL': '/bin/bash', 10:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:16 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:16 INFO - 'USER': 'cltbld', 10:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:16 INFO - 'XPC_FLAGS': '0x0', 10:27:16 INFO - 'XPC_SERVICE_NAME': '0', 10:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:27:16 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 10:27:16 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 10:27:16 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 10:27:16 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 10:27:16 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 10:27:16 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 10:27:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:27:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:27:19 INFO - Installing collected packages: mozsystemmonitor 10:27:19 INFO - Running setup.py install for mozsystemmonitor 10:27:19 INFO - Successfully installed mozsystemmonitor 10:27:19 INFO - Cleaning up... 10:27:19 INFO - Return code: 0 10:27:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:19 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:19 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 10:27:19 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 10:27:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:19 INFO - 'HOME': '/Users/cltbld', 10:27:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:19 INFO - 'LOGNAME': 'cltbld', 10:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:19 INFO - 'MOZ_NO_REMOTE': '1', 10:27:19 INFO - 'NO_EM_RESTART': '1', 10:27:19 INFO - 'PAGER': '/bin/cat', 10:27:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:19 INFO - 'PWD': '/builds/slave/test', 10:27:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:19 INFO - 'SHELL': '/bin/bash', 10:27:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:19 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:19 INFO - 'USER': 'cltbld', 10:27:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:19 INFO - 'XPC_FLAGS': '0x0', 10:27:19 INFO - 'XPC_SERVICE_NAME': '0', 10:27:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:27:20 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 10:27:20 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 10:27:20 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 10:27:20 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 10:27:20 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 10:27:20 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 10:27:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:27:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:27:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:23 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 10:27:24 INFO - Downloading docopt-0.6.1.tar.gz 10:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:27:24 INFO - Installing collected packages: blobuploader, requests, docopt 10:27:24 INFO - Running setup.py install for blobuploader 10:27:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:27:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:27:24 INFO - Running setup.py install for requests 10:27:24 INFO - Running setup.py install for docopt 10:27:25 INFO - Successfully installed blobuploader requests docopt 10:27:25 INFO - Cleaning up... 10:27:25 INFO - Return code: 0 10:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:25 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:25 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 10:27:25 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 10:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:25 INFO - 'HOME': '/Users/cltbld', 10:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:25 INFO - 'LOGNAME': 'cltbld', 10:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:25 INFO - 'MOZ_NO_REMOTE': '1', 10:27:25 INFO - 'NO_EM_RESTART': '1', 10:27:25 INFO - 'PAGER': '/bin/cat', 10:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:25 INFO - 'PWD': '/builds/slave/test', 10:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:25 INFO - 'SHELL': '/bin/bash', 10:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:25 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:25 INFO - 'USER': 'cltbld', 10:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:25 INFO - 'XPC_FLAGS': '0x0', 10:27:25 INFO - 'XPC_SERVICE_NAME': '0', 10:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-vKmZ1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-pjbSts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-0oMRaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-WgxXVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-cymL9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:27:25 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-sycLR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-jpyMoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-U5N_IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-KFAIys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-XdGKua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-BIXBq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-mwNQOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-9e1c5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-1a4rMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-EQCjPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:27:26 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-CuYnip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:27:27 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-9gBGAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:27:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:27:27 INFO - Running setup.py install for manifestparser 10:27:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:27:27 INFO - Running setup.py install for mozcrash 10:27:27 INFO - Running setup.py install for mozdebug 10:27:27 INFO - Running setup.py install for mozdevice 10:27:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:27:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:27:27 INFO - Running setup.py install for mozfile 10:27:27 INFO - Running setup.py install for mozhttpd 10:27:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Running setup.py install for mozinfo 10:27:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Running setup.py install for mozInstall 10:27:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Running setup.py install for mozleak 10:27:28 INFO - Running setup.py install for mozlog 10:27:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Running setup.py install for moznetwork 10:27:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:27:28 INFO - Running setup.py install for mozprocess 10:27:28 INFO - Running setup.py install for mozprofile 10:27:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:27:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:27:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:27:29 INFO - Running setup.py install for mozrunner 10:27:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:27:29 INFO - Running setup.py install for mozscreenshot 10:27:29 INFO - Running setup.py install for moztest 10:27:29 INFO - Running setup.py install for mozversion 10:27:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:27:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:27:29 INFO - Cleaning up... 10:27:29 INFO - Return code: 0 10:27:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:29 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:29 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 10:27:29 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 10:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:29 INFO - 'HOME': '/Users/cltbld', 10:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:29 INFO - 'LOGNAME': 'cltbld', 10:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:29 INFO - 'MOZ_NO_REMOTE': '1', 10:27:29 INFO - 'NO_EM_RESTART': '1', 10:27:29 INFO - 'PAGER': '/bin/cat', 10:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:29 INFO - 'PWD': '/builds/slave/test', 10:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:29 INFO - 'SHELL': '/bin/bash', 10:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:29 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:29 INFO - 'USER': 'cltbld', 10:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:29 INFO - 'XPC_FLAGS': '0x0', 10:27:29 INFO - 'XPC_SERVICE_NAME': '0', 10:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:27:29 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-i0v2uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-gPUQtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-05NiDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-4lxXgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-rxWWRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ORaQ4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-CPiHBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-MF5npG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-13RNwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:27:30 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)) 10:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:27:30 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-JRwRUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-DdveDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-xV0rBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-K6Y4xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-inn_10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-GcfUsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-9i8CBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:27:31 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)) 10:27:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:27:31 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-RlmZvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:27:31 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)) 10:27:31 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)) 10:27:31 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)) 10:27:31 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)) 10:27:31 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)) 10:27:31 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)) 10:27:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:34 INFO - Downloading blessings-1.6.tar.gz 10:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:27:34 INFO - Installing collected packages: blessings 10:27:34 INFO - Running setup.py install for blessings 10:27:34 INFO - Successfully installed blessings 10:27:34 INFO - Cleaning up... 10:27:34 INFO - Return code: 0 10:27:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:34 INFO - Reading from file tmpfile_stdout 10:27:34 INFO - Current package versions: 10:27:34 INFO - blessings == 1.6 10:27:34 INFO - blobuploader == 1.2.4 10:27:34 INFO - docopt == 0.6.1 10:27:34 INFO - manifestparser == 1.1 10:27:34 INFO - mozInstall == 1.12 10:27:34 INFO - mozcrash == 0.17 10:27:34 INFO - mozdebug == 0.1 10:27:34 INFO - mozdevice == 0.48 10:27:34 INFO - mozfile == 1.2 10:27:34 INFO - mozhttpd == 0.7 10:27:34 INFO - mozinfo == 0.9 10:27:34 INFO - mozleak == 0.1 10:27:34 INFO - mozlog == 3.1 10:27:34 INFO - moznetwork == 0.27 10:27:34 INFO - mozprocess == 0.22 10:27:34 INFO - mozprofile == 0.28 10:27:34 INFO - mozrunner == 6.11 10:27:34 INFO - mozscreenshot == 0.1 10:27:34 INFO - mozsystemmonitor == 0.0 10:27:34 INFO - moztest == 0.7 10:27:34 INFO - mozversion == 1.4 10:27:34 INFO - psutil == 3.1.1 10:27:34 INFO - requests == 1.2.3 10:27:34 INFO - wsgiref == 0.1.2 10:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27:34 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')]} 10:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:34 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')]} 10:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:34 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:34 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 10:27:34 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 10:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:34 INFO - 'HOME': '/Users/cltbld', 10:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:34 INFO - 'LOGNAME': 'cltbld', 10:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:34 INFO - 'MOZ_NO_REMOTE': '1', 10:27:34 INFO - 'NO_EM_RESTART': '1', 10:27:34 INFO - 'PAGER': '/bin/cat', 10:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:34 INFO - 'PWD': '/builds/slave/test', 10:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:34 INFO - 'SHELL': '/bin/bash', 10:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:34 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:34 INFO - 'USER': 'cltbld', 10:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:34 INFO - 'XPC_FLAGS': '0x0', 10:27:34 INFO - 'XPC_SERVICE_NAME': '0', 10:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 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)) 10:27:35 INFO - Cleaning up... 10:27:35 INFO - Return code: 0 10:27:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:35 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:35 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 10:27:35 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 10:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:35 INFO - 'HOME': '/Users/cltbld', 10:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:35 INFO - 'LOGNAME': 'cltbld', 10:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:35 INFO - 'MOZ_NO_REMOTE': '1', 10:27:35 INFO - 'NO_EM_RESTART': '1', 10:27:35 INFO - 'PAGER': '/bin/cat', 10:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:35 INFO - 'PWD': '/builds/slave/test', 10:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:35 INFO - 'SHELL': '/bin/bash', 10:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:35 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:35 INFO - 'USER': 'cltbld', 10:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:35 INFO - 'XPC_FLAGS': '0x0', 10:27:35 INFO - 'XPC_SERVICE_NAME': '0', 10:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:35 INFO - Downloading/unpacking jsonschema 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:27:37 INFO - Downloading/unpacking functools32 (from jsonschema) 10:27:37 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 10:27:37 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 10:27:37 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 10:27:37 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 10:27:37 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 10:27:37 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 10:27:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:27:38 INFO - warning: no files found matching '*.txt' 10:27:38 INFO - no previously-included directories found matching 'build' 10:27:38 INFO - no previously-included directories found matching 'dist' 10:27:38 INFO - no previously-included directories found matching '.git*' 10:27:38 INFO - Installing collected packages: jsonschema, functools32 10:27:38 INFO - Running setup.py install for functools32 10:27:38 INFO - warning: no files found matching '*.txt' 10:27:38 INFO - no previously-included directories found matching 'build' 10:27:38 INFO - no previously-included directories found matching 'dist' 10:27:38 INFO - no previously-included directories found matching '.git*' 10:27:38 INFO - Successfully installed jsonschema functools32 10:27:38 INFO - Cleaning up... 10:27:38 INFO - Return code: 0 10:27:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:38 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 0x10348da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10349d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03a598f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, '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.oQSz88gCKv/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.oBGT9RS66c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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 10:27:38 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 10:27:38 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 10:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:38 INFO - 'HOME': '/Users/cltbld', 10:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:38 INFO - 'LOGNAME': 'cltbld', 10:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:38 INFO - 'MOZ_NO_REMOTE': '1', 10:27:38 INFO - 'NO_EM_RESTART': '1', 10:27:38 INFO - 'PAGER': '/bin/cat', 10:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:38 INFO - 'PWD': '/builds/slave/test', 10:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:38 INFO - 'SHELL': '/bin/bash', 10:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:27:38 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:38 INFO - 'USER': 'cltbld', 10:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:38 INFO - 'XPC_FLAGS': '0x0', 10:27:38 INFO - 'XPC_SERVICE_NAME': '0', 10:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:38 INFO - Downloading/unpacking flake8 10:27:38 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 10:27:38 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 10:27:38 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 10:27:38 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 10:27:38 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 10:27:38 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 10:27:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:27:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:27:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:41 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 10:27:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:27:42 INFO - no previously-included directories found matching 'docs/_build' 10:27:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:27:42 INFO - Running setup.py install for pep8 10:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:27:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:27:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:27:42 INFO - no previously-included directories found matching 'docs/_build' 10:27:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:27:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:27:42 INFO - Cleaning up... 10:27:42 INFO - Return code: 0 10:27:42 INFO - Running post-action listener: _resource_record_post_action 10:27:42 INFO - Running post-action listener: _start_resource_monitoring 10:27:42 INFO - Starting resource monitoring. 10:27:42 INFO - ##### 10:27:42 INFO - ##### Running install step. 10:27:42 INFO - ##### 10:27:42 INFO - Running pre-action listener: _resource_record_pre_action 10:27:42 INFO - Running main action method: install 10:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:43 INFO - Reading from file tmpfile_stdout 10:27:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:27:43 INFO - Reading from file tmpfile_stdout 10:27:43 INFO - Output received: 10:27:43 INFO - Usage: mozinstall [options] installer 10:27:43 INFO - Options: 10:27:43 INFO - -h, --help show this help message and exit 10:27:43 INFO - -d DEST, --destination=DEST 10:27:43 INFO - Directory to install application into. [default: 10:27:43 INFO - "/builds/slave/test"] 10:27:43 INFO - --app=APP Application being installed. [default: firefox] 10:27:43 INFO - mkdir: /builds/slave/test/build/application 10:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:28:17 INFO - Reading from file tmpfile_stdout 10:28:17 INFO - Output received: 10:28:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:28:17 INFO - Running post-action listener: _resource_record_post_action 10:28:17 INFO - ##### 10:28:17 INFO - ##### Running run-tests step. 10:28:17 INFO - ##### 10:28:17 INFO - Running pre-action listener: _resource_record_pre_action 10:28:17 INFO - Running main action method: run_tests 10:28:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:17 INFO - 2016-04-14 10:28:17.719 screenresolution[1642:7654] starting screenresolution argv=screenresolution get 10:28:17 INFO - 2016-04-14 10:28:17.721 screenresolution[1642:7654] Display 0: 1600x1200x32@60 10:28:17 INFO - 2016-04-14 10:28:17.728 screenresolution[1643:7657] starting screenresolution argv=screenresolution list 10:28:17 INFO - Available Modes on Display 0 10:28:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:17 INFO - Intel Iris: 10:28:17 INFO - Chipset Model: Intel Iris 10:28:17 INFO - Type: GPU 10:28:17 INFO - Bus: Built-In 10:28:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:17 INFO - Vendor: Intel (0x8086) 10:28:17 INFO - Device ID: 0x0a2e 10:28:17 INFO - Revision ID: 0x0009 10:28:17 INFO - Displays: 10:28:17 INFO - Display: 10:28:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:17 INFO - Display Serial Number: 1600x1200 60 10:28:17 INFO - Main Display: Yes 10:28:17 INFO - Mirror: Off 10:28:17 INFO - Online: Yes 10:28:17 INFO - Rotation: Supported 10:28:17 INFO - Return code: 0 10:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:17 INFO - Python 2.7.3 10:28:17 INFO - Return code: 0 10:28:17 INFO - grabbing minidump binary from tooltool 10:28: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')]} 10:28:17 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 0x10332ce00>, '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 0x103155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103327b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:17 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 10:28:17 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 10:28:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:18 INFO - Return code: 0 10:28:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:28:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:28:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:28:19 INFO - Return code: 0 10:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:28:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oQSz88gCKv/Render', 10:28:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:19 INFO - 'HOME': '/Users/cltbld', 10:28:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:19 INFO - 'LOGNAME': 'cltbld', 10:28:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:19 INFO - 'MOZ_NO_REMOTE': '1', 10:28:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:19 INFO - 'NO_EM_RESTART': '1', 10:28:19 INFO - 'PAGER': '/bin/cat', 10:28:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:19 INFO - 'PWD': '/builds/slave/test', 10:28:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:19 INFO - 'SHELL': '/bin/bash', 10:28:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oBGT9RS66c/Listeners', 10:28:19 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 10:28:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:19 INFO - 'USER': 'cltbld', 10:28:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:19 INFO - 'XPC_FLAGS': '0x0', 10:28:19 INFO - 'XPC_SERVICE_NAME': '0', 10:28:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:28:19 INFO - mozversion application_buildid: 20160414083550 10:28:19 INFO - mozversion application_changeset: b40daaf112476e4d07b3fcfec36223d0852449d4 10:28:19 INFO - mozversion application_display_name: Nightly 10:28:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:19 INFO - mozversion application_name: Firefox 10:28:19 INFO - mozversion application_remotingname: firefox 10:28:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:28:19 INFO - mozversion application_vendor: Mozilla 10:28:19 INFO - mozversion application_version: 48.0a1 10:28:19 INFO - mozversion platform_buildid: 20160414083550 10:28:19 INFO - mozversion platform_changeset: b40daaf112476e4d07b3fcfec36223d0852449d4 10:28:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:28:19 INFO - mozversion platform_version: 48.0a1 10:28:19 INFO - using testdate: 1460654899 10:28:19 INFO - actual date: 1460654899 10:28:19 INFO - starting webserver on 'localhost:49278' 10:28:19 INFO - SUITE-START | Running 2 tests 10:28:19 INFO - TEST-START | dromaeo_css 10:28:19 INFO - operating with platform_type : mac_ 10:28:19 INFO - Initialising browser for dromaeo_css test... 10:28:19 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpxK6j_n/profile http://localhost:49278/getInfo.html) 10:28:21 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 10:28:21 INFO - PROCESS | 1661 | colorDepth:24 10:28:21 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 10:28:21 INFO - PROCESS | 1661 | __metrics 10:28:22 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:28:22 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:28:22 INFO - TEST-INFO | 1661: exit 0 10:28:22 INFO - Browser initialized. 10:28:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:22 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpxK6j_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:34 INFO - PROCESS | 1663 | RSS: Main: 237576192 10:28:34 INFO - PROCESS | 1663 | 10:29:25 INFO - PROCESS | 1663 | 1460654965631 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] 10:31:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:31:37 INFO - PROCESS | 1663 | RSS: Main: 385810432 10:31:37 INFO - PROCESS | 1663 | 10:34:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 10:34:40 INFO - PROCESS | 1663 | RSS: Main: 378556416 10:34:40 INFO - PROCESS | 1663 | 10:37:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:37:43 INFO - PROCESS | 1663 | RSS: Main: 375296000 10:37:43 INFO - PROCESS | 1663 | 10:40:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:40:46 INFO - PROCESS | 1663 | RSS: Main: 376201216 10:40:46 INFO - PROCESS | 1663 | 10:43:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:43:50 INFO - PROCESS | 1663 | RSS: Main: 345952256 10:43:50 INFO - PROCESS | 1663 | 10:46:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:46:53 INFO - PROCESS | 1663 | RSS: Main: 384741376 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | __start_tp_report 10:46:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 10:46:53 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 10:46:53 INFO - PROCESS | 1663 | |i|pagename|runs| 10:46:53 INFO - PROCESS | 1663 | |0;dojo.html;2975.6875528069554;3380.121168496191;3425.092350527112;3443.259699164679;3462.601800792908;5571.331440227168;5629.240052592899;5644.096944488882;5645.943540564593;5670.0927851543765;5625;5630.380658127613;5632.690202038886;5775.451332123452;5788.739506722197;5060.746962651871;5064.772085256172;5094.261332106842;5101.260317253996;5105.05556472052;5110.693358398489;5113.1307677694695;5131.717755523445;5146.819861304855;5192.974035129819;5053.065182941167;5059.4181669107975;5065.265536497224;5150.278960945433;5153.974230128844;5135.3067335909545;5139.0749665060275;5143.614228932807;5148.099082660557;5148.794048238104;5060.443351231362;5120.564751996085;5133.178691409394;5140.691558506502;5176.0683077046115;5478.342598888119;5483.396826349099;5576.275084239063;5594.776208951637;5621.747021384007;6135.570510064297;6143.840248219912;6156.138140660311;6166.568340216187;6188.071789231606;6145.539084568675;6205.720742566596;6231.003039513656;6233.345498722614;6239.126522286883;5329.680219186861;5611;5696.886062278772;5727.885442291173;5817.894600025981;6199.876002479925;6203.16257305267;6223.3465486123305;6227.221597300338;6243.562950593415;6075.179850720185;6081.239845019372;6087.512998960073;6090.451859332681;6091.42131497507;5967.283925928917;6095.377886651403;6122.093225952662;6185.628862268279;6217.129601855744;6088.082901554369;6113.480354169857;6119.289302195883;6141.877162456726;6146.692665366714;6145.754169833246;6151.046587778901;6157.630542167484;6159.076138579249;6159.3224745277985;4827.42070951488;4832.299316599144;4889.682170658896;4889.997550502138;4901.852944411602;3779.622037796253;4283.957160428356;4433.889152771207;4458.197524445566;4465.218586747306;5561.63849349791;5601.719914004365;5602.663840169603;5612;5635.464630860061;6131.601445906002;6202.472789812917;6207.099970504251;6212.9068063979075;6230.127782110508;5493.038718224295;5582.637128586629;5592.189132575753;5616.0171969905105;5623.718814059281;4384;5294.285271488377;5349.893002139936;5363.839084827461;5371.328583927009;6190.133381326618;6221.377862213742;6226.813195604139;6230;6259.061140828821;5300.734963251745;6052.061930400795;6112.663803490851;6201.689915504297;6225.470834979077;6176.073588961692;6226.377362263918;6267.4045965633195;6267.780627678009;6271.3728627136925;6072.210612620331;6090.725917333642;6091.238595175603;6093.482054025458;6095.444577600282;6063.484603808549;6160.291566469913;6183.81448556544;6205.627662340274;6212.844678882883;5877.794277200449;5940.495057920125;6041.486473649789;6050.969745151246;6075.149479072845;5824.592278540462;5995.5803093783015;6004.099385092271;6042.607230530001;6051.667158306335;5737.885242295214;5865.882682346414;5880.529557635465;5899;5925.9407405925385;5884.499817515559;5911.940880591139;5928.407159284037;5941.287045554561;6020.217371741821;5713.114467257582;5738.081906894877;5749.683767392834;5782.277215348082;5784.479396854304 10:46:53 INFO - PROCESS | 1663 | |1;ext.html;499.19629396671354;505.02530116874465;511.16679811906585;545.5362941499726;552.1965540139099;24800.50398992019;29779.808807647696;29856.104316870475;29868.40263194735;29900.700992990063;38960.61039389605;39129.60870391295;39709.602903970954;39753.80123099388;39879.80060099703;9410.153086222239;9625.133737963582;9658.275629327793;9658.855117173249;9700.126988571028;8588.742337729878;9433.858492122623;9602.75993100171;9630;11557.364344961024;11519;11636.767264654702;11648.650540483799;11649.767004659901;11665.41672916355;11395.145364097685;11506;11515.078793696484;11517.25137866036;11524.711882203012;11395.031422329112;11493.42532873353;11528.654140375802;11530.192886497949;11536.942315288454;37919.81040094782;38325.42511862297;38341.616583834366;38382.424263636065;40049.39925901085;3366.6801653842845;3531.8410671519587;3706.8517259309597;3745.4381842723537;3805.2769973705185;24887.62668559973;29135.125946221648;29391.412171756445;29981.25046873824;30018.399632007455;2720.9058419448934;2739.2330147558714;2780.263230243987;2780.33272014715;2791.9581206281923;474581;478991;479528.60235698946;479594;480262;58064.70967645219;58231;58406.707966460745;60140.39859601348;60154.39845601488;63150.42123946938;63305.68347158327;63394.68302658457;63410;63506.682466588296;16110.597235068983;16557.006579605262;16703.749443758352;16708.24812883423;16721.331146753993;12943.741125177443;13032.957363410904;13048.151870128411;13058.608241752763;13095.672608184872;14130.929345353414;14572.615601517839;15662.216889155725;16084.195790210442;16239.538441540319;6087.665178415141;6775.932240677629;6842.349976752201;7016.824579385556;7076.681549330293;950.8003319302885;967.5742673223759;1010.3584224017654;1013.1843865688045;1053.3679792124665;24532.754672453404;29364.82540698348;29487.55768663472;30006.39987200244;30131.09606711758;1107.3134656513014;1112.8831472695413;1150.0741902768184;1152.2049785647876;1192.2607983050564;15021.549353519413;15138.318775655121;15148.469803556822;15562.766558501631;15623.609409764847;521417;527121;532644;534651;536674;60272.39727602668;61061.69469152715;61066.38933610607;61296.693516532134;61314.38685613176;1418.0499065626054;1455.9490417835325;1471.801306823565;1503.6992601479528;1512.447956495893;23374.181903633293;28399.006034788683;28453.573196402485;28720.138395848157;29030.27424314409;35498;44542;44899.877503062686;44913.550864490935;44982.55017449784;398966;401412;402326;402502;403762;33695.98912032643;38758.418623721234;39389.409158863215;39713.2057358857;40604;44837.32744008777;44853;44933;46261.76869115633;46486.07027859492;30335;35569.64430355767;35946.4608030885;37373;37865.81067094757;29642.85178574093;35956.4606530897;36340.81829590835;37081.88754337374;37403.87788366353;36952.815235924725;37274.627253727114;37339.87980360594;37648.62351376451;38522;24198.63702044506;30492.542611861285;31289.646932971187;31598.52602210923;31598.684013159575;23313;23438.414039649146;23603.40991475227;23811.28566142949;23921.401964951016 10:46:53 INFO - PROCESS | 1663 | |2;jquery.html;385.3045253317761;385.3853104298644;388.3495145631069;399.516584932232;404.87651266363787;15637.530874073767;15962.605609158632;19870;21633.35099947002;21642.567148657035;20155.294564690237;21000.789992100075;21073.57852842942;21274.14903403866;21939.012744426498;5670.5463562914865;5879.559033072526;6074.149619053336;6074.665893375863;6104.542159338045;3906.6484016438517;6015.669138197398;6040.848978775522;6070.2412198475195;6070.392960703938;5753;6110.694465276741;6115.633062016271;6121.938780612204;6130.570860039777;6113.663748493831;6128.601640893327;6189.288231853349;6695.598264104121;6727.596344219362;5714.685692286923;5881.441263080001;5894.410558944114;5904.645721256738;5910.34986151523;11540.884591154065;13011.219326840324;14018.649533761636;14030.508932187426;14054.929725351309;2003.4690806936173;2028.0670891389977;2028.4863987896717;2047.580246049571;2095.8428117891217;9920.751981200456;9947.452890091043;10322.741931451774;10359.689209323733;10389.220808439397;1743.0935913325;1766.1257677449744;1777.8666600004922;1793.2378739035987;1860.5162657708959;87420.93192591805;88739;107077;115572.84427155704;121660;10491.10825579819;10565.260431769702;10731.731706707395;10744.677659670222;10842.566297348018;13388.330583470983;13418.127821691558;13475.865241347461;13487.393067311994;13499.460021599223;8288.875666865002;8476.770868224074;8479.89761331023;8575.914240857512;8609.61256743448;8608.397412181088;8609.397342186112;8610.225079742853;8710.782230444289;8724.78188045304;3490.2321489272317;4088.7751173685733;4150.937735933963;4162.209180255742;4221.5778422158155;1907.1322548240516;1962.6369121712528;1967.370441458748;1977.3672424824206;1993.7208790769305;909.3679892474667;920.7836158502746;953.3612479638658;955.7992821507422;1012.4583347908833;19056.428307150807;19836.900815495832;20185.798142018393;20198.697019544717;20434.69347959782;948.2698322291797;953.5661274120258;957.7797106665506;962.9374090684083;1070.0904231403244;10689.893101069045;10978.286411383395;10998.06516446095;11015.669529914116;11031.503582338813;565060;604895;605218;610960;617627;116590;118416.40791796158;119263.40368298104;121147;121860;996.4519514267124;999.3054826895383;1012.2104758288547;1014.8985101489792;1036.2176556699794;18012.91922484655;18295.634087318445;18379;18503.629927401107;18512.309273618204;47828.52171478241;48222.79443013812;49163;50506.737331567005;50563.49436505735;61610.69194653998;65005;73076.90384644129;73467.63266183635;76032.23967760251;7816.609169541386;8073.636686349011;8141.0637776654075;8284.544350060805;8480.491170529787;10348.482575871025;12077;12671.493140274286;12684;12974.545890893773;10738.67783966451;11146.052585529997;11359;11452.08383329315;11455.255408398762;10714.357138571711;11046.30129790326;11270.211085223955;11426.2001659883;11557.422128893353;8999.730008099768;11150.776984460103;11450.141239406912;11592.420378981185;11858.584949526725;8308.335333173452;8309.83380332402;8436.198561136682;8441.36689748259;8467.957660211907;8471.407001509835;10920.945395272973;11205.943970280096;11398.97409233173;11550.075993920635 10:46:53 INFO - PROCESS | 1663 | |3;mootools.html;1297.573537484902;1563.8592526672596;1568.1375243616012;1692.6022384739583;1819.972700409494;8073.838523229532;8788.252998495127;9025.052369501207;9035.096490350961;9040.54797260137;8681.73954781356;8767.16711912369;8842.115788421155;8843.425177363482;8910.46537207768;2251.2120757734824;2338.4916728709973;2444.5477586646484;2468.419921318489;2470.3206618179966;2091.9686204706863;2422.63660450932;2445.608702607583;2469.987650061747;2475.084218839032;2433.926982190528;2449.595816690244;2469.1975108089855;2470.0984140788573;2471.036295844622;2413.1553956115395;2440.9389765255833;2448.902043918241;2453.779159875602;2455.3493324269084;2403.987980060106;2420.4311986683115;2434.610462326037;2435.3789783605243;2435.6833611630373;8745.912540874637;8874.911250887537;8896.154865287852;8960.731178064669;8963.103689630985;4798.904021919542;5201.349831271091;5434.184872269152;5458.181272809071;5475.616706830523;3468.7051600613727;3488.5464889564446;3565.5721313442295;3566.465030245458;3576.5886923003927;997.8253805584067;1011.1910471622673;1011.5801942193981;1020.3571749797654;1022.2690776095128;11572.363520006396;11916.582919597773;11941.343226122559;11950.820737688942;11958;4228.9154216915485;4422.695304885066;4533.252013417749;4536.7731613419855;4727.432708075053;9188.678396256233;9203.907960920438;9232.21526170283;9237.261019118454;9243.168114869693;5340.412554618989;5360.973195133999;5368.651037682538;5369.597280203922;5378.327709036371;4398.4941731701265;4458.4426946631675;4480.551944805558;4875.634327425457;5017.89964200714;3805.6765174959883;3827.3876179811095;3858.4180486001164;3889.202713443737;3909.5308562972054;1196.0670676872053;1198.1133960868895;1198.6284251881943;1215.9115845751692;1217.689489180271;796.80079980005;854.7264875239988;890.6615486115235;913.9497327647043;950.4107453378949;5927.347991720907;5934.19888315072;6043.909341359883;6196.411340922605;6213.161223234805;806.1978331560135;908.1327332397676;969.2730452160879;969.8302797010637;1027.075631931268;3184.697453741891;3993.840246390112;4048.1296521248073;4072.75563466193;4073.348264277701;10532.10477109439;10652.254342195973;10847.620333288298;10998.725031874266;11135.777284454427;10729.678109656566;10874.619388321371;11151.442427878736;11159.72100697489;11201.887981120248;8266.875996860052;8461.873071903927;8491.320694344438;8530.573471326534;8535.487870727777;5188.7405629719115;5696.629719068247;5905.232319798571;5926;5980.850478738066;10177.440240786827;10262.640807571699;10349.896501034893;10366.896331036593;10371.481425928825;9846.867610224916;10205.13256373187;10478.842817357898;10527.052565269163;10650.946745266225;6478.902816457663;6697.2633010367845;6853.657317134223;7076.433885289268;7097.7160913562875;8422.915770842214;8471.957640212006;8517.659293628185;8524.957375213084;8531.488110713377;7345.522541034816;7611.086669599462;7624.504407213513;7743.070831500256;7762.41781866351;7363.77908662741;7394.630268486447;7469.962650186714;7553.395728341829;7591.278828511283;7104.573725576482;7180.892286615601;7181.030560874216;7197.676104575202;7202.567845929261;4701.083288758659;4904.141775189399;4924.96575719103;4925.852224433273;4963.553280204799;4819.060283244874;4873.6832105913;4896.9755151225445;4949;5017.924731129109 10:46:53 INFO - PROCESS | 1663 | |4;prototype.html;309.6500953922068;315.11767052253697;317.75374085084064;323.1630078097728;328.13863608028925;5869.501092407145;5873.735681894314;5892.528597712183;5893.55798315126;5900.822975310747;4915.680480768748;5776.740046697898;5808.273965754281;5821.3887541808135;5862.599692178537;3691.3909204981146;4162.604552567501;4170.186813571355;4267.381229721688;4359.280718681413;4280.229558679452;4346.413234213388;4352.281873490871;4363.258246098155;4365.694401391904;3921.784301863396;4071.1654110907343;4314.546972567882;4339;4345.369921361401;4166.062780806924;4329.328954012101;4341.351775416993;4353.738775673438;4367.803448844794;3702.7593206441493;3740.719446041531;3752.137008488063;3754.3242216401036;3767.097615704079;5065;5310.92033619496;5613.971930140364;5615.326160860682;5622.212890195376;4633.397658304432;4834.419869615634;4930.161872481651;4966.255061740731;5048.62135339851;5222.817201397971;6035.426634469763;6133.754649814002;6146.8770624587705;6166.660833654148;4117.382392641098;4126.628603425706;4126.752394856288;4131.710780245384;4139.089400331922;5667.089708101397;6174.351693072253;6442.903356449657;6523.804285871432;6540.4767618590395;4084.4077608746566;4126.855560055444;4162.41726158338;4162.62536371728;4168.749875007509;4207.726497777635;4217.00900288432;4222.113356195234;4233.491980962242;4245.57544245573;4731.976340118277;4773.427188737373;4956.851294461172;5062.848114556569;5137.2037334213255;5978.760849565969;6191.721372538246;6203.270560953166;6244.313125556185;6278.937210627927;1158.3802665573878;1415.4550498058322;1498.6103613060466;1538.3462028638007;1538.8612426804084;879.0725784297628;949.4730424614268;1009;1011.5245834457793;1026.2559644257854;4986.476419975923;5564.360098588633;5638.85902852432;5649.802256920988;5665.5184309333345;5247.396549396868;6249.78125765596;6252.937470625327;6253.593516421418;6326.240851097898;4906.754662266872;5163.631637616035;5167.044096842096;5172;5635.519761789305;2816.6338376010985;3231.434498962672;3407.2844702612233;3408.0287118171204;3427.8628854846024;6391.904121438182;6757.837492002512;6786.488999070277;6796.640671865646;6855.383015528626;6549.821032214152;6597.86804263912;6670.332966703291;6673.833154171088;6694.732210711517;5445.863853403696;6263.686815659199;6454.451371633464;6753.527253092237;6792.830179245559;5705.486506214461;6437.774677886251;6448.32292609288;6489.221293444817;6493.032829885236;5666.829995100154;6370.745170193326;6387.818253623094;6414.358564143548;6417.8395540110005;5734.111212762028;5858.297004359504;6143.447089761943;6768.120144381396;6832.897506537505;4140.358244472111;4145.91708165841;4181.853635122756;4189.769562674082;4219.535851056443;5493.9286839066;5800.302859170337;5889.469947704727;6190.966426451097;6453.16108905858;6119.938800611937;6259.749610015549;6281.497480201481;6284.874302513833;6290.012244183976;4987.9251811223585;6229.719662615103;6241.750329986749;6244.219472565929;6422.229332480132;5660.462256085665;5926;5945.3757355477055;6124.601900876429;6211.627302361872;4650.976785107271;5607.934492446422;5695.430456954271;6237.220347456568;6262.655553944577;5140.532544378644;6139.938600613937;6154.415330543591;6166;6179.443850053517 10:46:53 INFO - PROCESS | 1663 | |5;yui.html;657.7632052461113;731.7182884589434;738.3723834740468;742.532204711032;746.6565379925235;15304;15337.616559586017;15587.986780859264;15597.766033509506;15618.687626247482;14315.570532884005;14378.856211437882;14455.494057707981;14479.855201447983;14488.855111448882;771.6026246483066;906.1934877958622;916.7708072981754;924.2882980105314;944.5418971798672;877.6840337478502;885.1016218538189;903.4759839293195;916.1983264643437;920.7974245665943;967.5839389062701;967.666155176463;970.4032020307495;971.5919313888148;971.9368241064343;959.0313783079071;963.6001059560274;963.9084286992725;964.5900492290748;964.599691128181;712.1845486917503;715.906932098829;715.9355657990806;716.2193209401725;716.4197000429668;12237.632871013884;13032.54386096482;13406.329683515884;13486.325683715775;13643.590692279247;11401.771964560663;11407.201495895291;11631.243969141979;11668.766624667544;11674.474648640831;9363.953180234123;9536.52317384128;9591.808163836684;9612.903870961341;10314.226433017553;3399.5410619566287;3452.9654703452893;3490.511328414024;3494.6330635283184;3572.4284114541547;69860;71844;73381.6330918342;76180.61909690472;82695.58652206701;9545.379550329206;9652.420854748598;9762.414255144715;9948.104670579683;10080.445575493271;21802.672959905613;21837.563248734936;21870.781292187192;21891.562168756853;21926.23258185956;7696.923030769621;7759.68961241544;7785.182555831556;7830.099538553025;7847.176046515148;4039.8182081805803;4062.939055914164;4117.608827161474;4132.91734165315;4148.647364974011;3556.5376501054698;3617.94573081404;3647.124690074363;3649.525561676965;3662.340778659867;649.1463725201345;658.7463826426764;663.9468842492589;668.9732410703615;703.426707233603;479.30740080583223;531.4472948133897;568.2802591912389;611.9816405507753;617.9227596550431;7768.495047821873;8044.879326810103;8138.186181381814;8200;8450.070492245848;499.9475055119233;506.5263978180413;582.1006544888158;594.7680404642193;597.6414151509147;3838.405047217686;3851.768893866377;3880.708946828999;3962.623550762673;3964.762084479586;89214;89287.10712892788;90335;91430.54284728666;94730;78211.43577128426;79291;79527.60236198783;79830.20169798228;81365;70464.06751527343;70623;70712;70780.29219707738;71028;7559.773206803805;7581.139069142435;7670.578118203329;7798.454108212371;8012.3590112792;35586.46620300646;43521;45042;45690;45718;58000.41999580119;61296;64085.71828563496;64571.03143452946;65418.01872972005;10300.845487317547;10427.895721042996;10539.63111291101;10656.84014739795;10796.244262901522;11029.83455248188;11083.72290692739;11130.833037504282;11361;11937.223836630748;10355;10485.895141048797;10716.249862509549;10820.188485863435;10951.616693415692;10266.691999240034;10387.220958427997;10855.728606784893;10902.563897444013;10923.781524369628;10165.52599873029;10413.47932603382;10641.308314959502;10661.520231589442;10727.785444291227;8976.461412315282;9154.359194856295;9185.724428267162;9265.397749146285;9406.952965235403;7878.369730421668;7906.9209307906185;8878;9049.457032578066;9144.63421463134 10:46:53 INFO - PROCESS | 1663 | __end_tp_report 10:46:53 INFO - PROCESS | 1663 | __start_cc_report 10:46:53 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1413 10:46:53 INFO - PROCESS | 1663 | __end_cc_report 10:46:53 INFO - PROCESS | 1663 | __startTimestamp1460656013139__endTimestamp 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | ------- Summary: start ------- 10:46:53 INFO - PROCESS | 1663 | Number of tests: 6 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5649.22 Median:5824.59 stddev:645.30 (11.1%) stddev-sans-first:612.24 10:46:53 INFO - PROCESS | 1663 | Values: 2975.7 3380.1 3425.1 3443.3 3462.6 5571.3 5629.2 5644.1 5645.9 5670.1 5625.0 5630.4 5632.7 5775.5 5788.7 5060.7 5064.8 5094.3 5101.3 5105.1 5110.7 5113.1 5131.7 5146.8 5193.0 5053.1 5059.4 5065.3 5150.3 5154.0 5135.3 5139.1 5143.6 5148.1 5148.8 5060.4 5120.6 5133.2 5140.7 5176.1 5478.3 5483.4 5576.3 5594.8 5621.7 6135.6 6143.8 6156.1 6166.6 6188.1 6145.5 6205.7 6231.0 6233.3 6239.1 5329.7 5611.0 5696.9 5727.9 5817.9 6199.9 6203.2 6223.3 6227.2 6243.6 6075.2 6081.2 6087.5 6090.5 6091.4 5967.3 6095.4 6122.1 6185.6 6217.1 6088.1 6113.5 6119.3 6141.9 6146.7 6145.8 6151.0 6157.6 6159.1 6159.3 4827.4 4832.3 4889.7 4890.0 4901.9 3779.6 4284.0 4433.9 4458.2 4465.2 5561.6 5601.7 5602.7 5612.0 5635.5 6131.6 6202.5 6207.1 6212.9 6230.1 5493.0 5582.6 5592.2 5616.0 5623.7 4384.0 5294.3 5349.9 5363.8 5371.3 6190.1 6221.4 6226.8 6230.0 6259.1 5300.7 6052.1 6112.7 6201.7 6225.5 6176.1 6226.4 6267.4 6267.8 6271.4 6072.2 6090.7 6091.2 6093.5 6095.4 6063.5 6160.3 6183.8 6205.6 6212.8 5877.8 5940.5 6041.5 6051.0 6075.1 5824.6 5995.6 6004.1 6042.6 6051.7 5737.9 5865.9 5880.5 5899.0 5925.9 5884.5 5911.9 5928.4 5941.3 6020.2 5713.1 5738.1 5749.7 5782.3 5784.5 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:61284.51 Median:35758.05 stddev:125808.97 (351.8%) stddev-sans-first:126079.12 10:46:53 INFO - PROCESS | 1663 | Values: 499.2 505.0 511.2 545.5 552.2 24800.5 29779.8 29856.1 29868.4 29900.7 38960.6 39129.6 39709.6 39753.8 39879.8 9410.2 9625.1 9658.3 9658.9 9700.1 8588.7 9433.9 9602.8 9630.0 11557.4 11519.0 11636.8 11648.7 11649.8 11665.4 11395.1 11506.0 11515.1 11517.3 11524.7 11395.0 11493.4 11528.7 11530.2 11536.9 37919.8 38325.4 38341.6 38382.4 40049.4 3366.7 3531.8 3706.9 3745.4 3805.3 24887.6 29135.1 29391.4 29981.3 30018.4 2720.9 2739.2 2780.3 2780.3 2792.0 474581.0 478991.0 479528.6 479594.0 480262.0 58064.7 58231.0 58406.7 60140.4 60154.4 63150.4 63305.7 63394.7 63410.0 63506.7 16110.6 16557.0 16703.7 16708.2 16721.3 12943.7 13033.0 13048.2 13058.6 13095.7 14130.9 14572.6 15662.2 16084.2 16239.5 6087.7 6775.9 6842.3 7016.8 7076.7 950.8 967.6 1010.4 1013.2 1053.4 24532.8 29364.8 29487.6 30006.4 30131.1 1107.3 1112.9 1150.1 1152.2 1192.3 15021.5 15138.3 15148.5 15562.8 15623.6 521417.0 527121.0 532644.0 534651.0 536674.0 60272.4 61061.7 61066.4 61296.7 61314.4 1418.0 1455.9 1471.8 1503.7 1512.4 23374.2 28399.0 28453.6 28720.1 29030.3 35498.0 44542.0 44899.9 44913.6 44982.6 398966.0 401412.0 402326.0 402502.0 403762.0 33696.0 38758.4 39389.4 39713.2 40604.0 44837.3 44853.0 44933.0 46261.8 46486.1 30335.0 35569.6 35946.5 37373.0 37865.8 29642.9 35956.5 36340.8 37081.9 37403.9 36952.8 37274.6 37339.9 37648.6 38522.0 24198.6 30492.5 31289.6 31598.5 31598.7 23313.0 23438.4 23603.4 23811.3 23921.4 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33703.05 Median:21453.75 stddev:99771.10 (465.1%) stddev-sans-first:100019.62 10:46:53 INFO - PROCESS | 1663 | Values: 385.3 385.4 388.3 399.5 404.9 15637.5 15962.6 19870.0 21633.4 21642.6 20155.3 21000.8 21073.6 21274.1 21939.0 5670.5 5879.6 6074.1 6074.7 6104.5 3906.6 6015.7 6040.8 6070.2 6070.4 5753.0 6110.7 6115.6 6121.9 6130.6 6113.7 6128.6 6189.3 6695.6 6727.6 5714.7 5881.4 5894.4 5904.6 5910.3 11540.9 13011.2 14018.6 14030.5 14054.9 2003.5 2028.1 2028.5 2047.6 2095.8 9920.8 9947.5 10322.7 10359.7 10389.2 1743.1 1766.1 1777.9 1793.2 1860.5 87420.9 88739.0 107077.0 115572.8 121660.0 10491.1 10565.3 10731.7 10744.7 10842.6 13388.3 13418.1 13475.9 13487.4 13499.5 8288.9 8476.8 8479.9 8575.9 8609.6 8608.4 8609.4 8610.2 8710.8 8724.8 3490.2 4088.8 4150.9 4162.2 4221.6 1907.1 1962.6 1967.4 1977.4 1993.7 909.4 920.8 953.4 955.8 1012.5 19056.4 19836.9 20185.8 20198.7 20434.7 948.3 953.6 957.8 962.9 1070.1 10689.9 10978.3 10998.1 11015.7 11031.5 565060.0 604895.0 605218.0 610960.0 617627.0 116590.0 118416.4 119263.4 121147.0 121860.0 996.5 999.3 1012.2 1014.9 1036.2 18012.9 18295.6 18379.0 18503.6 18512.3 47828.5 48222.8 49163.0 50506.7 50563.5 61610.7 65005.0 73076.9 73467.6 76032.2 7816.6 8073.6 8141.1 8284.5 8480.5 10348.5 12077.0 12671.5 12684.0 12974.5 10738.7 11146.1 11359.0 11452.1 11455.3 10714.4 11046.3 11270.2 11426.2 11557.4 8999.7 11150.8 11450.1 11592.4 11858.6 8308.3 8309.8 8436.2 8441.4 8468.0 8471.4 10920.9 11205.9 11399.0 11550.1 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5736.20 Median:4874.66 stddev:3250.81 (66.7%) stddev-sans-first:3242.81 10:46:53 INFO - PROCESS | 1663 | Values: 1297.6 1563.9 1568.1 1692.6 1820.0 8073.8 8788.3 9025.1 9035.1 9040.5 8681.7 8767.2 8842.1 8843.4 8910.5 2251.2 2338.5 2444.5 2468.4 2470.3 2092.0 2422.6 2445.6 2470.0 2475.1 2433.9 2449.6 2469.2 2470.1 2471.0 2413.2 2440.9 2448.9 2453.8 2455.3 2404.0 2420.4 2434.6 2435.4 2435.7 8745.9 8874.9 8896.2 8960.7 8963.1 4798.9 5201.3 5434.2 5458.2 5475.6 3468.7 3488.5 3565.6 3566.5 3576.6 997.8 1011.2 1011.6 1020.4 1022.3 11572.4 11916.6 11941.3 11950.8 11958.0 4228.9 4422.7 4533.3 4536.8 4727.4 9188.7 9203.9 9232.2 9237.3 9243.2 5340.4 5361.0 5368.7 5369.6 5378.3 4398.5 4458.4 4480.6 4875.6 5017.9 3805.7 3827.4 3858.4 3889.2 3909.5 1196.1 1198.1 1198.6 1215.9 1217.7 796.8 854.7 890.7 913.9 950.4 5927.3 5934.2 6043.9 6196.4 6213.2 806.2 908.1 969.3 969.8 1027.1 3184.7 3993.8 4048.1 4072.8 4073.3 10532.1 10652.3 10847.6 10998.7 11135.8 10729.7 10874.6 11151.4 11159.7 11201.9 8266.9 8461.9 8491.3 8530.6 8535.5 5188.7 5696.6 5905.2 5926.0 5980.9 10177.4 10262.6 10349.9 10366.9 10371.5 9846.9 10205.1 10478.8 10527.1 10650.9 6478.9 6697.3 6853.7 7076.4 7097.7 8422.9 8472.0 8517.7 8525.0 8531.5 7345.5 7611.1 7624.5 7743.1 7762.4 7363.8 7394.6 7470.0 7553.4 7591.3 7104.6 7180.9 7181.0 7197.7 7202.6 4701.1 4904.1 4925.0 4925.9 4963.6 4819.1 4873.7 4897.0 4949.0 5017.9 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4992.11 Median:5614.65 stddev:1568.00 (27.9%) stddev-sans-first:1532.51 10:46:53 INFO - PROCESS | 1663 | Values: 309.7 315.1 317.8 323.2 328.1 5869.5 5873.7 5892.5 5893.6 5900.8 4915.7 5776.7 5808.3 5821.4 5862.6 3691.4 4162.6 4170.2 4267.4 4359.3 4280.2 4346.4 4352.3 4363.3 4365.7 3921.8 4071.2 4314.5 4339.0 4345.4 4166.1 4329.3 4341.4 4353.7 4367.8 3702.8 3740.7 3752.1 3754.3 3767.1 5065.0 5310.9 5614.0 5615.3 5622.2 4633.4 4834.4 4930.2 4966.3 5048.6 5222.8 6035.4 6133.8 6146.9 6166.7 4117.4 4126.6 4126.8 4131.7 4139.1 5667.1 6174.4 6442.9 6523.8 6540.5 4084.4 4126.9 4162.4 4162.6 4168.7 4207.7 4217.0 4222.1 4233.5 4245.6 4732.0 4773.4 4956.9 5062.8 5137.2 5978.8 6191.7 6203.3 6244.3 6278.9 1158.4 1415.5 1498.6 1538.3 1538.9 879.1 949.5 1009.0 1011.5 1026.3 4986.5 5564.4 5638.9 5649.8 5665.5 5247.4 6249.8 6252.9 6253.6 6326.2 4906.8 5163.6 5167.0 5172.0 5635.5 2816.6 3231.4 3407.3 3408.0 3427.9 6391.9 6757.8 6786.5 6796.6 6855.4 6549.8 6597.9 6670.3 6673.8 6694.7 5445.9 6263.7 6454.5 6753.5 6792.8 5705.5 6437.8 6448.3 6489.2 6493.0 5666.8 6370.7 6387.8 6414.4 6417.8 5734.1 5858.3 6143.4 6768.1 6832.9 4140.4 4145.9 4181.9 4189.8 4219.5 5493.9 5800.3 5889.5 6191.0 6453.2 6119.9 6259.7 6281.5 6284.9 6290.0 4987.9 6229.7 6241.8 6244.2 6422.2 5660.5 5926.0 5945.4 6124.6 6211.6 4651.0 5607.9 5695.4 6237.2 6262.7 5140.5 6139.9 6154.4 6166.0 6179.4 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17641.35 Median:32610.09 stddev:24934.55 (76.5%) stddev-sans-first:24971.89 10:46:53 INFO - PROCESS | 1663 | Values: 657.8 731.7 738.4 742.5 746.7 15304.0 15337.6 15588.0 15597.8 15618.7 14315.6 14378.9 14455.5 14479.9 14488.9 771.6 906.2 916.8 924.3 944.5 877.7 885.1 903.5 916.2 920.8 967.6 967.7 970.4 971.6 971.9 959.0 963.6 963.9 964.6 964.6 712.2 715.9 715.9 716.2 716.4 12237.6 13032.5 13406.3 13486.3 13643.6 11401.8 11407.2 11631.2 11668.8 11674.5 9364.0 9536.5 9591.8 9612.9 10314.2 3399.5 3453.0 3490.5 3494.6 3572.4 69860.0 71844.0 73381.6 76180.6 82695.6 9545.4 9652.4 9762.4 9948.1 10080.4 21802.7 21837.6 21870.8 21891.6 21926.2 7696.9 7759.7 7785.2 7830.1 7847.2 4039.8 4062.9 4117.6 4132.9 4148.6 3556.5 3617.9 3647.1 3649.5 3662.3 649.1 658.7 663.9 669.0 703.4 479.3 531.4 568.3 612.0 617.9 7768.5 8044.9 8138.2 8200.0 8450.1 499.9 506.5 582.1 594.8 597.6 3838.4 3851.8 3880.7 3962.6 3964.8 89214.0 89287.1 90335.0 91430.5 94730.0 78211.4 79291.0 79527.6 79830.2 81365.0 70464.1 70623.0 70712.0 70780.3 71028.0 7559.8 7581.1 7670.6 7798.5 8012.4 35586.5 43521.0 45042.0 45690.0 45718.0 58000.4 61296.0 64085.7 64571.0 65418.0 10300.8 10427.9 10539.6 10656.8 10796.2 11029.8 11083.7 11130.8 11361.0 11937.2 10355.0 10485.9 10716.2 10820.2 10951.6 10266.7 10387.2 10855.7 10902.6 10923.8 10165.5 10413.5 10641.3 10661.5 10727.8 8976.5 9154.4 9185.7 9265.4 9407.0 7878.4 7906.9 8878.0 9049.5 9144.6 10:46:53 INFO - PROCESS | 1663 | -------- Summary: end -------- 10:46:53 INFO - PROCESS | 1663 | 10:46:53 INFO - TEST-INFO | 1663: exit 0 10:46:53 INFO - TEST-OK | dromaeo_css | took 1114247ms 10:46:53 INFO - TEST-START | kraken 10:46:53 INFO - operating with platform_type : mac_ 10:46:53 INFO - Initialising browser for kraken test... 10:46:53 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpA7GSxp/profile http://localhost:49278/getInfo.html) 10:46:55 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:46:55 INFO - PROCESS | 1671 | colorDepth:24 10:46:55 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:46:55 INFO - PROCESS | 1671 | __metrics 10:46:55 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:46:55 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:46:56 INFO - TEST-INFO | 1671: exit 0 10:46:56 INFO - Browser initialized. 10:46:56 INFO - Running cycle 1/1 for kraken test... 10:46:56 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpA7GSxp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:08 INFO - PROCESS | 1673 | RSS: Main: 237699072 10:47:08 INFO - PROCESS | 1673 | 10:47:11 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:12 INFO - PROCESS | 1673 | RSS: Main: 286523392 10:47:12 INFO - PROCESS | 1673 | 10:47:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:47:15 INFO - PROCESS | 1673 | RSS: Main: 298377216 10:47:15 INFO - PROCESS | 1673 | 10:47:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:47:19 INFO - PROCESS | 1673 | RSS: Main: 382324736 10:47:19 INFO - PROCESS | 1673 | 10:47:21 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:47:22 INFO - PROCESS | 1673 | RSS: Main: 285208576 10:47:22 INFO - PROCESS | 1673 | 10:47:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:25 INFO - PROCESS | 1673 | RSS: Main: 289259520 10:47:25 INFO - PROCESS | 1673 | 10:47:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:28 INFO - PROCESS | 1673 | RSS: Main: 328912896 10:47:28 INFO - PROCESS | 1673 | 10:47:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:32 INFO - PROCESS | 1673 | RSS: Main: 328970240 10:47:32 INFO - PROCESS | 1673 | 10:47:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:47:35 INFO - PROCESS | 1673 | RSS: Main: 328503296 10:47:35 INFO - PROCESS | 1673 | 10:47:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:47:38 INFO - PROCESS | 1673 | RSS: Main: 319639552 10:47:38 INFO - PROCESS | 1673 | 10:47:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:47:40 INFO - PROCESS | 1673 | RSS: Main: 325566464 10:47:40 INFO - PROCESS | 1673 | 10:47:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:47:43 INFO - PROCESS | 1673 | RSS: Main: 330043392 10:47:43 INFO - PROCESS | 1673 | 10:47:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:47:46 INFO - PROCESS | 1673 | RSS: Main: 334061568 10:47:46 INFO - PROCESS | 1673 | 10:47:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:47:50 INFO - PROCESS | 1673 | RSS: Main: 331796480 10:47:50 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:47:52 INFO - PROCESS | 1673 | RSS: Main: 395505664 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | __start_tp_report 10:47:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 10:47:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 10:47:52 INFO - PROCESS | 1673 | |i|pagename|runs| 10:47:52 INFO - PROCESS | 1673 | |0;ai-astar;135;153;164;113;112;113;118;112;113;112 10:47:52 INFO - PROCESS | 1673 | |1;audio-beat-detection;160;125;145;172;128;163;167;144;173;120 10:47:52 INFO - PROCESS | 1673 | |2;audio-dft;189;187;187;185;185;188;260;202;181;182 10:47:52 INFO - PROCESS | 1673 | |3;audio-fft;80;73;87;92;55;58;59;77;85;54 10:47:52 INFO - PROCESS | 1673 | |4;audio-oscillator;93;99;134;77;79;80;119;79;77;125 10:47:52 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;91;88;132;88;92;127;130;87;90;87 10:47:52 INFO - PROCESS | 1673 | |6;imaging-darkroom;106;125;89;126;147;139;96;95;95;95 10:47:52 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;86;86;100;131;132;87;85;88;87 10:47:52 INFO - PROCESS | 1673 | |8;json-parse-financial;58;60;58;57;57;57;59;74;60;57 10:47:52 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;66;72;71;75;73;68;72;68;70 10:47:52 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;86;86;86;86;85;86;85;88;86 10:47:52 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;144;145;145;143;143;151;153;157;183;145 10:47:52 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;170;174;171;167;179;166;169;168;168;169 10:47:52 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;69;68;67;67;75 10:47:52 INFO - PROCESS | 1673 | __end_tp_report 10:47:52 INFO - PROCESS | 1673 | __start_cc_report 10:47:52 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1891 10:47:52 INFO - PROCESS | 1673 | __end_cc_report 10:47:52 INFO - PROCESS | 1673 | __startTimestamp1460656072337__endTimestamp 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | ------- Summary: start ------- 10:47:52 INFO - PROCESS | 1673 | Number of tests: 14 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:124.50 Median:115.50 stddev:19.41 (16.8%) stddev-sans-first:20.21 10:47:52 INFO - PROCESS | 1673 | Values: 135.0 153.0 164.0 113.0 112.0 113.0 118.0 112.0 113.0 112.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:161.50 stddev:20.11 (12.5%) stddev-sans-first:20.98 10:47:52 INFO - PROCESS | 1673 | Values: 160.0 125.0 145.0 172.0 128.0 163.0 167.0 144.0 173.0 120.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:194.60 Median:187.50 stddev:23.69 (12.6%) stddev-sans-first:25.04 10:47:52 INFO - PROCESS | 1673 | Values: 189.0 187.0 187.0 185.0 185.0 188.0 260.0 202.0 181.0 182.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:72.00 Median:78.50 stddev:14.38 (18.3%) stddev-sans-first:14.96 10:47:52 INFO - PROCESS | 1673 | Values: 80.0 73.0 87.0 92.0 55.0 58.0 59.0 77.0 85.0 54.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:22.08 (27.9%) stddev-sans-first:23.39 10:47:52 INFO - PROCESS | 1673 | Values: 93.0 99.0 134.0 77.0 79.0 80.0 119.0 79.0 77.0 125.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:88.00 stddev:19.75 (22.4%) stddev-sans-first:20.60 10:47:52 INFO - PROCESS | 1673 | Values: 91.0 88.0 132.0 88.0 92.0 127.0 130.0 87.0 90.0 87.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:92.00 stddev:21.09 (22.9%) stddev-sans-first:22.28 10:47:52 INFO - PROCESS | 1673 | Values: 106.0 125.0 89.0 126.0 147.0 139.0 96.0 95.0 95.0 95.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:86.00 stddev:18.79 (21.8%) stddev-sans-first:19.52 10:47:52 INFO - PROCESS | 1673 | Values: 86.0 86.0 86.0 100.0 131.0 132.0 87.0 85.0 88.0 87.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:5.17 (8.8%) stddev-sans-first:5.44 10:47:52 INFO - PROCESS | 1673 | Values: 58.0 60.0 58.0 57.0 57.0 57.0 59.0 74.0 60.0 57.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.50 stddev:3.03 (4.2%) stddev-sans-first:2.83 10:47:52 INFO - PROCESS | 1673 | Values: 66.0 66.0 72.0 71.0 75.0 73.0 68.0 72.0 68.0 70.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:47:52 INFO - PROCESS | 1673 | Values: 86.0 86.0 86.0 86.0 86.0 85.0 86.0 85.0 88.0 86.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:148.00 stddev:12.24 (8.3%) stddev-sans-first:12.73 10:47:52 INFO - PROCESS | 1673 | Values: 144.0 145.0 145.0 143.0 143.0 151.0 153.0 157.0 183.0 145.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:169.50 stddev:3.84 (2.3%) stddev-sans-first:4.08 10:47:52 INFO - PROCESS | 1673 | Values: 170.0 174.0 171.0 167.0 179.0 166.0 169.0 168.0 168.0 169.0 10:47:52 INFO - PROCESS | 1673 | 10:47:52 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.30 (3.4%) stddev-sans-first:2.42 10:47:52 INFO - PROCESS | 1673 | Values: 68.0 69.0 69.0 68.0 68.0 69.0 68.0 67.0 67.0 75.0 10:47:52 INFO - PROCESS | 1673 | -------- Summary: end -------- 10:47:52 INFO - PROCESS | 1673 | 10:47:53 INFO - TEST-INFO | 1673: exit 0 10:47:53 INFO - TEST-OK | kraken | took 59422ms 10:47:53 INFO - SUITE-END | took 1173s 10:47:53 INFO - Completed test suite (00:19:34) 10:47:53 INFO - javascript benchmark 10:47:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.6875528069554, 3380.121168496191, 3425.092350527112, 3443.259699164679, 3462.601800792908, 5571.331440227168, 5629.240052592899, 5644.096944488882, 5645.943540564593, 5670.0927851543765, 5625.0, 5630.380658127613, 5632.690202038886, 5775.451332123452, 5788.739506722197, 5060.746962651871, 5064.772085256172, 5094.261332106842, 5101.260317253996, 5105.05556472052, 5110.693358398489, 5113.1307677694695, 5131.717755523445, 5146.819861304855, 5192.974035129819, 5053.065182941167, 5059.4181669107975, 5065.265536497224, 5150.278960945433, 5153.974230128844, 5135.3067335909545, 5139.0749665060275, 5143.614228932807, 5148.099082660557, 5148.794048238104, 5060.443351231362, 5120.564751996085, 5133.178691409394, 5140.691558506502, 5176.0683077046115, 5478.342598888119, 5483.396826349099, 5576.275084239063, 5594.776208951637, 5621.747021384007, 6135.570510064297, 6143.840248219912, 6156.138140660311, 6166.568340216187, 6188.071789231606, 6145.539084568675, 6205.720742566596, 6231.003039513656, 6233.345498722614, 6239.126522286883, 5329.680219186861, 5611.0, 5696.886062278772, 5727.885442291173, 5817.894600025981, 6199.876002479925, 6203.16257305267, 6223.3465486123305, 6227.221597300338, 6243.562950593415, 6075.179850720185, 6081.239845019372, 6087.512998960073, 6090.451859332681, 6091.42131497507, 5967.283925928917, 6095.377886651403, 6122.093225952662, 6185.628862268279, 6217.129601855744, 6088.082901554369, 6113.480354169857, 6119.289302195883, 6141.877162456726, 6146.692665366714, 6145.754169833246, 6151.046587778901, 6157.630542167484, 6159.076138579249, 6159.3224745277985, 4827.42070951488, 4832.299316599144, 4889.682170658896, 4889.997550502138, 4901.852944411602, 3779.622037796253, 4283.957160428356, 4433.889152771207, 4458.197524445566, 4465.218586747306, 5561.63849349791, 5601.719914004365, 5602.663840169603, 5612.0, 5635.464630860061, 6131.601445906002, 6202.472789812917, 6207.099970504251, 6212.9068063979075, 6230.127782110508, 5493.038718224295, 5582.637128586629, 5592.189132575753, 5616.0171969905105, 5623.718814059281, 4384.0, 5294.285271488377, 5349.893002139936, 5363.839084827461, 5371.328583927009, 6190.133381326618, 6221.377862213742, 6226.813195604139, 6230.0, 6259.061140828821, 5300.734963251745, 6052.061930400795, 6112.663803490851, 6201.689915504297, 6225.470834979077, 6176.073588961692, 6226.377362263918, 6267.4045965633195, 6267.780627678009, 6271.3728627136925, 6072.210612620331, 6090.725917333642, 6091.238595175603, 6093.482054025458, 6095.444577600282, 6063.484603808549, 6160.291566469913, 6183.81448556544, 6205.627662340274, 6212.844678882883, 5877.794277200449, 5940.495057920125, 6041.486473649789, 6050.969745151246, 6075.149479072845, 5824.592278540462, 5995.5803093783015, 6004.099385092271, 6042.607230530001, 6051.667158306335, 5737.885242295214, 5865.882682346414, 5880.529557635465, 5899.0, 5925.9407405925385, 5884.499817515559, 5911.940880591139, 5928.407159284037, 5941.287045554561, 6020.217371741821, 5713.114467257582, 5738.081906894877, 5749.683767392834, 5782.277215348082, 5784.479396854304], "value": 5607.344148177432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.19629396671354, 505.02530116874465, 511.16679811906585, 545.5362941499726, 552.1965540139099, 24800.50398992019, 29779.808807647696, 29856.104316870475, 29868.40263194735, 29900.700992990063, 38960.61039389605, 39129.60870391295, 39709.602903970954, 39753.80123099388, 39879.80060099703, 9410.153086222239, 9625.133737963582, 9658.275629327793, 9658.855117173249, 9700.126988571028, 8588.742337729878, 9433.858492122623, 9602.75993100171, 9630.0, 11557.364344961024, 11519.0, 11636.767264654702, 11648.650540483799, 11649.767004659901, 11665.41672916355, 11395.145364097685, 11506.0, 11515.078793696484, 11517.25137866036, 11524.711882203012, 11395.031422329112, 11493.42532873353, 11528.654140375802, 11530.192886497949, 11536.942315288454, 37919.81040094782, 38325.42511862297, 38341.616583834366, 38382.424263636065, 40049.39925901085, 3366.6801653842845, 3531.8410671519587, 3706.8517259309597, 3745.4381842723537, 3805.2769973705185, 24887.62668559973, 29135.125946221648, 29391.412171756445, 29981.25046873824, 30018.399632007455, 2720.9058419448934, 2739.2330147558714, 2780.263230243987, 2780.33272014715, 2791.9581206281923, 474581.0, 478991.0, 479528.60235698946, 479594.0, 480262.0, 58064.70967645219, 58231.0, 58406.707966460745, 60140.39859601348, 60154.39845601488, 63150.42123946938, 63305.68347158327, 63394.68302658457, 63410.0, 63506.682466588296, 16110.597235068983, 16557.006579605262, 16703.749443758352, 16708.24812883423, 16721.331146753993, 12943.741125177443, 13032.957363410904, 13048.151870128411, 13058.608241752763, 13095.672608184872, 14130.929345353414, 14572.615601517839, 15662.216889155725, 16084.195790210442, 16239.538441540319, 6087.665178415141, 6775.932240677629, 6842.349976752201, 7016.824579385556, 7076.681549330293, 950.8003319302885, 967.5742673223759, 1010.3584224017654, 1013.1843865688045, 1053.3679792124665, 24532.754672453404, 29364.82540698348, 29487.55768663472, 30006.39987200244, 30131.09606711758, 1107.3134656513014, 1112.8831472695413, 1150.0741902768184, 1152.2049785647876, 1192.2607983050564, 15021.549353519413, 15138.318775655121, 15148.469803556822, 15562.766558501631, 15623.609409764847, 521417.0, 527121.0, 532644.0, 534651.0, 536674.0, 60272.39727602668, 61061.69469152715, 61066.38933610607, 61296.693516532134, 61314.38685613176, 1418.0499065626054, 1455.9490417835325, 1471.801306823565, 1503.6992601479528, 1512.447956495893, 23374.181903633293, 28399.006034788683, 28453.573196402485, 28720.138395848157, 29030.27424314409, 35498.0, 44542.0, 44899.877503062686, 44913.550864490935, 44982.55017449784, 398966.0, 401412.0, 402326.0, 402502.0, 403762.0, 33695.98912032643, 38758.418623721234, 39389.409158863215, 39713.2057358857, 40604.0, 44837.32744008777, 44853.0, 44933.0, 46261.76869115633, 46486.07027859492, 30335.0, 35569.64430355767, 35946.4608030885, 37373.0, 37865.81067094757, 29642.85178574093, 35956.4606530897, 36340.81829590835, 37081.88754337374, 37403.87788366353, 36952.815235924725, 37274.627253727114, 37339.87980360594, 37648.62351376451, 38522.0, 24198.63702044506, 30492.542611861285, 31289.646932971187, 31598.52602210923, 31598.684013159575, 23313.0, 23438.414039649146, 23603.40991475227, 23811.28566142949, 23921.401964951016], "value": 19450.45341620763, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.3045253317761, 385.3853104298644, 388.3495145631069, 399.516584932232, 404.87651266363787, 15637.530874073767, 15962.605609158632, 19870.0, 21633.35099947002, 21642.567148657035, 20155.294564690237, 21000.789992100075, 21073.57852842942, 21274.14903403866, 21939.012744426498, 5670.5463562914865, 5879.559033072526, 6074.149619053336, 6074.665893375863, 6104.542159338045, 3906.6484016438517, 6015.669138197398, 6040.848978775522, 6070.2412198475195, 6070.392960703938, 5753.0, 6110.694465276741, 6115.633062016271, 6121.938780612204, 6130.570860039777, 6113.663748493831, 6128.601640893327, 6189.288231853349, 6695.598264104121, 6727.596344219362, 5714.685692286923, 5881.441263080001, 5894.410558944114, 5904.645721256738, 5910.34986151523, 11540.884591154065, 13011.219326840324, 14018.649533761636, 14030.508932187426, 14054.929725351309, 2003.4690806936173, 2028.0670891389977, 2028.4863987896717, 2047.580246049571, 2095.8428117891217, 9920.751981200456, 9947.452890091043, 10322.741931451774, 10359.689209323733, 10389.220808439397, 1743.0935913325, 1766.1257677449744, 1777.8666600004922, 1793.2378739035987, 1860.5162657708959, 87420.93192591805, 88739.0, 107077.0, 115572.84427155704, 121660.0, 10491.10825579819, 10565.260431769702, 10731.731706707395, 10744.677659670222, 10842.566297348018, 13388.330583470983, 13418.127821691558, 13475.865241347461, 13487.393067311994, 13499.460021599223, 8288.875666865002, 8476.770868224074, 8479.89761331023, 8575.914240857512, 8609.61256743448, 8608.397412181088, 8609.397342186112, 8610.225079742853, 8710.782230444289, 8724.78188045304, 3490.2321489272317, 4088.7751173685733, 4150.937735933963, 4162.209180255742, 4221.5778422158155, 1907.1322548240516, 1962.6369121712528, 1967.370441458748, 1977.3672424824206, 1993.7208790769305, 909.3679892474667, 920.7836158502746, 953.3612479638658, 955.7992821507422, 1012.4583347908833, 19056.428307150807, 19836.900815495832, 20185.798142018393, 20198.697019544717, 20434.69347959782, 948.2698322291797, 953.5661274120258, 957.7797106665506, 962.9374090684083, 1070.0904231403244, 10689.893101069045, 10978.286411383395, 10998.06516446095, 11015.669529914116, 11031.503582338813, 565060.0, 604895.0, 605218.0, 610960.0, 617627.0, 116590.0, 118416.40791796158, 119263.40368298104, 121147.0, 121860.0, 996.4519514267124, 999.3054826895383, 1012.2104758288547, 1014.8985101489792, 1036.2176556699794, 18012.91922484655, 18295.634087318445, 18379.0, 18503.629927401107, 18512.309273618204, 47828.52171478241, 48222.79443013812, 49163.0, 50506.737331567005, 50563.49436505735, 61610.69194653998, 65005.0, 73076.90384644129, 73467.63266183635, 76032.23967760251, 7816.609169541386, 8073.636686349011, 8141.0637776654075, 8284.544350060805, 8480.491170529787, 10348.482575871025, 12077.0, 12671.493140274286, 12684.0, 12974.545890893773, 10738.67783966451, 11146.052585529997, 11359.0, 11452.08383329315, 11455.255408398762, 10714.357138571711, 11046.30129790326, 11270.211085223955, 11426.2001659883, 11557.422128893353, 8999.730008099768, 11150.776984460103, 11450.141239406912, 11592.420378981185, 11858.584949526725, 8308.335333173452, 8309.83380332402, 8436.198561136682, 8441.36689748259, 8467.957660211907, 8471.407001509835, 10920.945395272973, 11205.943970280096, 11398.97409233173, 11550.075993920635], "value": 9243.221907615474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.573537484902, 1563.8592526672596, 1568.1375243616012, 1692.6022384739583, 1819.972700409494, 8073.838523229532, 8788.252998495127, 9025.052369501207, 9035.096490350961, 9040.54797260137, 8681.73954781356, 8767.16711912369, 8842.115788421155, 8843.425177363482, 8910.46537207768, 2251.2120757734824, 2338.4916728709973, 2444.5477586646484, 2468.419921318489, 2470.3206618179966, 2091.9686204706863, 2422.63660450932, 2445.608702607583, 2469.987650061747, 2475.084218839032, 2433.926982190528, 2449.595816690244, 2469.1975108089855, 2470.0984140788573, 2471.036295844622, 2413.1553956115395, 2440.9389765255833, 2448.902043918241, 2453.779159875602, 2455.3493324269084, 2403.987980060106, 2420.4311986683115, 2434.610462326037, 2435.3789783605243, 2435.6833611630373, 8745.912540874637, 8874.911250887537, 8896.154865287852, 8960.731178064669, 8963.103689630985, 4798.904021919542, 5201.349831271091, 5434.184872269152, 5458.181272809071, 5475.616706830523, 3468.7051600613727, 3488.5464889564446, 3565.5721313442295, 3566.465030245458, 3576.5886923003927, 997.8253805584067, 1011.1910471622673, 1011.5801942193981, 1020.3571749797654, 1022.2690776095128, 11572.363520006396, 11916.582919597773, 11941.343226122559, 11950.820737688942, 11958.0, 4228.9154216915485, 4422.695304885066, 4533.252013417749, 4536.7731613419855, 4727.432708075053, 9188.678396256233, 9203.907960920438, 9232.21526170283, 9237.261019118454, 9243.168114869693, 5340.412554618989, 5360.973195133999, 5368.651037682538, 5369.597280203922, 5378.327709036371, 4398.4941731701265, 4458.4426946631675, 4480.551944805558, 4875.634327425457, 5017.89964200714, 3805.6765174959883, 3827.3876179811095, 3858.4180486001164, 3889.202713443737, 3909.5308562972054, 1196.0670676872053, 1198.1133960868895, 1198.6284251881943, 1215.9115845751692, 1217.689489180271, 796.80079980005, 854.7264875239988, 890.6615486115235, 913.9497327647043, 950.4107453378949, 5927.347991720907, 5934.19888315072, 6043.909341359883, 6196.411340922605, 6213.161223234805, 806.1978331560135, 908.1327332397676, 969.2730452160879, 969.8302797010637, 1027.075631931268, 3184.697453741891, 3993.840246390112, 4048.1296521248073, 4072.75563466193, 4073.348264277701, 10532.10477109439, 10652.254342195973, 10847.620333288298, 10998.725031874266, 11135.777284454427, 10729.678109656566, 10874.619388321371, 11151.442427878736, 11159.72100697489, 11201.887981120248, 8266.875996860052, 8461.873071903927, 8491.320694344438, 8530.573471326534, 8535.487870727777, 5188.7405629719115, 5696.629719068247, 5905.232319798571, 5926.0, 5980.850478738066, 10177.440240786827, 10262.640807571699, 10349.896501034893, 10366.896331036593, 10371.481425928825, 9846.867610224916, 10205.13256373187, 10478.842817357898, 10527.052565269163, 10650.946745266225, 6478.902816457663, 6697.2633010367845, 6853.657317134223, 7076.433885289268, 7097.7160913562875, 8422.915770842214, 8471.957640212006, 8517.659293628185, 8524.957375213084, 8531.488110713377, 7345.522541034816, 7611.086669599462, 7624.504407213513, 7743.070831500256, 7762.41781866351, 7363.77908662741, 7394.630268486447, 7469.962650186714, 7553.395728341829, 7591.278828511283, 7104.573725576482, 7180.892286615601, 7181.030560874216, 7197.676104575202, 7202.567845929261, 4701.083288758659, 4904.141775189399, 4924.96575719103, 4925.852224433273, 4963.553280204799, 4819.060283244874, 4873.6832105913, 4896.9755151225445, 4949.0, 5017.924731129109], "value": 4589.675729510664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.6500953922068, 315.11767052253697, 317.75374085084064, 323.1630078097728, 328.13863608028925, 5869.501092407145, 5873.735681894314, 5892.528597712183, 5893.55798315126, 5900.822975310747, 4915.680480768748, 5776.740046697898, 5808.273965754281, 5821.3887541808135, 5862.599692178537, 3691.3909204981146, 4162.604552567501, 4170.186813571355, 4267.381229721688, 4359.280718681413, 4280.229558679452, 4346.413234213388, 4352.281873490871, 4363.258246098155, 4365.694401391904, 3921.784301863396, 4071.1654110907343, 4314.546972567882, 4339.0, 4345.369921361401, 4166.062780806924, 4329.328954012101, 4341.351775416993, 4353.738775673438, 4367.803448844794, 3702.7593206441493, 3740.719446041531, 3752.137008488063, 3754.3242216401036, 3767.097615704079, 5065.0, 5310.92033619496, 5613.971930140364, 5615.326160860682, 5622.212890195376, 4633.397658304432, 4834.419869615634, 4930.161872481651, 4966.255061740731, 5048.62135339851, 5222.817201397971, 6035.426634469763, 6133.754649814002, 6146.8770624587705, 6166.660833654148, 4117.382392641098, 4126.628603425706, 4126.752394856288, 4131.710780245384, 4139.089400331922, 5667.089708101397, 6174.351693072253, 6442.903356449657, 6523.804285871432, 6540.4767618590395, 4084.4077608746566, 4126.855560055444, 4162.41726158338, 4162.62536371728, 4168.749875007509, 4207.726497777635, 4217.00900288432, 4222.113356195234, 4233.491980962242, 4245.57544245573, 4731.976340118277, 4773.427188737373, 4956.851294461172, 5062.848114556569, 5137.2037334213255, 5978.760849565969, 6191.721372538246, 6203.270560953166, 6244.313125556185, 6278.937210627927, 1158.3802665573878, 1415.4550498058322, 1498.6103613060466, 1538.3462028638007, 1538.8612426804084, 879.0725784297628, 949.4730424614268, 1009.0, 1011.5245834457793, 1026.2559644257854, 4986.476419975923, 5564.360098588633, 5638.85902852432, 5649.802256920988, 5665.5184309333345, 5247.396549396868, 6249.78125765596, 6252.937470625327, 6253.593516421418, 6326.240851097898, 4906.754662266872, 5163.631637616035, 5167.044096842096, 5172.0, 5635.519761789305, 2816.6338376010985, 3231.434498962672, 3407.2844702612233, 3408.0287118171204, 3427.8628854846024, 6391.904121438182, 6757.837492002512, 6786.488999070277, 6796.640671865646, 6855.383015528626, 6549.821032214152, 6597.86804263912, 6670.332966703291, 6673.833154171088, 6694.732210711517, 5445.863853403696, 6263.686815659199, 6454.451371633464, 6753.527253092237, 6792.830179245559, 5705.486506214461, 6437.774677886251, 6448.32292609288, 6489.221293444817, 6493.032829885236, 5666.829995100154, 6370.745170193326, 6387.818253623094, 6414.358564143548, 6417.8395540110005, 5734.111212762028, 5858.297004359504, 6143.447089761943, 6768.120144381396, 6832.897506537505, 4140.358244472111, 4145.91708165841, 4181.853635122756, 4189.769562674082, 4219.535851056443, 5493.9286839066, 5800.302859170337, 5889.469947704727, 6190.966426451097, 6453.16108905858, 6119.938800611937, 6259.749610015549, 6281.497480201481, 6284.874302513833, 6290.012244183976, 4987.9251811223585, 6229.719662615103, 6241.750329986749, 6244.219472565929, 6422.229332480132, 5660.462256085665, 5926.0, 5945.3757355477055, 6124.601900876429, 6211.627302361872, 4650.976785107271, 5607.934492446422, 5695.430456954271, 6237.220347456568, 6262.655553944577, 5140.532544378644, 6139.938600613937, 6154.415330543591, 6166.0, 6179.443850053517], "value": 4486.75449421243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.7632052461113, 731.7182884589434, 738.3723834740468, 742.532204711032, 746.6565379925235, 15304.0, 15337.616559586017, 15587.986780859264, 15597.766033509506, 15618.687626247482, 14315.570532884005, 14378.856211437882, 14455.494057707981, 14479.855201447983, 14488.855111448882, 771.6026246483066, 906.1934877958622, 916.7708072981754, 924.2882980105314, 944.5418971798672, 877.6840337478502, 885.1016218538189, 903.4759839293195, 916.1983264643437, 920.7974245665943, 967.5839389062701, 967.666155176463, 970.4032020307495, 971.5919313888148, 971.9368241064343, 959.0313783079071, 963.6001059560274, 963.9084286992725, 964.5900492290748, 964.599691128181, 712.1845486917503, 715.906932098829, 715.9355657990806, 716.2193209401725, 716.4197000429668, 12237.632871013884, 13032.54386096482, 13406.329683515884, 13486.325683715775, 13643.590692279247, 11401.771964560663, 11407.201495895291, 11631.243969141979, 11668.766624667544, 11674.474648640831, 9363.953180234123, 9536.52317384128, 9591.808163836684, 9612.903870961341, 10314.226433017553, 3399.5410619566287, 3452.9654703452893, 3490.511328414024, 3494.6330635283184, 3572.4284114541547, 69860.0, 71844.0, 73381.6330918342, 76180.61909690472, 82695.58652206701, 9545.379550329206, 9652.420854748598, 9762.414255144715, 9948.104670579683, 10080.445575493271, 21802.672959905613, 21837.563248734936, 21870.781292187192, 21891.562168756853, 21926.23258185956, 7696.923030769621, 7759.68961241544, 7785.182555831556, 7830.099538553025, 7847.176046515148, 4039.8182081805803, 4062.939055914164, 4117.608827161474, 4132.91734165315, 4148.647364974011, 3556.5376501054698, 3617.94573081404, 3647.124690074363, 3649.525561676965, 3662.340778659867, 649.1463725201345, 658.7463826426764, 663.9468842492589, 668.9732410703615, 703.426707233603, 479.30740080583223, 531.4472948133897, 568.2802591912389, 611.9816405507753, 617.9227596550431, 7768.495047821873, 8044.879326810103, 8138.186181381814, 8200.0, 8450.070492245848, 499.9475055119233, 506.5263978180413, 582.1006544888158, 594.7680404642193, 597.6414151509147, 3838.405047217686, 3851.768893866377, 3880.708946828999, 3962.623550762673, 3964.762084479586, 89214.0, 89287.10712892788, 90335.0, 91430.54284728666, 94730.0, 78211.43577128426, 79291.0, 79527.60236198783, 79830.20169798228, 81365.0, 70464.06751527343, 70623.0, 70712.0, 70780.29219707738, 71028.0, 7559.773206803805, 7581.139069142435, 7670.578118203329, 7798.454108212371, 8012.3590112792, 35586.46620300646, 43521.0, 45042.0, 45690.0, 45718.0, 58000.41999580119, 61296.0, 64085.71828563496, 64571.03143452946, 65418.01872972005, 10300.845487317547, 10427.895721042996, 10539.63111291101, 10656.84014739795, 10796.244262901522, 11029.83455248188, 11083.72290692739, 11130.833037504282, 11361.0, 11937.223836630748, 10355.0, 10485.895141048797, 10716.249862509549, 10820.188485863435, 10951.616693415692, 10266.691999240034, 10387.220958427997, 10855.728606784893, 10902.563897444013, 10923.781524369628, 10165.52599873029, 10413.47932603382, 10641.308314959502, 10661.520231589442, 10727.785444291227, 8976.461412315282, 9154.359194856295, 9185.724428267162, 9265.397749146285, 9406.952965235403, 7878.369730421668, 7906.9209307906185, 8878.0, 9049.457032578066, 9144.63421463134], "value": 6735.974160312918, "unit": "score"}], "name": "dromaeo_css", "value": 7204.618708793912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 153.0, 164.0, 113.0, 112.0, 113.0, 118.0, 112.0, 113.0, 112.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 145.0, 172.0, 128.0, 163.0, 167.0, 144.0, 173.0, 120.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 187.0, 187.0, 185.0, 185.0, 188.0, 260.0, 202.0, 181.0, 182.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 87.0, 92.0, 55.0, 58.0, 59.0, 77.0, 85.0, 54.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 134.0, 77.0, 79.0, 80.0, 119.0, 79.0, 77.0, 125.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 132.0, 88.0, 92.0, 127.0, 130.0, 87.0, 90.0, 87.0], "value": 101.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 125.0, 89.0, 126.0, 147.0, 139.0, 96.0, 95.0, 95.0, 95.0], "value": 111.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 100.0, 131.0, 132.0, 87.0, 85.0, 88.0, 87.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 57.0, 57.0, 57.0, 59.0, 74.0, 60.0, 57.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 71.0, 75.0, 73.0, 68.0, 72.0, 68.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 86.0, 85.0, 86.0, 85.0, 88.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 143.0, 143.0, 151.0, 153.0, 157.0, 183.0, 145.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 171.0, 167.0, 179.0, 166.0, 169.0, 168.0, 168.0, 169.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 67.0, 67.0, 75.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1551.8999999999999, "alertThreshold": 2.0}]} 10:47:53 INFO - Return code: 0 10:47:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:47:53 ERROR - # TBPL SUCCESS # 10:47:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:47:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:47:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:47:53 INFO - 2016-04-14 10:47:53.661 screenresolution[1677:9961] starting screenresolution argv=screenresolution get 10:47:53 INFO - 2016-04-14 10:47:53.664 screenresolution[1677:9961] Display 0: 1600x1200x32@60 10:47:53 INFO - 2016-04-14 10:47:53.670 screenresolution[1678:9964] starting screenresolution argv=screenresolution list 10:47:53 INFO - Available Modes on Display 0 10:47:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:47:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:47:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:47:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:47:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:47:53 INFO - Intel Iris: 10:47:53 INFO - Chipset Model: Intel Iris 10:47:53 INFO - Type: GPU 10:47:53 INFO - Bus: Built-In 10:47:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:47:53 INFO - Vendor: Intel (0x8086) 10:47:53 INFO - Device ID: 0x0a2e 10:47:53 INFO - Revision ID: 0x0009 10:47:53 INFO - Displays: 10:47:53 INFO - Display: 10:47:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:47:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:47:53 INFO - Display Serial Number: 1600x1200 60 10:47:53 INFO - Main Display: Yes 10:47:53 INFO - Mirror: Off 10:47:53 INFO - Online: Yes 10:47:53 INFO - Rotation: Supported 10:47:53 INFO - Return code: 0 10:47:53 INFO - Running post-action listener: _resource_record_post_action 10:47:53 INFO - Running post-run listener: _resource_record_post_run 10:47:54 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 36151808; Write bytes: 693349888; Read time: 375; Write time: 2001 10:47:54 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384786944; Write bytes: 373794816; Read time: 29485; Write time: 688 10:47:54 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 29907456; Write bytes: 296588800; Read time: 294; Write time: 1266 10:47:54 INFO - Running post-run listener: _upload_blobber_files 10:47:54 INFO - Blob upload gear active. 10:47:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:47:54 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 10:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:47:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:56 INFO - (blobuploader) - INFO - Done attempting. 10:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:47:57 INFO - (blobuploader) - INFO - Done attempting. 10:47:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:47:57 INFO - Return code: 0 10:47:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:47:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:47:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5c689cd3b2d2f9ef25fd3655daf56c796c61ed9b32d278c7d104b1a2ac087a8cde24c745d5aa03a34f417db4139c6e69f34de8e0baf1a09eff037102cc3e295", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476ed9a4365b2f3014adcbd726fbaf174b89b757213b5cebeed0524cf76b6fd118b70e4306f5c0cd77c86a365bb74fe49549ac9936218c87ab43a8e492355442"} 10:47:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:47:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:47:57 INFO - Contents: 10:47:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5c689cd3b2d2f9ef25fd3655daf56c796c61ed9b32d278c7d104b1a2ac087a8cde24c745d5aa03a34f417db4139c6e69f34de8e0baf1a09eff037102cc3e295", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476ed9a4365b2f3014adcbd726fbaf174b89b757213b5cebeed0524cf76b6fd118b70e4306f5c0cd77c86a365bb74fe49549ac9936218c87ab43a8e492355442"} 10:47:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:47:57 INFO - Copying logs to upload dir... 10:47:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:47:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.208559 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-04-14 10:47:57.818437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-14 10:47:57.822737) ========= 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.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5c689cd3b2d2f9ef25fd3655daf56c796c61ed9b32d278c7d104b1a2ac087a8cde24c745d5aa03a34f417db4139c6e69f34de8e0baf1a09eff037102cc3e295", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476ed9a4365b2f3014adcbd726fbaf174b89b757213b5cebeed0524cf76b6fd118b70e4306f5c0cd77c86a365bb74fe49549ac9936218c87ab43a8e492355442"} build_url:https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010950 build_url: 'https://queue.taskcluster.net/v1/task/D9Uy07DBSFecLaG079-f9g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5c689cd3b2d2f9ef25fd3655daf56c796c61ed9b32d278c7d104b1a2ac087a8cde24c745d5aa03a34f417db4139c6e69f34de8e0baf1a09eff037102cc3e295", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476ed9a4365b2f3014adcbd726fbaf174b89b757213b5cebeed0524cf76b6fd118b70e4306f5c0cd77c86a365bb74fe49549ac9936218c87ab43a8e492355442"}' ========= master_lag: 2.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-14 10:48:00.408699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-14 10:48:00.409033) ========= 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.oQSz88gCKv/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.oBGT9RS66c/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.005273 ========= master_lag: 3.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-14 10:48:03.466531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 10:48:03.466884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 10:48:03.622472) ========= ========= Total master_lag: 6.23 =========