builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0131 starttime: 1477329523.19 results: success (0) buildid: 20161024075822 builduid: 86b59fa6c1cb45d09af113a5423e2535 revision: c845bfd0accb7e0c29b41713255963b08006e701 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.190735) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.191154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.191448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.214493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.214825) ========= 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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-10-24 10:18:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 59.6M=0s 2016-10-24 10:18:43 (59.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.318326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.318819) ========= 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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.021738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:43.367178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 10:18:43.367568) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c845bfd0accb7e0c29b41713255963b08006e701 --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 c845bfd0accb7e0c29b41713255963b08006e701 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-10-24 10:18:43,439 truncating revision to first 12 chars 2016-10-24 10:18:43,439 Setting DEBUG logging. 2016-10-24 10:18:43,439 attempt 1/10 2016-10-24 10:18:43,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c845bfd0accb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 10:18:44,222 unpacking tar archive at: fx-team-c845bfd0accb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.025986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 10:18:44.416051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:44.416386) ========= script_repo_revision: c845bfd0accb7e0c29b41713255963b08006e701 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:44.416769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:44.417038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 10:18:44.435662) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 10:18:44.435962) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:18:44 INFO - MultiFileLogger online at 20161024 10:18:44 in /builds/slave/test 10:18:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:18:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:44 INFO - {'append_to_log': False, 10:18:44 INFO - 'base_work_dir': '/builds/slave/test', 10:18:44 INFO - 'blob_upload_branch': 'Fx-Team', 10:18:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:44 INFO - 'branch': 'Fx-Team', 10:18:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:44 INFO - 'config_files': ('talos/mac_config.py',), 10:18:44 INFO - 'default_actions': ('clobber', 10:18:44 INFO - 'read-buildbot-config', 10:18:44 INFO - 'download-and-extract', 10:18:44 INFO - 'populate-webroot', 10:18:44 INFO - 'create-virtualenv', 10:18:44 INFO - 'install', 10:18:44 INFO - 'run-tests'), 10:18:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:44 INFO - 'download_minidump_stackwalk': True, 10:18:44 INFO - 'download_symbols': 'ondemand', 10:18:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:44 INFO - 'installer_path': 'installer.exe', 10:18:44 INFO - 'log_level': 'info', 10:18:44 INFO - 'log_name': 'talos', 10:18:44 INFO - 'log_to_console': True, 10:18:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:18:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:18:44 INFO - 'opt_config_files': (), 10:18:44 INFO - 'pip_index': False, 10:18:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:44 INFO - 'cmd': ('bash', 10:18:44 INFO - '-c', 10:18:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:44 INFO - 'enabled': True, 10:18:44 INFO - 'halt_on_failure': False, 10:18:44 INFO - 'name': 'check_screen_resolution'},), 10:18:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:18:44 INFO - 'cmd': ('bash', 10:18:44 INFO - '-c', 10:18:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:18:44 INFO - 'enabled': True, 10:18:44 INFO - 'halt_on_failure': False, 10:18:44 INFO - 'name': 'check_screen_resolution'},), 10:18:44 INFO - 'run_cmd_checks_enabled': True, 10:18:44 INFO - 'sps_profile': False, 10:18:44 INFO - 'sps_profile_interval': 0, 10:18:44 INFO - 'suite': 'dromaeojs-e10s', 10:18:44 INFO - 'system_bits': '32', 10:18:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:44 INFO - 'title': 't-yosemite-r7-0131', 10:18:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:44 INFO - 'use_talos_json': True, 10:18:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:44 INFO - 'work_dir': 'build'} 10:18:44 INFO - [mozharness: 2016-10-24 17:18:44.630569Z] Running clobber step. 10:18:44 INFO - Running pre-action listener: _resource_record_pre_action 10:18:44 INFO - Running main action method: clobber 10:18:44 INFO - rmtree: /builds/slave/test/build 10:18:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:44 INFO - Running post-action listener: _resource_record_post_action 10:18:44 INFO - [mozharness: 2016-10-24 17:18:44.815828Z] Finished clobber step (success) 10:18:44 INFO - [mozharness: 2016-10-24 17:18:44.815999Z] Running read-buildbot-config step. 10:18:44 INFO - Running pre-action listener: _resource_record_pre_action 10:18:44 INFO - Running main action method: read_buildbot_config 10:18:44 INFO - Using buildbot properties: 10:18:44 INFO - { 10:18:44 INFO - "project": "", 10:18:44 INFO - "product": "firefox", 10:18:44 INFO - "script_repo_revision": "production", 10:18:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:18:44 INFO - "repository": "", 10:18:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:18:44 INFO - "buildid": "20161024075822", 10:18:44 INFO - "pgo_build": "False", 10:18:44 INFO - "basedir": "/builds/slave/test", 10:18:44 INFO - "buildnumber": 8, 10:18:44 INFO - "slavename": "t-yosemite-r7-0131", 10:18:44 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:18:44 INFO - "platform": "yosemite_r7", 10:18:44 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 10:18:44 INFO - "branch": "fx-team", 10:18:44 INFO - "repo_path": "integration/fx-team", 10:18:44 INFO - "revision": "c845bfd0accb7e0c29b41713255963b08006e701", 10:18:44 INFO - "stage_platform": "macosx64", 10:18:44 INFO - "builduid": "86b59fa6c1cb45d09af113a5423e2535", 10:18:44 INFO - "slavebuilddir": "test" 10:18:44 INFO - } 10:18:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:18:44 INFO - Running post-action listener: _resource_record_post_action 10:18:44 INFO - [mozharness: 2016-10-24 17:18:44.819362Z] Finished read-buildbot-config step (success) 10:18:44 INFO - [mozharness: 2016-10-24 17:18:44.819462Z] Running download-and-extract step. 10:18:44 INFO - Running pre-action listener: _resource_record_pre_action 10:18:44 INFO - Running main action method: download_and_extract 10:18:44 INFO - mkdir: /builds/slave/test/build/tests 10:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:44 INFO - trying https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:18:46 INFO - Downloaded 1199 bytes. 10:18:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:18:46 INFO - Using the following test package requirements: 10:18:46 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:18:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:18:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:18:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'jsshell-mac.zip'], 10:18:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:18:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:18:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:18:46 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:18:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:18:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:18:46 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:18:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:18:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:18:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:18:46 INFO - Fetch https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:18:46 INFO - Http code: 200 10:18:46 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 10:18:46 INFO - x-amz-cf-id: jWzObGhCajjP2Y088LLNh71zg2ngmmscU57UjzZG-U_siHPoqE1paQ== 10:18:46 INFO - x-amz-version-id: yurQQVMoRCmi7Aon0B.q40CbC.NkQ1st 10:18:47 INFO - Expected file size: 16409318 10:18:47 INFO - Obtained file size: 16409318 10:18:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:18:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:18:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:18:53 INFO - Fetch https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:18:54 INFO - Http code: 200 10:18:54 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:18:54 INFO - x-amz-cf-id: 5EdytJBgj-NncaUm4xuMtb8j0PMg1vEd0tnMDVk8IhkmRuIJs43QmA== 10:18:54 INFO - x-amz-version-id: yurQQVMoRCmi7Aon0B.q40CbC.NkQ1st 10:18:54 INFO - Expected file size: 16409318 10:18:54 INFO - Obtained file size: 16409318 10:19:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:19:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:19:01 INFO - Fetch https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:19:01 INFO - Http code: 200 10:19:01 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 10:19:01 INFO - x-amz-cf-id: Dg2daqzCppbAkfP-91zq8z_WDwN_ImJSvm0mQYOygeeHoO-ZUPwXWg== 10:19:01 INFO - x-amz-version-id: 4blWLpCsvJusud.NnZzZFvmlnWR7x9UH 10:19:02 INFO - Expected file size: 14409028 10:19:02 INFO - Obtained file size: 14409028 10:19: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:02 INFO - trying https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:19:05 INFO - Downloaded 111215466 bytes. 10:19:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:05 INFO - mkdir: /builds/slave/test/properties 10:19:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:05 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:05 INFO - Contents: 10:19:05 INFO - build_url:https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - Running post-action listener: set_extra_try_arguments 10:19:05 INFO - [mozharness: 2016-10-24 17:19:05.957794Z] Finished download-and-extract step (success) 10:19:05 INFO - [mozharness: 2016-10-24 17:19:05.957912Z] Running populate-webroot step. 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: populate_webroot 10:19:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:05 INFO - '--tppagecycles', 10:19:05 INFO - '7'], 10:19:05 INFO - 'tests': ['tsvgm']}}, 10:19:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['damp', 'tps']}, 10:19:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['damp', 'tps']}, 10:19:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['dromaeo_dom']}, 10:19:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['basic_compositor_video']}, 10:19:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['a11yr', 10:19:05 INFO - 'ts_paint', 10:19:05 INFO - 'tpaint', 10:19:05 INFO - 'sessionrestore', 10:19:05 INFO - 'sessionrestore_no_auto_restore', 10:19:05 INFO - 'tabpaint']}, 10:19:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tsvgx', 10:19:05 INFO - 'tsvgr_opacity', 10:19:05 INFO - 'tart', 10:19:05 INFO - 'tscrollx', 10:19:05 INFO - 'cart']}, 10:19:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:05 INFO - 'tsvgr_opacity', 10:19:05 INFO - 'tart', 10:19:05 INFO - 'tscrollx', 10:19:05 INFO - 'cart']}, 10:19:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s'], 10:19:05 INFO - 'tests': ['tp5o']}, 10:19:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'tests': ['tp5o']}, 10:19:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--disable-e10s', 10:19:05 INFO - '--xperf_path', 10:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:05 INFO - 'tests': ['tp5n']}, 10:19:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:05 INFO - 'talos_options': ['--xperf_path', 10:19:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:05 INFO - 'tests': ['tp5n']}}, 10:19:05 INFO - 'talos.zip': {'path': '', 10:19:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:05 INFO - Running post-action listener: _resource_record_post_action 10:19:05 INFO - [mozharness: 2016-10-24 17:19:05.976363Z] Finished populate-webroot step (success) 10:19:05 INFO - [mozharness: 2016-10-24 17:19:05.976493Z] Running create-virtualenv step. 10:19:05 INFO - Running pre-action listener: _resource_record_pre_action 10:19:05 INFO - Running main action method: create_virtualenv 10:19:05 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:05 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:19:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:06 INFO - Using real prefix '/tools/python27' 10:19:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:06 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:09 INFO - Installing pip.................done. 10:19:09 INFO - Return code: 0 10:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:19:09 INFO - Reading from file tmpfile_stdout 10:19:09 INFO - Output received: 10:19:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:09 INFO - 'HOME': '/Users/cltbld', 10:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:09 INFO - 'LOGNAME': 'cltbld', 10:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:09 INFO - 'MOZ_NO_REMOTE': '1', 10:19:09 INFO - 'NO_EM_RESTART': '1', 10:19:09 INFO - 'PAGER': '/bin/cat', 10:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:09 INFO - 'PWD': '/builds/slave/test', 10:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:09 INFO - 'SHELL': '/bin/bash', 10:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:09 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:09 INFO - 'USER': 'cltbld', 10:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:09 INFO - 'XPC_FLAGS': '0x0', 10:19:09 INFO - 'XPC_SERVICE_NAME': '0', 10:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:10 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:19:10 INFO - Cleaning up... 10:19:10 INFO - Return code: 0 10:19:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:10 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:10 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>=3.1.1'] in /builds/slave/test/build 10:19:10 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>=3.1.1 10:19:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:10 INFO - 'HOME': '/Users/cltbld', 10:19:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:10 INFO - 'LOGNAME': 'cltbld', 10:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:10 INFO - 'MOZ_NO_REMOTE': '1', 10:19:10 INFO - 'NO_EM_RESTART': '1', 10:19:10 INFO - 'PAGER': '/bin/cat', 10:19:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:10 INFO - 'PWD': '/builds/slave/test', 10:19:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:10 INFO - 'SHELL': '/bin/bash', 10:19:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:10 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:10 INFO - 'USER': 'cltbld', 10:19:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:10 INFO - 'XPC_FLAGS': '0x0', 10:19:10 INFO - 'XPC_SERVICE_NAME': '0', 10:19:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:10 INFO - Downloading/unpacking psutil>=3.1.1 10:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:13 INFO - Installing collected packages: psutil 10:19:13 INFO - Running setup.py install for psutil 10:19:13 INFO - building 'psutil._psutil_osx' extension 10:19:13 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:19:14 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:19:14 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:19:14 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:19:14 INFO - building 'psutil._psutil_posix' extension 10:19:14 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:19:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:19:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:19:14 INFO - ^ 10:19:14 INFO - 1 warning generated. 10:19:14 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:19:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:14 INFO - Successfully installed psutil 10:19:14 INFO - Cleaning up... 10:19:14 INFO - Return code: 0 10:19:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:14 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:14 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.3'] in /builds/slave/test/build 10:19:14 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.3 10:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:14 INFO - 'HOME': '/Users/cltbld', 10:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:14 INFO - 'LOGNAME': 'cltbld', 10:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:14 INFO - 'MOZ_NO_REMOTE': '1', 10:19:14 INFO - 'NO_EM_RESTART': '1', 10:19:14 INFO - 'PAGER': '/bin/cat', 10:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:14 INFO - 'PWD': '/builds/slave/test', 10:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:14 INFO - 'SHELL': '/bin/bash', 10:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:14 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:14 INFO - 'USER': 'cltbld', 10:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:14 INFO - 'XPC_FLAGS': '0x0', 10:19:14 INFO - 'XPC_SERVICE_NAME': '0', 10:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19:14 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:19:14 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:19:14 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:19:14 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:19:14 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:19:14 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:19:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:17 INFO - Installing collected packages: mozsystemmonitor 10:19:17 INFO - Running setup.py install for mozsystemmonitor 10:19:17 INFO - Successfully installed mozsystemmonitor 10:19:17 INFO - Cleaning up... 10:19:17 INFO - Return code: 0 10:19:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:17 INFO - 'HOME': '/Users/cltbld', 10:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:17 INFO - 'LOGNAME': 'cltbld', 10:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:17 INFO - 'MOZ_NO_REMOTE': '1', 10:19:17 INFO - 'NO_EM_RESTART': '1', 10:19:17 INFO - 'PAGER': '/bin/cat', 10:19:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:17 INFO - 'PWD': '/builds/slave/test', 10:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:17 INFO - 'SHELL': '/bin/bash', 10:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:17 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:17 INFO - 'USER': 'cltbld', 10:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:17 INFO - 'XPC_FLAGS': '0x0', 10:19:17 INFO - 'XPC_SERVICE_NAME': '0', 10:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:17 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19: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:19: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:19: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:19: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:19: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:19: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:19:20 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:21 INFO - warning: no files found matching '*.txt' 10:19:21 INFO - no previously-included directories found matching 'build' 10:19:21 INFO - no previously-included directories found matching 'dist' 10:19:21 INFO - no previously-included directories found matching '.git*' 10:19:21 INFO - Installing collected packages: jsonschema, functools32 10:19:21 INFO - Running setup.py install for functools32 10:19:21 INFO - warning: no files found matching '*.txt' 10:19:21 INFO - no previously-included directories found matching 'build' 10:19:21 INFO - no previously-included directories found matching 'dist' 10:19:21 INFO - no previously-included directories found matching '.git*' 10:19:21 INFO - Successfully installed jsonschema functools32 10:19:21 INFO - Cleaning up... 10:19:21 INFO - Return code: 0 10:19:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:21 INFO - 'HOME': '/Users/cltbld', 10:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:21 INFO - 'LOGNAME': 'cltbld', 10:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:21 INFO - 'MOZ_NO_REMOTE': '1', 10:19:21 INFO - 'NO_EM_RESTART': '1', 10:19:21 INFO - 'PAGER': '/bin/cat', 10:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:21 INFO - 'PWD': '/builds/slave/test', 10:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:21 INFO - 'SHELL': '/bin/bash', 10:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:21 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:21 INFO - 'USER': 'cltbld', 10:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:21 INFO - 'XPC_FLAGS': '0x0', 10:19:21 INFO - 'XPC_SERVICE_NAME': '0', 10:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:19:21 INFO - Cleaning up... 10:19:21 INFO - Return code: 0 10:19:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:21 INFO - 'HOME': '/Users/cltbld', 10:19:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:21 INFO - 'LOGNAME': 'cltbld', 10:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:21 INFO - 'MOZ_NO_REMOTE': '1', 10:19:21 INFO - 'NO_EM_RESTART': '1', 10:19:21 INFO - 'PAGER': '/bin/cat', 10:19:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:21 INFO - 'PWD': '/builds/slave/test', 10:19:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:21 INFO - 'SHELL': '/bin/bash', 10:19:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:21 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:21 INFO - 'USER': 'cltbld', 10:19:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:21 INFO - 'XPC_FLAGS': '0x0', 10:19:21 INFO - 'XPC_SERVICE_NAME': '0', 10:19:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:21 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:24 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:25 INFO - Downloading docopt-0.6.1.tar.gz 10:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:25 INFO - Running setup.py install for blobuploader 10:19:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:25 INFO - Running setup.py install for requests 10:19:26 INFO - Running setup.py install for docopt 10:19:26 INFO - Successfully installed blobuploader requests docopt 10:19:26 INFO - Cleaning up... 10:19:26 INFO - Return code: 0 10:19:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:26 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:26 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:19:26 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:19:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:26 INFO - 'HOME': '/Users/cltbld', 10:19:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:26 INFO - 'LOGNAME': 'cltbld', 10:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:26 INFO - 'MOZ_NO_REMOTE': '1', 10:19:26 INFO - 'NO_EM_RESTART': '1', 10:19:26 INFO - 'PAGER': '/bin/cat', 10:19:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:26 INFO - 'PWD': '/builds/slave/test', 10:19:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:26 INFO - 'SHELL': '/bin/bash', 10:19:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:26 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:26 INFO - 'USER': 'cltbld', 10:19:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:26 INFO - 'XPC_FLAGS': '0x0', 10:19:26 INFO - 'XPC_SERVICE_NAME': '0', 10:19:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-50EgVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GmhBpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-b5DkLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BTOSqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-FkQAaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-VVf4r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-nD7T6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jyrcDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_JS7q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-NMQeGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Dlf64z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:27 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-c1a5S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_fWEUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-9GkIUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-M0QvTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3dEQyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:28 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TN_P4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:28 INFO - Running setup.py install for manifestparser 10:19:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:28 INFO - Running setup.py install for mozcrash 10:19:28 INFO - Running setup.py install for mozdebug 10:19:28 INFO - Running setup.py install for mozdevice 10:19:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Running setup.py install for mozfile 10:19:29 INFO - Running setup.py install for mozhttpd 10:19:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Running setup.py install for mozinfo 10:19:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Running setup.py install for mozInstall 10:19:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:29 INFO - Running setup.py install for mozleak 10:19:29 INFO - Running setup.py install for mozlog 10:19:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Running setup.py install for moznetwork 10:19:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Running setup.py install for mozprocess 10:19:30 INFO - Running setup.py install for mozprofile 10:19:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Running setup.py install for mozrunner 10:19:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:30 INFO - Running setup.py install for mozscreenshot 10:19:30 INFO - Running setup.py install for moztest 10:19:31 INFO - Running setup.py install for mozversion 10:19:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:31 INFO - Cleaning up... 10:19:31 INFO - Return code: 0 10:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:31 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:31 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:19:31 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:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:31 INFO - 'HOME': '/Users/cltbld', 10:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:31 INFO - 'LOGNAME': 'cltbld', 10:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:31 INFO - 'MOZ_NO_REMOTE': '1', 10:19:31 INFO - 'NO_EM_RESTART': '1', 10:19:31 INFO - 'PAGER': '/bin/cat', 10:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:31 INFO - 'PWD': '/builds/slave/test', 10:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:31 INFO - 'SHELL': '/bin/bash', 10:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:31 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:31 INFO - 'USER': 'cltbld', 10:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:31 INFO - 'XPC_FLAGS': '0x0', 10:19:31 INFO - 'XPC_SERVICE_NAME': '0', 10:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-FKctpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:31 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:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-gdtCDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:31 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:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ykJAa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:31 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:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-0jWUyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:31 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:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GMXIAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:31 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:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:31 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YRweA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-pVpkn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-AmZTAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-IEPLFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Lr7hte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-i6ZmWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-piMudo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-N28XvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:32 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-KYLu2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:32 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-yVZsFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:33 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:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:33 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_6Y7yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:33 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:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:33 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-xmnLDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:35 INFO - Downloading blessings-1.6.tar.gz 10:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:35 INFO - Installing collected packages: blessings 10:19:35 INFO - Running setup.py install for blessings 10:19:36 INFO - Successfully installed blessings 10:19:36 INFO - Cleaning up... 10:19:36 INFO - Return code: 0 10:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:36 INFO - Reading from file tmpfile_stdout 10:19:36 INFO - Current package versions: 10:19:36 INFO - blessings == 1.6 10:19:36 INFO - blobuploader == 1.2.4 10:19:36 INFO - docopt == 0.6.1 10:19:36 INFO - functools32 == 3.2.3-2 10:19:36 INFO - jsonschema == 2.5.1 10:19:36 INFO - manifestparser == 1.1 10:19:36 INFO - mozInstall == 1.12 10:19:36 INFO - mozcrash == 0.17 10:19:36 INFO - mozdebug == 0.1 10:19:36 INFO - mozdevice == 0.48 10:19:36 INFO - mozfile == 1.2 10:19:36 INFO - mozhttpd == 0.7 10:19:36 INFO - mozinfo == 0.9 10:19:36 INFO - mozleak == 0.1 10:19:36 INFO - mozlog == 3.4 10:19:36 INFO - moznetwork == 0.27 10:19:36 INFO - mozprocess == 0.23 10:19:36 INFO - mozprofile == 0.28 10:19:36 INFO - mozrunner == 6.12 10:19:36 INFO - mozscreenshot == 0.1 10:19:36 INFO - mozsystemmonitor == 0.3 10:19:36 INFO - moztest == 0.7 10:19:36 INFO - mozversion == 1.4 10:19:36 INFO - psutil == 3.1.1 10:19:36 INFO - requests == 1.2.3 10:19:36 INFO - wsgiref == 0.1.2 10:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:36 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:36 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:19:36 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:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:36 INFO - 'HOME': '/Users/cltbld', 10:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:36 INFO - 'LOGNAME': 'cltbld', 10:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:36 INFO - 'MOZ_NO_REMOTE': '1', 10:19:36 INFO - 'NO_EM_RESTART': '1', 10:19:36 INFO - 'PAGER': '/bin/cat', 10:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:36 INFO - 'PWD': '/builds/slave/test', 10:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:36 INFO - 'SHELL': '/bin/bash', 10:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:36 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:36 INFO - 'USER': 'cltbld', 10:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:36 INFO - 'XPC_FLAGS': '0x0', 10:19:36 INFO - 'XPC_SERVICE_NAME': '0', 10:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 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:19:36 INFO - Cleaning up... 10:19:36 INFO - Return code: 0 10:19:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:36 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fe145a300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:19:36 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:19:36 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:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:19:36 INFO - 'HOME': '/Users/cltbld', 10:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:19:36 INFO - 'LOGNAME': 'cltbld', 10:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:36 INFO - 'MOZ_NO_REMOTE': '1', 10:19:36 INFO - 'NO_EM_RESTART': '1', 10:19:36 INFO - 'PAGER': '/bin/cat', 10:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:36 INFO - 'PWD': '/builds/slave/test', 10:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:19:36 INFO - 'SHELL': '/bin/bash', 10:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:19:36 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:19:36 INFO - 'USER': 'cltbld', 10:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:36 INFO - 'XPC_FLAGS': '0x0', 10:19:36 INFO - 'XPC_SERVICE_NAME': '0', 10:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:36 INFO - Cleaning up... 10:19:36 INFO - Return code: 0 10:19:36 INFO - Running post-action listener: _resource_record_post_action 10:19:36 INFO - Running post-action listener: _start_resource_monitoring 10:19:36 INFO - Starting resource monitoring. 10:19:36 INFO - [mozharness: 2016-10-24 17:19:36.954064Z] Finished create-virtualenv step (success) 10:19:36 INFO - [mozharness: 2016-10-24 17:19:36.955113Z] Running install step. 10:19:36 INFO - Running pre-action listener: _resource_record_pre_action 10:19:36 INFO - Running main action method: install 10:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:37 INFO - Reading from file tmpfile_stdout 10:19:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:37 INFO - Reading from file tmpfile_stdout 10:19:37 INFO - Output received: 10:19:37 INFO - Usage: mozinstall [options] installer 10:19:37 INFO - Options: 10:19:37 INFO - -h, --help show this help message and exit 10:19:37 INFO - -d DEST, --destination=DEST 10:19:37 INFO - Directory to install application into. [default: 10:19:37 INFO - "/builds/slave/test"] 10:19:37 INFO - --app=APP Application being installed. [default: firefox] 10:19:37 INFO - mkdir: /builds/slave/test/build/application 10:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:20:11 INFO - Reading from file tmpfile_stdout 10:20:11 INFO - Output received: 10:20:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:20:11 INFO - Running post-action listener: _resource_record_post_action 10:20:11 INFO - [mozharness: 2016-10-24 17:20:11.556241Z] Finished install step (success) 10:20:11 INFO - [mozharness: 2016-10-24 17:20:11.556376Z] Running run-tests step. 10:20:11 INFO - Running pre-action listener: _resource_record_pre_action 10:20:11 INFO - Running main action method: run_tests 10:20:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:11 INFO - 2016-10-24 10:20:11.571 screenresolution[2492:27919] starting screenresolution argv=screenresolution get 10:20:11 INFO - 2016-10-24 10:20:11.573 screenresolution[2492:27919] Display 0: 1600x1200x32@60 10:20:11 INFO - 2016-10-24 10:20:11.579 screenresolution[2493:27921] starting screenresolution argv=screenresolution list 10:20:11 INFO - Available Modes on Display 0 10:20:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:11 INFO - Intel Iris: 10:20:11 INFO - Chipset Model: Intel Iris 10:20:11 INFO - Type: GPU 10:20:11 INFO - Bus: Built-In 10:20:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:11 INFO - Vendor: Intel (0x8086) 10:20:11 INFO - Device ID: 0x0a2e 10:20:11 INFO - Revision ID: 0x0009 10:20:11 INFO - Displays: 10:20:11 INFO - Display: 10:20:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:11 INFO - Display Serial Number: 1600x1200 60 10:20:11 INFO - Main Display: Yes 10:20:11 INFO - Mirror: Off 10:20:11 INFO - Online: Yes 10:20:11 INFO - Rotation: Supported 10:20:11 INFO - Return code: 0 10:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:20:11 INFO - Python 2.7.3 10:20:11 INFO - Return code: 0 10:20:11 INFO - grabbing minidump binary from tooltool 10:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:11 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:20:11 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:20:11 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:20:11 INFO - Calling ['/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'] with output_timeout 600 10:20:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:11 INFO - Return code: 0 10:20:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:20:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:20:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:20:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:20:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:20:11 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:20:11 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EvKSeVFvc7/Render', 10:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:20:11 INFO - 'HOME': '/Users/cltbld', 10:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:20:11 INFO - 'LOGNAME': 'cltbld', 10:20:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:20:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:11 INFO - 'MOZ_NO_REMOTE': '1', 10:20:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:20:11 INFO - 'NO_EM_RESTART': '1', 10:20:11 INFO - 'PAGER': '/bin/cat', 10:20:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:11 INFO - 'PWD': '/builds/slave/test', 10:20:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:20:11 INFO - 'SHELL': '/bin/bash', 10:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g0dvxnxjKs/Listeners', 10:20:11 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 10:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:20:11 INFO - 'USER': 'cltbld', 10:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:11 INFO - 'XPC_FLAGS': '0x0', 10:20:11 INFO - 'XPC_SERVICE_NAME': '0', 10:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:20:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:20:12 INFO - mozversion application_buildid: 20161024075822 10:20:12 INFO - mozversion application_changeset: c845bfd0accb7e0c29b41713255963b08006e701 10:20:12 INFO - mozversion application_display_name: Nightly 10:20:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:12 INFO - mozversion application_name: Firefox 10:20:12 INFO - mozversion application_remotingname: firefox 10:20:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:20:12 INFO - mozversion application_vendor: Mozilla 10:20:12 INFO - mozversion application_version: 52.0a1 10:20:12 INFO - mozversion platform_buildid: 20161024075822 10:20:12 INFO - mozversion platform_changeset: c845bfd0accb7e0c29b41713255963b08006e701 10:20:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:20:12 INFO - mozversion platform_version: 52.0a1 10:20:12 INFO - using testdate: 1477329612 10:20:12 INFO - actual date: 1477329612 10:20:12 INFO - starting webserver on 'localhost:60026' 10:20:12 INFO - SUITE-START | Running 2 tests 10:20:12 INFO - TEST-START | dromaeo_css 10:20:12 INFO - operating with platform_type : mac_ 10:20:12 INFO - Initialising browser for dromaeo_css test... 10:20:12 INFO - TEST-INFO | started process 2503 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpg9zQFV/profile http://localhost:60026/getInfo.html) 10:20:15 INFO - PROCESS | 2503 | 2016-10-24 10:20:15.123 plugin-container[2505:28078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f53, name = 'com.apple.tsm.portname' 10:20:15 INFO - PROCESS | 2503 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:15 INFO - PROCESS | 2503 | 2016-10-24 10:20:15.126 plugin-container[2505:28078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 10:20:15 INFO - PROCESS | 2503 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:15 INFO - PROCESS | 2503 | 2016-10-24 10:20:15.126 plugin-container[2505:28078] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:15 INFO - PROCESS | 2503 | __metrics Screen width/height:1600/1200 10:20:15 INFO - PROCESS | 2503 | colorDepth:24 10:20:15 INFO - PROCESS | 2503 | Browser inner width/height: 1024/689 10:20:15 INFO - PROCESS | 2503 | __metrics 10:20:15 ERROR - PROCESS | 2503 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:20:16 INFO - TEST-INFO | 2503: exit 0 10:20:16 INFO - Browser initialized. 10:20:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:16 INFO - TEST-INFO | started process 2506 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpg9zQFV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:18 INFO - PROCESS | 2506 | 2016-10-24 10:20:18.290 plugin-container[2507:28196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 10:20:18 INFO - PROCESS | 2506 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:18 INFO - PROCESS | 2506 | 2016-10-24 10:20:18.290 plugin-container[2507:28196] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:20:18 INFO - PROCESS | 2506 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:20:18 INFO - PROCESS | 2506 | 2016-10-24 10:20:18.290 plugin-container[2507:28196] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:20:28 INFO - PROCESS | 2506 | RSS: Main: 236785664 10:20:28 INFO - PROCESS | 2506 | 10:21:17 INFO - PROCESS | 2506 | 1477329677643 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:23:31 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60026/tests/dromaeo/cssquery-ext.html) 10:23:32 INFO - PROCESS | 2506 | RSS: Main: 249298944 10:23:32 INFO - PROCESS | 2506 | 10:26:34 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-ext.html (next: http://localhost:60026/tests/dromaeo/cssquery-jquery.html) 10:26:35 INFO - PROCESS | 2506 | RSS: Main: 263430144 10:26:35 INFO - PROCESS | 2506 | 10:29:37 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60026/tests/dromaeo/cssquery-mootools.html) 10:29:38 INFO - PROCESS | 2506 | RSS: Main: 268066816 10:29:38 INFO - PROCESS | 2506 | 10:32:39 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60026/tests/dromaeo/cssquery-prototype.html) 10:32:40 INFO - PROCESS | 2506 | RSS: Main: 267857920 10:32:40 INFO - PROCESS | 2506 | 10:35:43 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60026/tests/dromaeo/cssquery-yui.html) 10:35:44 INFO - PROCESS | 2506 | RSS: Main: 273338368 10:35:44 INFO - PROCESS | 2506 | 10:38:46 INFO - PROCESS | 2506 | Cycle 1(1): loaded http://localhost:60026/tests/dromaeo/cssquery-yui.html (next: http://localhost:60026/tests/dromaeo/cssquery-dojo.html) 10:38:47 INFO - PROCESS | 2506 | RSS: Main: 275922944 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | __start_tp_report 10:38:47 INFO - PROCESS | 2506 | _x_x_mozilla_page_load 10:38:47 INFO - PROCESS | 2506 | _x_x_mozilla_page_load_details 10:38:47 INFO - PROCESS | 2506 | |i|pagename|runs| 10:38:47 INFO - PROCESS | 2506 | |0;dojo.html;3346.832658367081;3347.464405695086;3349.0622625664805;3374.0383990562677;3382.154461384653;5641.802536911209;5678.46054624811;5749.310082790066;5766.9711651441785;5767.250257466529;5674.829755107343;5711.828645140642;5732.283464566929;5790.739416726247;5814.651120932736;5175.803120412077;5201.635885488017;5207.088759467097;5299.867503312409;5318.016167009116;5293.39126000511;5306.522412982831;5316.096263635172;5347.679139251638;5359.651622644516;5147.794088236466;5175.275461435402;5265.078611243055;5273.604479664041;5301.787928482856;5219.42586315505;5235.502627250406;5269.789208431658;5271.077561426773;5276.3140791697215;5166.1217593008905;5175.146100893348;5195.454477279869;5223.2165175223645;5227.921581176285;5476.096444086721;5610.186522954149;5650.971745141248;5678.4037676044245;5751.079827227665;6066.454019138255;6138.204480310026;6158.261008678987;6194.752209911598;6197.535184861108;6191.442770150708;6211.192544969125;6215.782447614311;6218.564700470969;6235.00239961604;5820.592558520862;5834.533237341003;5836.066229403275;5852.326982397079;5888.5877988540815;5706.343770466367;6022.669599052641;6180.289266734383;6181.474574661114;6239.937600623935;6131.0803379492545;6150.969245153835;6155.384461553809;6165.537584681167;6165.784197553064;6106.542009349317;6136.815895523141;6194.225721784777;6215.844603884849;6251.3123556408755;6139.6454669416935;6158.107074474176;6160.630362178284;6213.130161777355;6214.875702485925;6165.445109940127;6232.501399887998;6244.313125556185;6269.968650156811;6284.591501552384;4849.660523763373;4926.3349447824085;4929.2359684248995;4971.229459433794;4975.4278258000795;4353.956460435418;4354.455693038371;4359.062801497693;4445.333200019958;4505.6846020778885;5697.857553561112;5757.6833274169485;5761.798337058183;5823.621464604787;5828.795992140254;6161.137440758297;6201.1938448002375;6225.62646241227;6231.127642130105;6247.406496382836;5679.148127780866;5722.170285308607;5732.369439361667;5745.88508229833;5774.740136693859;5413.350397952271;5424.864378390572;5439.728013599304;5442.292501974797;5488.91766623501;6293.559450838489;6301.6534090625455;6347.301796802348;6348.650824204713;6350.936490635035;6108.584917381041;6123.343628574205;6131.223750760645;6185.752569897154;6207.131001659681;6306.054091886253;6317.305096439296;6331.398517140864;6335.873282534416;6345.96827015862;6119;6127.172831667668;6146.416090471398;6184.5052395809125;6197.442230199304;6102.883130681719;6127.953177891068;6157.96921015392;6218.968905155445;6243.750249989949;5512.476314750093;6041.969790151021;6130.245269656939;6146.108814222002;6162.445379915829;5227.372715274191;5427.782888684566;5881.500072493886;6084.69576521181;6110.969445152746;5297.973510132425;5398.64908780928;5502.614816962774;5901.7639294427745;5907.645541267538;6069.544784141295;6093.238345206849;6100.298465676504;6123.510119190543;6137.232845894263;5004.974975125101;5883.146943693226;5910.911336329872;5912.822615321547;5933.110033495011 10:38:47 INFO - PROCESS | 2506 | |1;ext.html;456.8971981304207;467.74040407573796;488.91199584074855;499.0318781563766;516.5428595692815;40233.597664023386;41755.79122104389;41851.37222941654;43902.34146487797;43964.68105956826;43012.13975720484;43173.13653726924;43363.566364336344;43432;43488.347674784905;9512.571934262958;9643.276754243425;9678.274129440286;9710.41737495749;9732;9602.039796020412;9696.660616878411;9700.126988571028;9716.611335546604;9727.124558789708;9654.275929305295;9660.420374777535;9677.70966870995;9684.273679474067;9702.466364349957;9605.231581473465;9660.227181825438;9671.081247281498;9686.46724430156;9700.999999999965;9513.476758778264;9530.142287194116;9559.761005974837;9580.0898914603;9602.75993100171;40543.7972810137;40834.38748418776;40939;40962.59037409617;40966.59033409687;3184;3530.8411121499594;3578.8926332210076;3724.944125838115;4161.646260067898;30997.69002309993;31259.843700781577;31293.374132517223;31504;31785.682143178503;2764.682061562926;2779.583062540635;2861.6136821529244;2962.7777916656123;3257.657945915692;486615;486988;487088;487449.56275218754;487474;62340.37659623437;62395.6880215596;62438;62672.68663656653;62746;66342;66618.66690666515;66632;66739;66811;15718.68562628741;15909.840901591067;15985.520434386986;16097.356105755638;16341.591460213589;12288.569900053455;12338.629841104781;12369.319687417099;12374.752504950031;12383;16826.242819072926;18021;18054.729179062324;18231.544211394823;18247.54381140482;6704.2625311215725;6981.232064473005;7210.819729506699;7375;7394.5932973685885;860.8794768732382;916.2649491268558;1021.8416145497312;1035.316690983962;1049.9002594753485;25607.359816004377;25938.87030564873;30202.24494387658;30766.230844229074;31305;947.6825263536792;1012.4229189361993;1069.5187165775433;1097.3032124600777;1127.9887201127883;14759.852401476062;15631.84368156304;15698.529044128694;15734.213289335488;16075.598110047342;513042;628032;632582;634098;643117.784411075;58327.41672583305;58580.12129818056;58646;58731;58820.82358352809;1146.7821113988316;1251.3680591301334;1301.6420484366874;1360.455817672919;1418.5957002254102;31089.378212436077;31861.522077169324;31881;32419.351612967137;32792.85225017209;48173.03653926972;51291;51628.22557661563;51810.74094629503;51903.48096518986;418568;477943;478115;478124;478484;25936.61095083613;26053.869730651226;26838.731612683623;26854.462910741284;27766.86116569404;47760.52239477561;47762.522374777196;48171.5182848167;48499.27251091307;49317.50682493129;39664.40503392509;39667;40333.798331008154;40609;41370;39308.410373844985;39823.60176398315;39836.80081599573;39958.60144894915;40618.1876362477;37908;38705.225895481366;39006.219875602896;39212.6078739209;40663.78008659745;30833.8458307716;34902.30195396129;35224;35562.64437355593;35694.28611427809;26070.86964565165;26148.73851261463;26166.215013549623;26488.8675556621;26532.8673356632 10:38:47 INFO - PROCESS | 2506 | |2;jquery.html;376.6967591089174;378.4361301660526;383.637462597845;389.84406237504976;406.8169323804287;18261.452156435294;20819.959002049876;21025;21127.049282782275;21232.57534849304;20420.38738837837;20446.488837779063;20565.794342056575;20628.587428251427;20930.26744063958;5179.81870634527;5395.892082158354;5717.113847353667;6029.909551356734;6096.2074930259005;3858.6334298241622;4051.210014047262;6042.788502402417;6087.086936959469;6099.664518451484;5623.831285061455;5887.793927212549;5940.108983652443;5987.311459182184;6001.849953751147;5835.970820145914;5919.940800592003;5952.375000624937;5983.640981541122;6030.517558595346;5858.3848695886745;5865.090910908816;5870.765169393262;5870.853228669274;5881.85295367615;19308.613827723508;24419.63370549443;25028;25145.24564263075;25197.37006574832;2573.7040240372407;2779.2357101796965;2804.831710097401;2824.4915915135266;2905.6513218413716;9842;9899.731325642279;9919.553620087114;10399.220058495568;10429.791404171874;1630.9184540772915;1781.3320004998125;1862.7112797516406;1887.1979408751363;1890.4895678166956;107318;118723.4063829684;119668;120207;120326.39836800848;11168.888311116947;11239.494222759995;11343.659690209142;11451.828222576669;11475.655730328104;14287;14310.85689143116;14319.713605727828;14325.140491570539;14380;7961.283484486424;8260.752177434686;8325.583720814057;8378.371622128365;8454;8032.83934321322;8135.3491720662205;8150.551719655357;8276.958615206886;8297.211764882326;4388.868333949923;4486.461624605003;4520.2315606347;4574.817007319736;4590.770461476913;1567.5140706381057;1913.435536516731;1952.3947576251408;1962.3229985654925;2003.599280143948;815.6370415165195;909.5679552212646;928.2388441477923;941.3504681769557;982.6560703753629;19896.70154947677;20730.48173795667;21070.293707124354;21077.156913723586;21183.470413239484;887.9023307436177;908.5457271364318;944.9244060475146;946.8590348630022;975.8194733974237;10604.257701960943;10681.786364272672;10944.069754070993;10962.945185274022;10988.835167472495;575835;576982.1150894219;577988;588149;593047;99307;111683;114171;124752;130594;927.1377618814432;1000.6697789729371;1007.471077684207;1019.1133713669155;1020.0666390252835;15523.924984658566;16352.918235409223;17468.650626987645;18475.81524184741;18692.7196092056;54164.18753718776;54819;55020.724896375265;56210.43789562052;56829;84485.310293795;84509.3098138046;84602.57698711468;85190.7221391692;85395.57302213449;7737.419693522896;7795.538590003642;7841.294283514511;7933.722319718782;8154.103048664523;8792.560371981248;12032;12127.575534856238;12550.811737824122;12579.559715409916;9463.526823658927;10510;10570.65990506486;10690.839637405601;10928.852470490485;9218.861717074384;10143.391396516232;10416.583336666448;10437.060664540228;10707.089897358812;11141.83287250708;11327.886721132683;11341.432928353384;11464.426778660867;11728;7927.890095386535;7942.5306318331295;7988.680452782056;8150.9184908150155;8282.378821588285;10494.370337779757;10803.621873234399;11019.779604408028;11043.061339786209;11054.502547385226 10:38:47 INFO - PROCESS | 2506 | |3;mootools.html;1350.1898860683589;1473.2928194466651;1667.6414570867269;1846.9445916622506;1879.3422302194233;6523.80428587142;8331.041930178031;8517;9098.22665073468;9120.908790912088;8571.828563428744;8836.690715824947;8870.645174193025;8954.015058343577;8958.820823583525;2306.826987975904;2337.637666161748;2338.9064437422485;2347.471818840764;2354.1878052072007;1855.4248183063225;2240.5466014713943;2321.1643808229023;2341.2507997440825;2357.2456813819585;1967.2327792161068;2301.2175860207526;2312.3178662294663;2319.652052192176;2335.2177020698086;1994.1823852220664;2310.688057112285;2314.4445333120098;2318.4435735423463;2320.8027317677934;2005.899705014758;2298.28753086542;2319.281022882895;2324.0471406723163;2340.707411573553;8271;8543.82912341756;8594.183552562497;8991.100889911022;9080.182783549446;5239.056969745444;5364.490373414519;5383.353997520323;5390.326209223847;5421.674699518042;3481.147118955872;3577.141486043357;3682.1531047859144;3702.5186725725753;3723.180900201978;1054.7204990677476;1061.2359101446946;1080.6487891435236;1082.1559183836541;1091.4651820607924;11475.713107172387;11509.309441433541;11622;11633.418329083512;11652.300861948226;4555.544445555418;4682.180618391768;4771.165046116985;4789.736564488917;4804.495527969582;9887.209023278121;9927.553260103312;9929.900700993043;9947.900520994843;9948.850767238497;5352.090144675414;5368.489993450616;5378.2470454136455;5394.217838413408;5395.946040539544;3830.3488406970882;4546.40896683429;4700.130475861976;4845.733484658378;4918.975405122951;3418.7265018798435;3850.4609354690365;3883.1845312484693;3945.1715139820385;3980.402939559089;1291.6814318298677;1300.7042569864198;1302.7915533514781;1308.9018323625767;1312.1405479411;835.6197929941862;929.4423345992351;930.9906900931039;946.9621215151454;967.1875624475474;5773.538116950634;6021.668808215591;6035.6076855004285;6113.694315284307;6128.203333566607;413.4253387790913;432.5955231858223;436.2431181899402;443.4080502529095;445.7904784751162;3980.7014473914574;3987.222491614107;4043.251998380309;4097.733647312915;4110.979445102756;10465.372077675363;10736.624218152327;10806.729831754268;10848.620298289521;10885.727856803644;10811.675649730521;10832.079273261703;10833.29583577065;10849.78300433987;10859.565617375216;7652.579108149105;7716.112647045549;8265.380096492787;8301.086880443147;8302.294304984143;4780.402449693788;5409.594280428905;5843.211166492639;5867.442592953663;6049.758009679739;8107.351411886917;9757.707268781947;9864.260180486348;9967;10031.347962382422;9150.810394648654;9214.631414743335;9365.531723413938;10095.798084038131;10211.744706382102;5882.911756323744;6199.56603037783;6875.3812156906115;7136.750213742494;7618.69525218985;7310.488265821342;8272;8542.615582298935;8584.313254939714;8591.484510929364;7366.521176123535;7558.735444259424;7563.7352692655495;7654.004979352649;7660.5403675779635;7285.307895749896;7347.742829000959;7401.666924988281;7473.43949203801;7500.174980752222;7067.717291308496;7077.150741911004;7131.572105673677;7138.785836424708;7149.213586505376;4956.091904616821;5006.3992320921725;5097.311862898461;5107.489251075011;5137.357830271216;5079.796808127781;5090.134677104975;5252.711100889488;5254.500822421864;5280.1815718563685 10:38:47 INFO - PROCESS | 2506 | |4;prototype.html;267.87008300974026;299.8875421716856;309.0450507930494;312.49064025638205;314.67116862878316;4940.925886111707;5272.6273177070325;5325.547328477084;5452;5579.776808927638;4807.053143476897;5287.4976877196705;5362.51737343639;5391.622586418943;5458.836234912959;3514.6661067198575;3974.801259937006;4204.369344598304;4204.867373806518;4220.177065472234;3598.0285322962786;3860.5715885122545;4161.188568229197;4193.601607847265;4219.746815191098;3670.743047986642;4066.7966601669946;4086.754794712312;4105.557193469881;4155.605217504332;3525.4711793230963;3663.461346234588;4126.628603425676;4127.968007998001;4205.243056249874;3554.8979816257042;3559.857605695769;3564.7861128332124;3601.1717305019993;3613.602503724588;4377.868663940087;5262.184915935954;5371.623986320959;5375.7849686012905;5378.327709036371;4056.3307054336;4393.780310984438;4731.344029589651;4733.431988161408;4777.140114779339;4856.781444834991;5778.439821248281;5796.768129274866;5888.911666325009;5893.911591326134;3692.2061756722433;3779.433085037239;3812.894260664404;3842.8078596070086;3904.1801221743467;6145.064304743992;6208.379162083801;6235.407636274546;6242.940958930091;6286.371362863722;3933.881983540441;3956.66368358687;3965.6886499773013;3982.5021872265966;4009.7594144351433;3436.295559410315;3780.790147152885;3831.1762970961377;4010.318245898146;4053.7973101344814;3877.3990031545154;4272.6073398896715;4442.000549876252;4644.140833945731;4740.834070807505;5179.766910489037;5595.936772013386;5846.970765146147;5864.618799778001;5962.25471816023;1094.921502320214;1207.9033677305795;1240.5782034108265;1306.4251729239104;1362.3528823808613;833.5957060825494;874.9781255468664;917.9219766319937;920.8664743612138;923.6813299411692;5393.487618676219;5407;5414.996451312961;5418.9678870423595;5422.620416570802;5121.4622464641425;5929.555283353679;5963.373845746221;6009.248843894513;6017.548683848729;4516.864494065183;4638.976805115953;4950.628702847301;5054.368203974504;5208.635395522277;2427.7329493755674;2495.75382156061;2525.918379576913;2659;2683.034107721219;4667.369905062773;4872.806162490213;5142.845714628567;5147.485251474823;5252.581802913269;4772.785224664898;4786.712797232177;5052.873678158076;5061.709264137621;5195.376554813371;4605.930911036337;4724.7557410229865;4830.613550915848;5080.263361812516;5148.661348049459;4263.573642635712;4473.926257698194;4674.200432833316;4712.316714076508;5060.49395060491;4177.373393990925;4404.867853964386;4561.74910379919;4650.883727906829;4864.683795553277;4279.614834664895;4468.955310446854;4569.862904112882;5078.591300265206;5092;2974.553816927392;3324.6176689680997;3356.3958487471514;3417.8632854685534;3469.0746635617475;4243.575642435731;4858.416989961227;4992.326035985241;5010.448850626355;5589.428862723193;4888.5111488850835;5411.918821217763;5609.88780224385;5752.568557358131;5835.328937172279;4978.502149785138;5063.772130254221;5263.289455923401;5446.237526746179;5814.622049566765;4880.485051891482;5031.84904452867;5450.974709036523;5506.834794956158;5810.709464526842;5358.97320513395;5605.383407825218;5830.5627077968475;5835.44563266489;5846.327672317738;5062.468440813662;5210.53105220532;5683.2895888014;5745.885082298414;5804.419558044162 10:38:47 INFO - PROCESS | 2506 | |5;yui.html;678.2200469460121;689.7447944260623;698.2145086777372;711.4059760100316;728.9744858929938;15115.546533603982;16120.435784747537;16134.354625814953;16150;16181.595460113489;12446.626601201979;14565.635859103528;14618;14623.78064329036;14683.486077987272;686.3171144710994;710.3677726823106;752.5522314223056;859.5315553023618;877.8683197520392;865.6623916672503;885.1546772831962;886.9976926073527;887.3522328700053;888.6001299415257;937.5265490927106;945.6595625574788;946.9431834089977;949.1931857920747;950.7100334398006;932.3240650528346;941.1623654947102;942.1285311087217;943.0475220027753;943.6036864516919;699.098163369253;701.7614011236204;702.3819039245483;702.7013519254348;703.5075447186938;15143.621409464742;15176;15236.923815380853;15268.007579507408;15315.234238288042;14485.855141448556;14511.637209069857;14533.70932581353;14542.27288635564;14810.481633142788;11800.822987655192;12046.457909394097;12072.034237261087;12137.089718271165;12333.753324933452;3669.7798132111893;3687.6865466435383;3858.614138586147;3903.9609603904164;3911.0613452771413;101554;113963.43018284856;114333;114403.42798286039;116370.99999999916;9779.083958058387;9827.606895724233;9896.356736812084;10009.499525023866;10050.296479246383;22557.210497632503;22622.547549048926;22821.087156513884;22895.313140605474;22977.310680679606;7919.247671471201;7973.20267973198;7987.480813747088;8009.559474228973;8072.879051257435;4375.649948004216;4389;4395.1429471252795;4400.4939431965095;4432.135733531994;3519;3619.2761447710564;3622.7645203061716;3626.492291079251;3629.4737263096704;655.8360409897525;658.6048370977376;666.7333066773233;667.6394746836751;674.5986138247735;567.9858003549862;648.7664440801308;658.7727234104226;659.3110199841177;661.384912031815;8198.15695718818;9199.356045076915;9281.350305478552;9650.517474126405;9664.855027174597;619.9876002479925;631.5137344244906;657.8881590129689;675.9155105611799;689.7516893918186;4514.774261286922;4636.35091087248;4688.651987645724;4694.155052090657;4748.691335063209;101372;148629.36650384837;155208.22395887948;155737;159424;123437;123687;124634;125576.51258004784;127070;108605.45697271463;109418.45290773496;111041;111724.88275117308;112840.3073953875;8811.105612293388;8932.86600701003;8947.776305592412;8967.730968070968;9041.68354107603;63693.6815315939;64785.4368009764;65196.674016629615;66196.6690166546;67050.66474667596;80376;85618.57190714007;94866;97788.5110574471;101629;11272.549098035986;12083.939580302042;12146;12150;12346.567870124503;12812.167209131376;12923;12951.45070968903;12980.286084265455;13102;11945.701357466132;12200.572979945659;12340.938295308466;12753.171043882117;12884.291363975071;11997.460114295052;12121.69695757613;12330.63008109758;12609.87390126087;12863.22820630765;10650.84023739629;12163.756724865276;12482.500699971899;13647.385867635781;13725.931370343083;10736.838947415952;11042.171837112088;11345.716357090809;11381.487833047699;11449.542744329827;9876.802463950824;10513.632022879163;11197.944010279896;11551.42242887869;11625.18623696367 10:38:47 INFO - PROCESS | 2506 | __end_tp_report 10:38:47 INFO - PROCESS | 2506 | __start_cc_report 10:38:47 INFO - PROCESS | 2506 | _x_x_mozilla_cycle_collect,365 10:38:47 INFO - PROCESS | 2506 | __end_cc_report 10:38:47 INFO - PROCESS | 2506 | __startTimestamp1477330727149__endTimestamp 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | ------- Summary: start ------- 10:38:47 INFO - PROCESS | 2506 | Number of tests: 6 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#0] dojo.html Cycles:165 Average:5713.48 Median:5881.50 stddev:625.76 (10.6%) stddev-sans-first:599.50 10:38:47 INFO - PROCESS | 2506 | Values: 3346.8 3347.5 3349.1 3374.0 3382.2 5641.8 5678.5 5749.3 5767.0 5767.3 5674.8 5711.8 5732.3 5790.7 5814.7 5175.8 5201.6 5207.1 5299.9 5318.0 5293.4 5306.5 5316.1 5347.7 5359.7 5147.8 5175.3 5265.1 5273.6 5301.8 5219.4 5235.5 5269.8 5271.1 5276.3 5166.1 5175.1 5195.5 5223.2 5227.9 5476.1 5610.2 5651.0 5678.4 5751.1 6066.5 6138.2 6158.3 6194.8 6197.5 6191.4 6211.2 6215.8 6218.6 6235.0 5820.6 5834.5 5836.1 5852.3 5888.6 5706.3 6022.7 6180.3 6181.5 6239.9 6131.1 6151.0 6155.4 6165.5 6165.8 6106.5 6136.8 6194.2 6215.8 6251.3 6139.6 6158.1 6160.6 6213.1 6214.9 6165.4 6232.5 6244.3 6270.0 6284.6 4849.7 4926.3 4929.2 4971.2 4975.4 4354.0 4354.5 4359.1 4445.3 4505.7 5697.9 5757.7 5761.8 5823.6 5828.8 6161.1 6201.2 6225.6 6231.1 6247.4 5679.1 5722.2 5732.4 5745.9 5774.7 5413.4 5424.9 5439.7 5442.3 5488.9 6293.6 6301.7 6347.3 6348.7 6350.9 6108.6 6123.3 6131.2 6185.8 6207.1 6306.1 6317.3 6331.4 6335.9 6346.0 6119.0 6127.2 6146.4 6184.5 6197.4 6102.9 6128.0 6158.0 6219.0 6243.8 5512.5 6042.0 6130.2 6146.1 6162.4 5227.4 5427.8 5881.5 6084.7 6111.0 5298.0 5398.6 5502.6 5901.8 5907.6 6069.5 6093.2 6100.3 6123.5 6137.2 5005.0 5883.1 5910.9 5912.8 5933.1 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#1] ext.html Cycles:180 Average:66764.36 Median:41168.30 stddev:140153.86 (340.4%) stddev-sans-first:140458.61 10:38:47 INFO - PROCESS | 2506 | Values: 456.9 467.7 488.9 499.0 516.5 40233.6 41755.8 41851.4 43902.3 43964.7 43012.1 43173.1 43363.6 43432.0 43488.3 9512.6 9643.3 9678.3 9710.4 9732.0 9602.0 9696.7 9700.1 9716.6 9727.1 9654.3 9660.4 9677.7 9684.3 9702.5 9605.2 9660.2 9671.1 9686.5 9701.0 9513.5 9530.1 9559.8 9580.1 9602.8 40543.8 40834.4 40939.0 40962.6 40966.6 3184.0 3530.8 3578.9 3724.9 4161.6 30997.7 31259.8 31293.4 31504.0 31785.7 2764.7 2779.6 2861.6 2962.8 3257.7 486615.0 486988.0 487088.0 487449.6 487474.0 62340.4 62395.7 62438.0 62672.7 62746.0 66342.0 66618.7 66632.0 66739.0 66811.0 15718.7 15909.8 15985.5 16097.4 16341.6 12288.6 12338.6 12369.3 12374.8 12383.0 16826.2 18021.0 18054.7 18231.5 18247.5 6704.3 6981.2 7210.8 7375.0 7394.6 860.9 916.3 1021.8 1035.3 1049.9 25607.4 25938.9 30202.2 30766.2 31305.0 947.7 1012.4 1069.5 1097.3 1128.0 14759.9 15631.8 15698.5 15734.2 16075.6 513042.0 628032.0 632582.0 634098.0 643117.8 58327.4 58580.1 58646.0 58731.0 58820.8 1146.8 1251.4 1301.6 1360.5 1418.6 31089.4 31861.5 31881.0 32419.4 32792.9 48173.0 51291.0 51628.2 51810.7 51903.5 418568.0 477943.0 478115.0 478124.0 478484.0 25936.6 26053.9 26838.7 26854.5 27766.9 47760.5 47762.5 48171.5 48499.3 49317.5 39664.4 39667.0 40333.8 40609.0 41370.0 39308.4 39823.6 39836.8 39958.6 40618.2 37908.0 38705.2 39006.2 39212.6 40663.8 30833.8 34902.3 35224.0 35562.6 35694.3 26070.9 26148.7 26166.2 26488.9 26532.9 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#2] jquery.html Cycles:180 Average:34315.10 Median:2865.07 stddev:97203.07 (3392.7%) stddev-sans-first:97442.35 10:38:47 INFO - PROCESS | 2506 | Values: 376.7 378.4 383.6 389.8 406.8 18261.5 20820.0 21025.0 21127.0 21232.6 20420.4 20446.5 20565.8 20628.6 20930.3 5179.8 5395.9 5717.1 6029.9 6096.2 3858.6 4051.2 6042.8 6087.1 6099.7 5623.8 5887.8 5940.1 5987.3 6001.8 5836.0 5919.9 5952.4 5983.6 6030.5 5858.4 5865.1 5870.8 5870.9 5881.9 19308.6 24419.6 25028.0 25145.2 25197.4 2573.7 2779.2 2804.8 2824.5 2905.7 9842.0 9899.7 9919.6 10399.2 10429.8 1630.9 1781.3 1862.7 1887.2 1890.5 107318.0 118723.4 119668.0 120207.0 120326.4 11168.9 11239.5 11343.7 11451.8 11475.7 14287.0 14310.9 14319.7 14325.1 14380.0 7961.3 8260.8 8325.6 8378.4 8454.0 8032.8 8135.3 8150.6 8277.0 8297.2 4388.9 4486.5 4520.2 4574.8 4590.8 1567.5 1913.4 1952.4 1962.3 2003.6 815.6 909.6 928.2 941.4 982.7 19896.7 20730.5 21070.3 21077.2 21183.5 887.9 908.5 944.9 946.9 975.8 10604.3 10681.8 10944.1 10962.9 10988.8 575835.0 576982.1 577988.0 588149.0 593047.0 99307.0 111683.0 114171.0 124752.0 130594.0 927.1 1000.7 1007.5 1019.1 1020.1 15523.9 16352.9 17468.7 18475.8 18692.7 54164.2 54819.0 55020.7 56210.4 56829.0 84485.3 84509.3 84602.6 85190.7 85395.6 7737.4 7795.5 7841.3 7933.7 8154.1 8792.6 12032.0 12127.6 12550.8 12579.6 9463.5 10510.0 10570.7 10690.8 10928.9 9218.9 10143.4 10416.6 10437.1 10707.1 11141.8 11327.9 11341.4 11464.4 11728.0 7927.9 7942.5 7988.7 8150.9 8282.4 10494.4 10803.6 11019.8 11043.1 11054.5 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#3] mootools.html Cycles:180 Average:5647.06 Median:5043.10 stddev:3193.78 (63.3%) stddev-sans-first:3186.41 10:38:47 INFO - PROCESS | 2506 | Values: 1350.2 1473.3 1667.6 1846.9 1879.3 6523.8 8331.0 8517.0 9098.2 9120.9 8571.8 8836.7 8870.6 8954.0 8958.8 2306.8 2337.6 2338.9 2347.5 2354.2 1855.4 2240.5 2321.2 2341.3 2357.2 1967.2 2301.2 2312.3 2319.7 2335.2 1994.2 2310.7 2314.4 2318.4 2320.8 2005.9 2298.3 2319.3 2324.0 2340.7 8271.0 8543.8 8594.2 8991.1 9080.2 5239.1 5364.5 5383.4 5390.3 5421.7 3481.1 3577.1 3682.2 3702.5 3723.2 1054.7 1061.2 1080.6 1082.2 1091.5 11475.7 11509.3 11622.0 11633.4 11652.3 4555.5 4682.2 4771.2 4789.7 4804.5 9887.2 9927.6 9929.9 9947.9 9948.9 5352.1 5368.5 5378.2 5394.2 5395.9 3830.3 4546.4 4700.1 4845.7 4919.0 3418.7 3850.5 3883.2 3945.2 3980.4 1291.7 1300.7 1302.8 1308.9 1312.1 835.6 929.4 931.0 947.0 967.2 5773.5 6021.7 6035.6 6113.7 6128.2 413.4 432.6 436.2 443.4 445.8 3980.7 3987.2 4043.3 4097.7 4111.0 10465.4 10736.6 10806.7 10848.6 10885.7 10811.7 10832.1 10833.3 10849.8 10859.6 7652.6 7716.1 8265.4 8301.1 8302.3 4780.4 5409.6 5843.2 5867.4 6049.8 8107.4 9757.7 9864.3 9967.0 10031.3 9150.8 9214.6 9365.5 10095.8 10211.7 5882.9 6199.6 6875.4 7136.8 7618.7 7310.5 8272.0 8542.6 8584.3 8591.5 7366.5 7558.7 7563.7 7654.0 7660.5 7285.3 7347.7 7401.7 7473.4 7500.2 7067.7 7077.2 7131.6 7138.8 7149.2 4956.1 5006.4 5097.3 5107.5 5137.4 5079.8 5090.1 5252.7 5254.5 5280.2 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#4] prototype.html Cycles:180 Average:4410.87 Median:4818.83 stddev:1369.61 (28.4%) stddev-sans-first:1337.68 10:38:47 INFO - PROCESS | 2506 | Values: 267.9 299.9 309.0 312.5 314.7 4940.9 5272.6 5325.5 5452.0 5579.8 4807.1 5287.5 5362.5 5391.6 5458.8 3514.7 3974.8 4204.4 4204.9 4220.2 3598.0 3860.6 4161.2 4193.6 4219.7 3670.7 4066.8 4086.8 4105.6 4155.6 3525.5 3663.5 4126.6 4128.0 4205.2 3554.9 3559.9 3564.8 3601.2 3613.6 4377.9 5262.2 5371.6 5375.8 5378.3 4056.3 4393.8 4731.3 4733.4 4777.1 4856.8 5778.4 5796.8 5888.9 5893.9 3692.2 3779.4 3812.9 3842.8 3904.2 6145.1 6208.4 6235.4 6242.9 6286.4 3933.9 3956.7 3965.7 3982.5 4009.8 3436.3 3780.8 3831.2 4010.3 4053.8 3877.4 4272.6 4442.0 4644.1 4740.8 5179.8 5595.9 5847.0 5864.6 5962.3 1094.9 1207.9 1240.6 1306.4 1362.4 833.6 875.0 917.9 920.9 923.7 5393.5 5407.0 5415.0 5419.0 5422.6 5121.5 5929.6 5963.4 6009.2 6017.5 4516.9 4639.0 4950.6 5054.4 5208.6 2427.7 2495.8 2525.9 2659.0 2683.0 4667.4 4872.8 5142.8 5147.5 5252.6 4772.8 4786.7 5052.9 5061.7 5195.4 4605.9 4724.8 4830.6 5080.3 5148.7 4263.6 4473.9 4674.2 4712.3 5060.5 4177.4 4404.9 4561.7 4650.9 4864.7 4279.6 4469.0 4569.9 5078.6 5092.0 2974.6 3324.6 3356.4 3417.9 3469.1 4243.6 4858.4 4992.3 5010.4 5589.4 4888.5 5411.9 5609.9 5752.6 5835.3 4978.5 5063.8 5263.3 5446.2 5814.6 4880.5 5031.8 5451.0 5506.8 5810.7 5359.0 5605.4 5830.6 5835.4 5846.3 5062.5 5210.5 5683.3 5745.9 5804.4 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - PROCESS | 2506 | [#5] yui.html Cycles:180 Average:24663.62 Median:3627.98 stddev:39405.52 (1086.2%) stddev-sans-first:39474.91 10:38:47 INFO - PROCESS | 2506 | Values: 678.2 689.7 698.2 711.4 729.0 15115.5 16120.4 16134.4 16150.0 16181.6 12446.6 14565.6 14618.0 14623.8 14683.5 686.3 710.4 752.6 859.5 877.9 865.7 885.2 887.0 887.4 888.6 937.5 945.7 946.9 949.2 950.7 932.3 941.2 942.1 943.0 943.6 699.1 701.8 702.4 702.7 703.5 15143.6 15176.0 15236.9 15268.0 15315.2 14485.9 14511.6 14533.7 14542.3 14810.5 11800.8 12046.5 12072.0 12137.1 12333.8 3669.8 3687.7 3858.6 3904.0 3911.1 101554.0 113963.4 114333.0 114403.4 116371.0 9779.1 9827.6 9896.4 10009.5 10050.3 22557.2 22622.5 22821.1 22895.3 22977.3 7919.2 7973.2 7987.5 8009.6 8072.9 4375.6 4389.0 4395.1 4400.5 4432.1 3519.0 3619.3 3622.8 3626.5 3629.5 655.8 658.6 666.7 667.6 674.6 568.0 648.8 658.8 659.3 661.4 8198.2 9199.4 9281.4 9650.5 9664.9 620.0 631.5 657.9 675.9 689.8 4514.8 4636.4 4688.7 4694.2 4748.7 101372.0 148629.4 155208.2 155737.0 159424.0 123437.0 123687.0 124634.0 125576.5 127070.0 108605.5 109418.5 111041.0 111724.9 112840.3 8811.1 8932.9 8947.8 8967.7 9041.7 63693.7 64785.4 65196.7 66196.7 67050.7 80376.0 85618.6 94866.0 97788.5 101629.0 11272.5 12083.9 12146.0 12150.0 12346.6 12812.2 12923.0 12951.5 12980.3 13102.0 11945.7 12200.6 12340.9 12753.2 12884.3 11997.5 12121.7 12330.6 12609.9 12863.2 10650.8 12163.8 12482.5 13647.4 13725.9 10736.8 11042.2 11345.7 11381.5 11449.5 9876.8 10513.6 11197.9 11551.4 11625.2 10:38:47 INFO - PROCESS | 2506 | -------- Summary: end -------- 10:38:47 INFO - PROCESS | 2506 | 10:38:47 INFO - TEST-INFO | 2506: exit 0 10:38:47 INFO - TEST-OK | dromaeo_css | took 1115649ms 10:38:47 INFO - TEST-START | kraken 10:38:47 INFO - operating with platform_type : mac_ 10:38:47 INFO - Initialising browser for kraken test... 10:38:47 INFO - TEST-INFO | started process 2511 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpiOhYUq/profile http://localhost:60026/getInfo.html) 10:38:50 INFO - PROCESS | 2511 | 2016-10-24 10:38:50.594 plugin-container[2512:30066] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 10:38:50 INFO - PROCESS | 2511 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:50 INFO - PROCESS | 2511 | 2016-10-24 10:38:50.597 plugin-container[2512:30066] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 10:38:50 INFO - PROCESS | 2511 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:50 INFO - PROCESS | 2511 | 2016-10-24 10:38:50.597 plugin-container[2512:30066] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:38:50 INFO - PROCESS | 2511 | __metrics Screen width/height:1600/1200 10:38:50 INFO - PROCESS | 2511 | colorDepth:24 10:38:50 INFO - PROCESS | 2511 | Browser inner width/height: 1024/689 10:38:50 INFO - PROCESS | 2511 | __metrics 10:38:50 ERROR - PROCESS | 2511 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:38:51 INFO - TEST-INFO | 2511: exit 0 10:38:51 INFO - Browser initialized. 10:38:51 INFO - Running cycle 1/1 for kraken test... 10:38:51 INFO - TEST-INFO | started process 2513 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpiOhYUq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:53 INFO - PROCESS | 2513 | 2016-10-24 10:38:53.995 plugin-container[2514:30177] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 10:38:53 INFO - PROCESS | 2513 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:53 INFO - PROCESS | 2513 | 2016-10-24 10:38:53.995 plugin-container[2514:30177] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 10:38:53 INFO - PROCESS | 2513 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:38:53 INFO - PROCESS | 2513 | 2016-10-24 10:38:53.995 plugin-container[2514:30177] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:39:03 INFO - PROCESS | 2513 | RSS: Main: 236425216 10:39:03 INFO - PROCESS | 2513 | 10:39:06 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60026/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:07 INFO - PROCESS | 2513 | RSS: Main: 249188352 10:39:07 INFO - PROCESS | 2513 | 10:39:10 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60026/tests/kraken/driver.html?testName=audio-dft) 10:39:10 INFO - PROCESS | 2513 | RSS: Main: 256761856 10:39:10 INFO - PROCESS | 2513 | 10:39:14 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60026/tests/kraken/driver.html?testName=audio-fft) 10:39:14 INFO - PROCESS | 2513 | RSS: Main: 259825664 10:39:14 INFO - PROCESS | 2513 | 10:39:16 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60026/tests/kraken/driver.html?testName=audio-oscillator) 10:39:17 INFO - PROCESS | 2513 | RSS: Main: 261906432 10:39:17 INFO - PROCESS | 2513 | 10:39:19 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:19 INFO - PROCESS | 2513 | RSS: Main: 262434816 10:39:19 INFO - PROCESS | 2513 | 10:39:22 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60026/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:23 INFO - PROCESS | 2513 | RSS: Main: 263356416 10:39:23 INFO - PROCESS | 2513 | 10:39:26 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60026/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:27 INFO - PROCESS | 2513 | RSS: Main: 263479296 10:39:27 INFO - PROCESS | 2513 | 10:39:30 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60026/tests/kraken/driver.html?testName=json-parse-financial) 10:39:30 INFO - PROCESS | 2513 | RSS: Main: 263847936 10:39:30 INFO - PROCESS | 2513 | 10:39:32 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:32 INFO - PROCESS | 2513 | RSS: Main: 263606272 10:39:32 INFO - PROCESS | 2513 | 10:39:34 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:35 INFO - PROCESS | 2513 | RSS: Main: 263671808 10:39:35 INFO - PROCESS | 2513 | 10:39:37 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:38 INFO - PROCESS | 2513 | RSS: Main: 263737344 10:39:38 INFO - PROCESS | 2513 | 10:39:41 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:42 INFO - PROCESS | 2513 | RSS: Main: 264167424 10:39:42 INFO - PROCESS | 2513 | 10:39:45 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:46 INFO - PROCESS | 2513 | RSS: Main: 264200192 10:39:46 INFO - PROCESS | 2513 | 10:39:47 INFO - PROCESS | 2513 | Cycle 1(1): loaded http://localhost:60026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60026/tests/kraken/driver.html?testName=ai-astar) 10:39:48 INFO - PROCESS | 2513 | RSS: Main: 265773056 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | __start_tp_report 10:39:48 INFO - PROCESS | 2513 | _x_x_mozilla_page_load 10:39:48 INFO - PROCESS | 2513 | _x_x_mozilla_page_load_details 10:39:48 INFO - PROCESS | 2513 | |i|pagename|runs| 10:39:48 INFO - PROCESS | 2513 | |0;ai-astar;107;118;115;126;118;119;119;128;118;121 10:39:48 INFO - PROCESS | 2513 | |1;audio-beat-detection;149;118;113;156;117;119;116;116;141;118 10:39:48 INFO - PROCESS | 2513 | |2;audio-dft;199;215;219;201;194;199;198;199;204;195 10:39:48 INFO - PROCESS | 2513 | |3;audio-fft;104;77;50;100;52;60;76;78;98;78 10:39:48 INFO - PROCESS | 2513 | |4;audio-oscillator;89;69;90;72;68;71;89;69;69;83 10:39:48 INFO - PROCESS | 2513 | |5;imaging-gaussian-blur;118;89;118;116;89;85;91;88;89;79 10:39:48 INFO - PROCESS | 2513 | |6;imaging-darkroom;137;120;96;98;98;95;97;97;99;99 10:39:48 INFO - PROCESS | 2513 | |7;imaging-desaturate;89;90;82;89;106;130;123;90;110;130 10:39:48 INFO - PROCESS | 2513 | |8;json-parse-financial;58;57;52;53;55;52;53;50;51;59 10:39:48 INFO - PROCESS | 2513 | |9;json-stringify-tinderbox;70;75;87;87;59;98;98;99;98;60 10:39:48 INFO - PROCESS | 2513 | |10;stanford-crypto-aes;101;101;90;86;102;102;101;99;90;90 10:39:48 INFO - PROCESS | 2513 | |11;stanford-crypto-ccm;152;162;143;140;161;160;170;164;217;165 10:39:48 INFO - PROCESS | 2513 | |12;stanford-crypto-pbkdf2;173;174;173;177;179;177;177;180;173;177 10:39:48 INFO - PROCESS | 2513 | |13;stanford-crypto-sha256-iterative;67;71;72;73;85;91;88;89;86;82 10:39:48 INFO - PROCESS | 2513 | __end_tp_report 10:39:48 INFO - PROCESS | 2513 | __start_cc_report 10:39:48 INFO - PROCESS | 2513 | _x_x_mozilla_cycle_collect,954 10:39:48 INFO - PROCESS | 2513 | __end_cc_report 10:39:48 INFO - PROCESS | 2513 | __startTimestamp1477330788222__endTimestamp 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | ------- Summary: start ------- 10:39:48 INFO - PROCESS | 2513 | Number of tests: 14 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#0] ai-astar Cycles:10 Average:118.90 Median:119.00 stddev:5.74 (4.8%) stddev-sans-first:4.18 10:39:48 INFO - PROCESS | 2513 | Values: 107.0 118.0 115.0 126.0 118.0 119.0 119.0 128.0 118.0 121.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:118.50 stddev:15.92 (13.4%) stddev-sans-first:14.61 10:39:48 INFO - PROCESS | 2513 | Values: 149.0 118.0 113.0 156.0 117.0 119.0 116.0 116.0 141.0 118.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#2] audio-dft Cycles:10 Average:202.30 Median:200.00 stddev:8.29 (4.1%) stddev-sans-first:8.70 10:39:48 INFO - PROCESS | 2513 | Values: 199.0 215.0 219.0 201.0 194.0 199.0 198.0 199.0 204.0 195.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#3] audio-fft Cycles:10 Average:77.30 Median:76.50 stddev:19.28 (25.2%) stddev-sans-first:17.86 10:39:48 INFO - PROCESS | 2513 | Values: 104.0 77.0 50.0 100.0 52.0 60.0 76.0 78.0 98.0 78.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:9.59 (12.4%) stddev-sans-first:9.11 10:39:48 INFO - PROCESS | 2513 | Values: 89.0 69.0 90.0 72.0 68.0 71.0 89.0 69.0 69.0 83.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:88.50 stddev:14.96 (16.9%) stddev-sans-first:13.63 10:39:48 INFO - PROCESS | 2513 | Values: 118.0 89.0 118.0 116.0 89.0 85.0 91.0 88.0 89.0 79.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:97.50 stddev:13.78 (14.1%) stddev-sans-first:7.66 10:39:48 INFO - PROCESS | 2513 | Values: 137.0 120.0 96.0 98.0 98.0 95.0 97.0 97.0 99.0 99.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#7] imaging-desaturate Cycles:10 Average:103.90 Median:85.50 stddev:18.50 (21.6%) stddev-sans-first:18.82 10:39:48 INFO - PROCESS | 2513 | Values: 89.0 90.0 82.0 89.0 106.0 130.0 123.0 90.0 110.0 130.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:3.09 (5.7%) stddev-sans-first:2.92 10:39:48 INFO - PROCESS | 2513 | Values: 58.0 57.0 52.0 53.0 55.0 52.0 53.0 50.0 51.0 59.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#9] json-stringify-tinderbox Cycles:10 Average:83.10 Median:92.50 stddev:15.99 (17.3%) stddev-sans-first:16.24 10:39:48 INFO - PROCESS | 2513 | Values: 70.0 75.0 87.0 87.0 59.0 98.0 98.0 99.0 98.0 60.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:88.00 stddev:6.36 (7.2%) stddev-sans-first:6.50 10:39:48 INFO - PROCESS | 2513 | Values: 101.0 101.0 90.0 86.0 102.0 102.0 101.0 99.0 90.0 90.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#11] stanford-crypto-ccm Cycles:10 Average:163.40 Median:163.00 stddev:21.17 (13.0%) stddev-sans-first:22.05 10:39:48 INFO - PROCESS | 2513 | Values: 152.0 162.0 143.0 140.0 161.0 160.0 170.0 164.0 217.0 165.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:177.00 stddev:2.58 (1.5%) stddev-sans-first:2.50 10:39:48 INFO - PROCESS | 2513 | Values: 173.0 174.0 173.0 177.0 179.0 177.0 177.0 180.0 173.0 177.0 10:39:48 INFO - PROCESS | 2513 | 10:39:48 INFO - PROCESS | 2513 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:85.50 stddev:8.77 (10.3%) stddev-sans-first:7.85 10:39:48 INFO - PROCESS | 2513 | Values: 67.0 71.0 72.0 73.0 85.0 91.0 88.0 89.0 86.0 82.0 10:39:48 INFO - PROCESS | 2513 | -------- Summary: end -------- 10:39:48 INFO - PROCESS | 2513 | 10:39:49 INFO - TEST-INFO | 2513: exit 0 10:39:49 INFO - TEST-OK | kraken | took 61270ms 10:39:49 INFO - SUITE-END | took 1176s 10:39:49 INFO - Completed test suite (00:19:37) 10:39:49 INFO - javascript benchmark 10:39:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7266.596544861107, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.832658367081, 3347.464405695086, 3349.0622625664805, 3374.0383990562677, 3382.154461384653, 5641.802536911209, 5678.46054624811, 5749.310082790066, 5766.9711651441785, 5767.250257466529, 5674.829755107343, 5711.828645140642, 5732.283464566929, 5790.739416726247, 5814.651120932736, 5175.803120412077, 5201.635885488017, 5207.088759467097, 5299.867503312409, 5318.016167009116, 5293.39126000511, 5306.522412982831, 5316.096263635172, 5347.679139251638, 5359.651622644516, 5147.794088236466, 5175.275461435402, 5265.078611243055, 5273.604479664041, 5301.787928482856, 5219.42586315505, 5235.502627250406, 5269.789208431658, 5271.077561426773, 5276.3140791697215, 5166.1217593008905, 5175.146100893348, 5195.454477279869, 5223.2165175223645, 5227.921581176285, 5476.096444086721, 5610.186522954149, 5650.971745141248, 5678.4037676044245, 5751.079827227665, 6066.454019138255, 6138.204480310026, 6158.261008678987, 6194.752209911598, 6197.535184861108, 6191.442770150708, 6211.192544969125, 6215.782447614311, 6218.564700470969, 6235.00239961604, 5820.592558520862, 5834.533237341003, 5836.066229403275, 5852.326982397079, 5888.5877988540815, 5706.343770466367, 6022.669599052641, 6180.289266734383, 6181.474574661114, 6239.937600623935, 6131.0803379492545, 6150.969245153835, 6155.384461553809, 6165.537584681167, 6165.784197553064, 6106.542009349317, 6136.815895523141, 6194.225721784777, 6215.844603884849, 6251.3123556408755, 6139.6454669416935, 6158.107074474176, 6160.630362178284, 6213.130161777355, 6214.875702485925, 6165.445109940127, 6232.501399887998, 6244.313125556185, 6269.968650156811, 6284.591501552384, 4849.660523763373, 4926.3349447824085, 4929.2359684248995, 4971.229459433794, 4975.4278258000795, 4353.956460435418, 4354.455693038371, 4359.062801497693, 4445.333200019958, 4505.6846020778885, 5697.857553561112, 5757.6833274169485, 5761.798337058183, 5823.621464604787, 5828.795992140254, 6161.137440758297, 6201.1938448002375, 6225.62646241227, 6231.127642130105, 6247.406496382836, 5679.148127780866, 5722.170285308607, 5732.369439361667, 5745.88508229833, 5774.740136693859, 5413.350397952271, 5424.864378390572, 5439.728013599304, 5442.292501974797, 5488.91766623501, 6293.559450838489, 6301.6534090625455, 6347.301796802348, 6348.650824204713, 6350.936490635035, 6108.584917381041, 6123.343628574205, 6131.223750760645, 6185.752569897154, 6207.131001659681, 6306.054091886253, 6317.305096439296, 6331.398517140864, 6335.873282534416, 6345.96827015862, 6119.0, 6127.172831667668, 6146.416090471398, 6184.5052395809125, 6197.442230199304, 6102.883130681719, 6127.953177891068, 6157.96921015392, 6218.968905155445, 6243.750249989949, 5512.476314750093, 6041.969790151021, 6130.245269656939, 6146.108814222002, 6162.445379915829, 5227.372715274191, 5427.782888684566, 5881.500072493886, 6084.69576521181, 6110.969445152746, 5297.973510132425, 5398.64908780928, 5502.614816962774, 5901.7639294427745, 5907.645541267538, 6069.544784141295, 6093.238345206849, 6100.298465676504, 6123.510119190543, 6137.232845894263, 5004.974975125101, 5883.146943693226, 5910.911336329872, 5912.822615321547, 5933.110033495011], "value": 5674.19214531581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.8971981304207, 467.74040407573796, 488.91199584074855, 499.0318781563766, 516.5428595692815, 40233.597664023386, 41755.79122104389, 41851.37222941654, 43902.34146487797, 43964.68105956826, 43012.13975720484, 43173.13653726924, 43363.566364336344, 43432.0, 43488.347674784905, 9512.571934262958, 9643.276754243425, 9678.274129440286, 9710.41737495749, 9732.0, 9602.039796020412, 9696.660616878411, 9700.126988571028, 9716.611335546604, 9727.124558789708, 9654.275929305295, 9660.420374777535, 9677.70966870995, 9684.273679474067, 9702.466364349957, 9605.231581473465, 9660.227181825438, 9671.081247281498, 9686.46724430156, 9700.999999999965, 9513.476758778264, 9530.142287194116, 9559.761005974837, 9580.0898914603, 9602.75993100171, 40543.7972810137, 40834.38748418776, 40939.0, 40962.59037409617, 40966.59033409687, 3184.0, 3530.8411121499594, 3578.8926332210076, 3724.944125838115, 4161.646260067898, 30997.69002309993, 31259.843700781577, 31293.374132517223, 31504.0, 31785.682143178503, 2764.682061562926, 2779.583062540635, 2861.6136821529244, 2962.7777916656123, 3257.657945915692, 486615.0, 486988.0, 487088.0, 487449.56275218754, 487474.0, 62340.37659623437, 62395.6880215596, 62438.0, 62672.68663656653, 62746.0, 66342.0, 66618.66690666515, 66632.0, 66739.0, 66811.0, 15718.68562628741, 15909.840901591067, 15985.520434386986, 16097.356105755638, 16341.591460213589, 12288.569900053455, 12338.629841104781, 12369.319687417099, 12374.752504950031, 12383.0, 16826.242819072926, 18021.0, 18054.729179062324, 18231.544211394823, 18247.54381140482, 6704.2625311215725, 6981.232064473005, 7210.819729506699, 7375.0, 7394.5932973685885, 860.8794768732382, 916.2649491268558, 1021.8416145497312, 1035.316690983962, 1049.9002594753485, 25607.359816004377, 25938.87030564873, 30202.24494387658, 30766.230844229074, 31305.0, 947.6825263536792, 1012.4229189361993, 1069.5187165775433, 1097.3032124600777, 1127.9887201127883, 14759.852401476062, 15631.84368156304, 15698.529044128694, 15734.213289335488, 16075.598110047342, 513042.0, 628032.0, 632582.0, 634098.0, 643117.784411075, 58327.41672583305, 58580.12129818056, 58646.0, 58731.0, 58820.82358352809, 1146.7821113988316, 1251.3680591301334, 1301.6420484366874, 1360.455817672919, 1418.5957002254102, 31089.378212436077, 31861.522077169324, 31881.0, 32419.351612967137, 32792.85225017209, 48173.03653926972, 51291.0, 51628.22557661563, 51810.74094629503, 51903.48096518986, 418568.0, 477943.0, 478115.0, 478124.0, 478484.0, 25936.61095083613, 26053.869730651226, 26838.731612683623, 26854.462910741284, 27766.86116569404, 47760.52239477561, 47762.522374777196, 48171.5182848167, 48499.27251091307, 49317.50682493129, 39664.40503392509, 39667.0, 40333.798331008154, 40609.0, 41370.0, 39308.410373844985, 39823.60176398315, 39836.80081599573, 39958.60144894915, 40618.1876362477, 37908.0, 38705.225895481366, 39006.219875602896, 39212.6078739209, 40663.78008659745, 30833.8458307716, 34902.30195396129, 35224.0, 35562.64437355593, 35694.28611427809, 26070.86964565165, 26148.73851261463, 26166.215013549623, 26488.8675556621, 26532.8673356632], "value": 19944.251903436732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6967591089174, 378.4361301660526, 383.637462597845, 389.84406237504976, 406.8169323804287, 18261.452156435294, 20819.959002049876, 21025.0, 21127.049282782275, 21232.57534849304, 20420.38738837837, 20446.488837779063, 20565.794342056575, 20628.587428251427, 20930.26744063958, 5179.81870634527, 5395.892082158354, 5717.113847353667, 6029.909551356734, 6096.2074930259005, 3858.6334298241622, 4051.210014047262, 6042.788502402417, 6087.086936959469, 6099.664518451484, 5623.831285061455, 5887.793927212549, 5940.108983652443, 5987.311459182184, 6001.849953751147, 5835.970820145914, 5919.940800592003, 5952.375000624937, 5983.640981541122, 6030.517558595346, 5858.3848695886745, 5865.090910908816, 5870.765169393262, 5870.853228669274, 5881.85295367615, 19308.613827723508, 24419.63370549443, 25028.0, 25145.24564263075, 25197.37006574832, 2573.7040240372407, 2779.2357101796965, 2804.831710097401, 2824.4915915135266, 2905.6513218413716, 9842.0, 9899.731325642279, 9919.553620087114, 10399.220058495568, 10429.791404171874, 1630.9184540772915, 1781.3320004998125, 1862.7112797516406, 1887.1979408751363, 1890.4895678166956, 107318.0, 118723.4063829684, 119668.0, 120207.0, 120326.39836800848, 11168.888311116947, 11239.494222759995, 11343.659690209142, 11451.828222576669, 11475.655730328104, 14287.0, 14310.85689143116, 14319.713605727828, 14325.140491570539, 14380.0, 7961.283484486424, 8260.752177434686, 8325.583720814057, 8378.371622128365, 8454.0, 8032.83934321322, 8135.3491720662205, 8150.551719655357, 8276.958615206886, 8297.211764882326, 4388.868333949923, 4486.461624605003, 4520.2315606347, 4574.817007319736, 4590.770461476913, 1567.5140706381057, 1913.435536516731, 1952.3947576251408, 1962.3229985654925, 2003.599280143948, 815.6370415165195, 909.5679552212646, 928.2388441477923, 941.3504681769557, 982.6560703753629, 19896.70154947677, 20730.48173795667, 21070.293707124354, 21077.156913723586, 21183.470413239484, 887.9023307436177, 908.5457271364318, 944.9244060475146, 946.8590348630022, 975.8194733974237, 10604.257701960943, 10681.786364272672, 10944.069754070993, 10962.945185274022, 10988.835167472495, 575835.0, 576982.1150894219, 577988.0, 588149.0, 593047.0, 99307.0, 111683.0, 114171.0, 124752.0, 130594.0, 927.1377618814432, 1000.6697789729371, 1007.471077684207, 1019.1133713669155, 1020.0666390252835, 15523.924984658566, 16352.918235409223, 17468.650626987645, 18475.81524184741, 18692.7196092056, 54164.18753718776, 54819.0, 55020.724896375265, 56210.43789562052, 56829.0, 84485.310293795, 84509.3098138046, 84602.57698711468, 85190.7221391692, 85395.57302213449, 7737.419693522896, 7795.538590003642, 7841.294283514511, 7933.722319718782, 8154.103048664523, 8792.560371981248, 12032.0, 12127.575534856238, 12550.811737824122, 12579.559715409916, 9463.526823658927, 10510.0, 10570.65990506486, 10690.839637405601, 10928.852470490485, 9218.861717074384, 10143.391396516232, 10416.583336666448, 10437.060664540228, 10707.089897358812, 11141.83287250708, 11327.886721132683, 11341.432928353384, 11464.426778660867, 11728.0, 7927.890095386535, 7942.5306318331295, 7988.680452782056, 8150.9184908150155, 8282.378821588285, 10494.370337779757, 10803.621873234399, 11019.779604408028, 11043.061339786209, 11054.502547385226], "value": 9461.007512140779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.1898860683589, 1473.2928194466651, 1667.6414570867269, 1846.9445916622506, 1879.3422302194233, 6523.80428587142, 8331.041930178031, 8517.0, 9098.22665073468, 9120.908790912088, 8571.828563428744, 8836.690715824947, 8870.645174193025, 8954.015058343577, 8958.820823583525, 2306.826987975904, 2337.637666161748, 2338.9064437422485, 2347.471818840764, 2354.1878052072007, 1855.4248183063225, 2240.5466014713943, 2321.1643808229023, 2341.2507997440825, 2357.2456813819585, 1967.2327792161068, 2301.2175860207526, 2312.3178662294663, 2319.652052192176, 2335.2177020698086, 1994.1823852220664, 2310.688057112285, 2314.4445333120098, 2318.4435735423463, 2320.8027317677934, 2005.899705014758, 2298.28753086542, 2319.281022882895, 2324.0471406723163, 2340.707411573553, 8271.0, 8543.82912341756, 8594.183552562497, 8991.100889911022, 9080.182783549446, 5239.056969745444, 5364.490373414519, 5383.353997520323, 5390.326209223847, 5421.674699518042, 3481.147118955872, 3577.141486043357, 3682.1531047859144, 3702.5186725725753, 3723.180900201978, 1054.7204990677476, 1061.2359101446946, 1080.6487891435236, 1082.1559183836541, 1091.4651820607924, 11475.713107172387, 11509.309441433541, 11622.0, 11633.418329083512, 11652.300861948226, 4555.544445555418, 4682.180618391768, 4771.165046116985, 4789.736564488917, 4804.495527969582, 9887.209023278121, 9927.553260103312, 9929.900700993043, 9947.900520994843, 9948.850767238497, 5352.090144675414, 5368.489993450616, 5378.2470454136455, 5394.217838413408, 5395.946040539544, 3830.3488406970882, 4546.40896683429, 4700.130475861976, 4845.733484658378, 4918.975405122951, 3418.7265018798435, 3850.4609354690365, 3883.1845312484693, 3945.1715139820385, 3980.402939559089, 1291.6814318298677, 1300.7042569864198, 1302.7915533514781, 1308.9018323625767, 1312.1405479411, 835.6197929941862, 929.4423345992351, 930.9906900931039, 946.9621215151454, 967.1875624475474, 5773.538116950634, 6021.668808215591, 6035.6076855004285, 6113.694315284307, 6128.203333566607, 413.4253387790913, 432.5955231858223, 436.2431181899402, 443.4080502529095, 445.7904784751162, 3980.7014473914574, 3987.222491614107, 4043.251998380309, 4097.733647312915, 4110.979445102756, 10465.372077675363, 10736.624218152327, 10806.729831754268, 10848.620298289521, 10885.727856803644, 10811.675649730521, 10832.079273261703, 10833.29583577065, 10849.78300433987, 10859.565617375216, 7652.579108149105, 7716.112647045549, 8265.380096492787, 8301.086880443147, 8302.294304984143, 4780.402449693788, 5409.594280428905, 5843.211166492639, 5867.442592953663, 6049.758009679739, 8107.351411886917, 9757.707268781947, 9864.260180486348, 9967.0, 10031.347962382422, 9150.810394648654, 9214.631414743335, 9365.531723413938, 10095.798084038131, 10211.744706382102, 5882.911756323744, 6199.56603037783, 6875.3812156906115, 7136.750213742494, 7618.69525218985, 7310.488265821342, 8272.0, 8542.615582298935, 8584.313254939714, 8591.484510929364, 7366.521176123535, 7558.735444259424, 7563.7352692655495, 7654.004979352649, 7660.5403675779635, 7285.307895749896, 7347.742829000959, 7401.666924988281, 7473.43949203801, 7500.174980752222, 7067.717291308496, 7077.150741911004, 7131.572105673677, 7138.785836424708, 7149.213586505376, 4956.091904616821, 5006.3992320921725, 5097.311862898461, 5107.489251075011, 5137.357830271216, 5079.796808127781, 5090.134677104975, 5252.711100889488, 5254.500822421864, 5280.1815718563685], "value": 4459.450455557322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.87008300974026, 299.8875421716856, 309.0450507930494, 312.49064025638205, 314.67116862878316, 4940.925886111707, 5272.6273177070325, 5325.547328477084, 5452.0, 5579.776808927638, 4807.053143476897, 5287.4976877196705, 5362.51737343639, 5391.622586418943, 5458.836234912959, 3514.6661067198575, 3974.801259937006, 4204.369344598304, 4204.867373806518, 4220.177065472234, 3598.0285322962786, 3860.5715885122545, 4161.188568229197, 4193.601607847265, 4219.746815191098, 3670.743047986642, 4066.7966601669946, 4086.754794712312, 4105.557193469881, 4155.605217504332, 3525.4711793230963, 3663.461346234588, 4126.628603425676, 4127.968007998001, 4205.243056249874, 3554.8979816257042, 3559.857605695769, 3564.7861128332124, 3601.1717305019993, 3613.602503724588, 4377.868663940087, 5262.184915935954, 5371.623986320959, 5375.7849686012905, 5378.327709036371, 4056.3307054336, 4393.780310984438, 4731.344029589651, 4733.431988161408, 4777.140114779339, 4856.781444834991, 5778.439821248281, 5796.768129274866, 5888.911666325009, 5893.911591326134, 3692.2061756722433, 3779.433085037239, 3812.894260664404, 3842.8078596070086, 3904.1801221743467, 6145.064304743992, 6208.379162083801, 6235.407636274546, 6242.940958930091, 6286.371362863722, 3933.881983540441, 3956.66368358687, 3965.6886499773013, 3982.5021872265966, 4009.7594144351433, 3436.295559410315, 3780.790147152885, 3831.1762970961377, 4010.318245898146, 4053.7973101344814, 3877.3990031545154, 4272.6073398896715, 4442.000549876252, 4644.140833945731, 4740.834070807505, 5179.766910489037, 5595.936772013386, 5846.970765146147, 5864.618799778001, 5962.25471816023, 1094.921502320214, 1207.9033677305795, 1240.5782034108265, 1306.4251729239104, 1362.3528823808613, 833.5957060825494, 874.9781255468664, 917.9219766319937, 920.8664743612138, 923.6813299411692, 5393.487618676219, 5407.0, 5414.996451312961, 5418.9678870423595, 5422.620416570802, 5121.4622464641425, 5929.555283353679, 5963.373845746221, 6009.248843894513, 6017.548683848729, 4516.864494065183, 4638.976805115953, 4950.628702847301, 5054.368203974504, 5208.635395522277, 2427.7329493755674, 2495.75382156061, 2525.918379576913, 2659.0, 2683.034107721219, 4667.369905062773, 4872.806162490213, 5142.845714628567, 5147.485251474823, 5252.581802913269, 4772.785224664898, 4786.712797232177, 5052.873678158076, 5061.709264137621, 5195.376554813371, 4605.930911036337, 4724.7557410229865, 4830.613550915848, 5080.263361812516, 5148.661348049459, 4263.573642635712, 4473.926257698194, 4674.200432833316, 4712.316714076508, 5060.49395060491, 4177.373393990925, 4404.867853964386, 4561.74910379919, 4650.883727906829, 4864.683795553277, 4279.614834664895, 4468.955310446854, 4569.862904112882, 5078.591300265206, 5092.0, 2974.553816927392, 3324.6176689680997, 3356.3958487471514, 3417.8632854685534, 3469.0746635617475, 4243.575642435731, 4858.416989961227, 4992.326035985241, 5010.448850626355, 5589.428862723193, 4888.5111488850835, 5411.918821217763, 5609.88780224385, 5752.568557358131, 5835.328937172279, 4978.502149785138, 5063.772130254221, 5263.289455923401, 5446.237526746179, 5814.622049566765, 4880.485051891482, 5031.84904452867, 5450.974709036523, 5506.834794956158, 5810.709464526842, 5358.97320513395, 5605.383407825218, 5830.5627077968475, 5835.44563266489, 5846.327672317738, 5062.468440813662, 5210.53105220532, 5683.2895888014, 5745.885082298414, 5804.419558044162], "value": 3976.1821330994458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.2200469460121, 689.7447944260623, 698.2145086777372, 711.4059760100316, 728.9744858929938, 15115.546533603982, 16120.435784747537, 16134.354625814953, 16150.0, 16181.595460113489, 12446.626601201979, 14565.635859103528, 14618.0, 14623.78064329036, 14683.486077987272, 686.3171144710994, 710.3677726823106, 752.5522314223056, 859.5315553023618, 877.8683197520392, 865.6623916672503, 885.1546772831962, 886.9976926073527, 887.3522328700053, 888.6001299415257, 937.5265490927106, 945.6595625574788, 946.9431834089977, 949.1931857920747, 950.7100334398006, 932.3240650528346, 941.1623654947102, 942.1285311087217, 943.0475220027753, 943.6036864516919, 699.098163369253, 701.7614011236204, 702.3819039245483, 702.7013519254348, 703.5075447186938, 15143.621409464742, 15176.0, 15236.923815380853, 15268.007579507408, 15315.234238288042, 14485.855141448556, 14511.637209069857, 14533.70932581353, 14542.27288635564, 14810.481633142788, 11800.822987655192, 12046.457909394097, 12072.034237261087, 12137.089718271165, 12333.753324933452, 3669.7798132111893, 3687.6865466435383, 3858.614138586147, 3903.9609603904164, 3911.0613452771413, 101554.0, 113963.43018284856, 114333.0, 114403.42798286039, 116370.99999999916, 9779.083958058387, 9827.606895724233, 9896.356736812084, 10009.499525023866, 10050.296479246383, 22557.210497632503, 22622.547549048926, 22821.087156513884, 22895.313140605474, 22977.310680679606, 7919.247671471201, 7973.20267973198, 7987.480813747088, 8009.559474228973, 8072.879051257435, 4375.649948004216, 4389.0, 4395.1429471252795, 4400.4939431965095, 4432.135733531994, 3519.0, 3619.2761447710564, 3622.7645203061716, 3626.492291079251, 3629.4737263096704, 655.8360409897525, 658.6048370977376, 666.7333066773233, 667.6394746836751, 674.5986138247735, 567.9858003549862, 648.7664440801308, 658.7727234104226, 659.3110199841177, 661.384912031815, 8198.15695718818, 9199.356045076915, 9281.350305478552, 9650.517474126405, 9664.855027174597, 619.9876002479925, 631.5137344244906, 657.8881590129689, 675.9155105611799, 689.7516893918186, 4514.774261286922, 4636.35091087248, 4688.651987645724, 4694.155052090657, 4748.691335063209, 101372.0, 148629.36650384837, 155208.22395887948, 155737.0, 159424.0, 123437.0, 123687.0, 124634.0, 125576.51258004784, 127070.0, 108605.45697271463, 109418.45290773496, 111041.0, 111724.88275117308, 112840.3073953875, 8811.105612293388, 8932.86600701003, 8947.776305592412, 8967.730968070968, 9041.68354107603, 63693.6815315939, 64785.4368009764, 65196.674016629615, 66196.6690166546, 67050.66474667596, 80376.0, 85618.57190714007, 94866.0, 97788.5110574471, 101629.0, 11272.549098035986, 12083.939580302042, 12146.0, 12150.0, 12346.567870124503, 12812.167209131376, 12923.0, 12951.45070968903, 12980.286084265455, 13102.0, 11945.701357466132, 12200.572979945659, 12340.938295308466, 12753.171043882117, 12884.291363975071, 11997.460114295052, 12121.69695757613, 12330.63008109758, 12609.87390126087, 12863.22820630765, 10650.84023739629, 12163.756724865276, 12482.500699971899, 13647.385867635781, 13725.931370343083, 10736.838947415952, 11042.171837112088, 11345.716357090809, 11381.487833047699, 11449.542744329827, 9876.802463950824, 10513.632022879163, 11197.944010279896, 11551.42242887869, 11625.18623696367], "value": 7754.097723787435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 115.0, 126.0, 118.0, 119.0, 119.0, 128.0, 118.0, 121.0], "value": 118.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 113.0, 156.0, 117.0, 119.0, 116.0, 116.0, 141.0, 118.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 215.0, 219.0, 201.0, 194.0, 199.0, 198.0, 199.0, 204.0, 195.0], "value": 202.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 77.0, 50.0, 100.0, 52.0, 60.0, 76.0, 78.0, 98.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 90.0, 72.0, 68.0, 71.0, 89.0, 69.0, 69.0, 83.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 89.0, 118.0, 116.0, 89.0, 85.0, 91.0, 88.0, 89.0, 79.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 120.0, 96.0, 98.0, 98.0, 95.0, 97.0, 97.0, 99.0, 99.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 82.0, 89.0, 106.0, 130.0, 123.0, 90.0, 110.0, 130.0], "value": 103.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 52.0, 53.0, 55.0, 52.0, 53.0, 50.0, 51.0, 59.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 87.0, 87.0, 59.0, 98.0, 98.0, 99.0, 98.0, 60.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 90.0, 86.0, 102.0, 102.0, 101.0, 99.0, 90.0, 90.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 162.0, 143.0, 140.0, 161.0, 160.0, 170.0, 164.0, 217.0, 165.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 173.0, 177.0, 179.0, 177.0, 177.0, 180.0, 173.0, 177.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 72.0, 73.0, 85.0, 91.0, 88.0, 89.0, 86.0, 82.0], "value": 80.4, "unit": "score"}]}]} 10:39:49 INFO - Return code: 0 10:39:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:49 ERROR - # TBPL SUCCESS # 10:39:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:39:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:39:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:39:49 INFO - 2016-10-24 10:39:49.534 screenresolution[2518:30558] starting screenresolution argv=screenresolution get 10:39:49 INFO - 2016-10-24 10:39:49.537 screenresolution[2518:30558] Display 0: 1600x1200x32@60 10:39:49 INFO - 2016-10-24 10:39:49.543 screenresolution[2519:30561] starting screenresolution argv=screenresolution list 10:39:49 INFO - Available Modes on Display 0 10:39:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:39:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:39:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:39:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:39:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:39:49 INFO - Intel Iris: 10:39:49 INFO - Chipset Model: Intel Iris 10:39:49 INFO - Type: GPU 10:39:49 INFO - Bus: Built-In 10:39:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:39:49 INFO - Vendor: Intel (0x8086) 10:39:49 INFO - Device ID: 0x0a2e 10:39:49 INFO - Revision ID: 0x0009 10:39:49 INFO - Displays: 10:39:49 INFO - Display: 10:39:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:39:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:39:49 INFO - Display Serial Number: 1600x1200 60 10:39:49 INFO - Main Display: Yes 10:39:49 INFO - Mirror: Off 10:39:49 INFO - Online: Yes 10:39:49 INFO - Rotation: Supported 10:39:49 INFO - Return code: 0 10:39:49 INFO - Running post-action listener: _resource_record_post_action 10:39:49 INFO - [mozharness: 2016-10-24 17:39:49.780494Z] Finished run-tests step (success) 10:39:49 INFO - Running post-run listener: _resource_record_post_run 10:39:49 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 0; Write bytes: 709386752; Read time: 0; Write time: 1911 10:39:49 INFO - TinderboxPrint: CPU usage
54.8% 10:39:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:39:49 INFO - TinderboxPrint: I/O write bytes / time
709,386,752 / 1,911 10:39:49 INFO - TinderboxPrint: CPU idle
2,194.1 (45.2%) 10:39:49 INFO - TinderboxPrint: CPU system
981.5 (20.2%) 10:39:49 INFO - TinderboxPrint: CPU user
1,674.2 (34.5%) 10:39:49 INFO - TinderboxPrint: Swap in / out
404,041,728 / 0 10:39:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393318912; Write bytes: 388274176; Read time: 29306; Write time: 715 10:39:49 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 0; Write bytes: 300644864; Read time: 0; Write time: 1146 10:39:50 INFO - Running post-run listener: _upload_blobber_files 10:39:50 INFO - Blob upload gear active. 10:39:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:50 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:39:50 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:39:50 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:39:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:51 INFO - (blobuploader) - INFO - Done attempting. 10:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:52 INFO - (blobuploader) - INFO - Done attempting. 10:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:57 INFO - (blobuploader) - INFO - Done attempting. 10:39:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:57 INFO - Return code: 0 10:39:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c91cc397f8360ad2c4abdaf7fe6e0ae7b1ba6e9822c64780e5e97aa37f247f85f4796b670ca3fb9cf31682a66444540f7d6842f6163f339777ff04346195392", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a85922276f753ede3b196f60cea9aff2b1413c4ab2dac2f3eb995b3830bcb0ed524e1e7850b9f735352503e56a25c145928f8c3c19b050e7886fc715c4c9e71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e9fb4a1d8ceaa9fdb2676422fb1e34bfe9758a9e0410f181e8a95ac835d708a9829e3c4f6e96c37acbacfc447aff92fbfc7bae53b722301b2a8da5cff1c537"} 10:39:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:57 INFO - Contents: 10:39:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c91cc397f8360ad2c4abdaf7fe6e0ae7b1ba6e9822c64780e5e97aa37f247f85f4796b670ca3fb9cf31682a66444540f7d6842f6163f339777ff04346195392", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a85922276f753ede3b196f60cea9aff2b1413c4ab2dac2f3eb995b3830bcb0ed524e1e7850b9f735352503e56a25c145928f8c3c19b050e7886fc715c4c9e71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e9fb4a1d8ceaa9fdb2676422fb1e34bfe9758a9e0410f181e8a95ac835d708a9829e3c4f6e96c37acbacfc447aff92fbfc7bae53b722301b2a8da5cff1c537"} 10:39:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:57 INFO - Copying logs to upload dir... 10:39:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.791292 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-24 10:39:57.266836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:39:57.270688) ========= 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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c91cc397f8360ad2c4abdaf7fe6e0ae7b1ba6e9822c64780e5e97aa37f247f85f4796b670ca3fb9cf31682a66444540f7d6842f6163f339777ff04346195392", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a85922276f753ede3b196f60cea9aff2b1413c4ab2dac2f3eb995b3830bcb0ed524e1e7850b9f735352503e56a25c145928f8c3c19b050e7886fc715c4c9e71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e9fb4a1d8ceaa9fdb2676422fb1e34bfe9758a9e0410f181e8a95ac835d708a9829e3c4f6e96c37acbacfc447aff92fbfc7bae53b722301b2a8da5cff1c537"} build_url:https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/aZ19tl3lRZSR9-RueKpsrQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c91cc397f8360ad2c4abdaf7fe6e0ae7b1ba6e9822c64780e5e97aa37f247f85f4796b670ca3fb9cf31682a66444540f7d6842f6163f339777ff04346195392", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a85922276f753ede3b196f60cea9aff2b1413c4ab2dac2f3eb995b3830bcb0ed524e1e7850b9f735352503e56a25c145928f8c3c19b050e7886fc715c4c9e71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81e9fb4a1d8ceaa9fdb2676422fb1e34bfe9758a9e0410f181e8a95ac835d708a9829e3c4f6e96c37acbacfc447aff92fbfc7bae53b722301b2a8da5cff1c537"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:39:57.307662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:39:57.308213) ========= 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.EvKSeVFvc7/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.g0dvxnxjKs/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:39:57.358370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:39:57.358728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:39:57.359135) ========= ========= Total master_lag: 0.18 =========